You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/03/09 06:41:56 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3350
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3350/display/redirect?page=changes>
Changes:
[neil.conway] Removed misleading comment from protobuf file.
------------------------------------------
[...truncated 11.75 MB...]
I0309 06:41:10.614444 25172 slave.cpp:3386] Got registration for executor 'default' of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 from executor(120)@172.17.0.2:33370
I0309 06:41:10.614631 25168 exec.cpp:237] Executor registered on agent ae02960f-793f-4657-b829-1419ca03dda1-S0
I0309 06:41:10.614681 25168 exec.cpp:249] Executor::registered took 30265ns
I0309 06:41:10.614866 25170 slave.cpp:2337] Sending queued task '1' to executor 'default' of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 at executor(120)@172.17.0.2:33370
I0309 06:41:10.615008 25169 exec.cpp:325] Executor asked to run task '1'
I0309 06:41:10.615057 25169 exec.cpp:334] Executor::launchTask took 31111ns
I0309 06:41:10.615113 25169 exec.cpp:551] Executor sending status update TASK_RUNNING (UUID: 8370544e-649c-4201-b51a-bda3dacb8ce2) for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.615226 25170 slave.cpp:3817] Handling status update TASK_RUNNING (UUID: 8370544e-649c-4201-b51a-bda3dacb8ce2) for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 from executor(120)@172.17.0.2:33370
I0309 06:41:10.615494 25160 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 8370544e-649c-4201-b51a-bda3dacb8ce2) for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.615523 25160 status_update_manager.cpp:500] Creating StatusUpdate stream for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.615720 25160 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 8370544e-649c-4201-b51a-bda3dacb8ce2) for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 to the agent
I0309 06:41:10.615829 25162 slave.cpp:4257] Forwarding the update TASK_RUNNING (UUID: 8370544e-649c-4201-b51a-bda3dacb8ce2) for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 to master@172.17.0.2:33370
I0309 06:41:10.615939 25162 slave.cpp:4151] Status update manager successfully handled status update TASK_RUNNING (UUID: 8370544e-649c-4201-b51a-bda3dacb8ce2) for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.615967 25162 slave.cpp:4167] Sending acknowledgement for status update TASK_RUNNING (UUID: 8370544e-649c-4201-b51a-bda3dacb8ce2) for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 to executor(120)@172.17.0.2:33370
I0309 06:41:10.615990 25159 master.cpp:6259] Status update TASK_RUNNING (UUID: 8370544e-649c-4201-b51a-bda3dacb8ce2) for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 from agent ae02960f-793f-4657-b829-1419ca03dda1-S0 at slave(283)@172.17.0.2:33370 (8ff00b6e581d)
I0309 06:41:10.616032 25159 master.cpp:6327] Forwarding status update TASK_RUNNING (UUID: 8370544e-649c-4201-b51a-bda3dacb8ce2) for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.616056 25158 exec.cpp:374] Executor received status update acknowledgement 8370544e-649c-4201-b51a-bda3dacb8ce2 for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.616122 25159 master.cpp:8361] Updating the state of task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0309 06:41:10.616255 25158 sched.cpp:1041] Scheduler::statusUpdate took 80245ns
I0309 06:41:10.616370 25158 master.cpp:5167] Processing ACKNOWLEDGE call 8370544e-649c-4201-b51a-bda3dacb8ce2 for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 (default) at scheduler-bbc218e2-182d-412d-94ae-edc54e84b976@172.17.0.2:33370 on agent ae02960f-793f-4657-b829-1419ca03dda1-S0
I0309 06:41:10.616704 25158 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 8370544e-649c-4201-b51a-bda3dacb8ce2) for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.616811 25167 exec.cpp:396] Executor received framework message
I0309 06:41:10.616830 25164 slave.cpp:3106] Status update manager successfully handled status update acknowledgement (UUID: 8370544e-649c-4201-b51a-bda3dacb8ce2) for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.616868 25167 exec.cpp:405] Executor::frameworkMessage took 38177ns
I0309 06:41:10.617231 25167 slave.cpp:4325] Sending message for framework ae02960f-793f-4657-b829-1419ca03dda1-0000 to scheduler-bbc218e2-182d-412d-94ae-edc54e84b976@172.17.0.2:33370
I0309 06:41:10.617382 25170 sched.cpp:1177] Scheduler::frameworkMessage took 27241ns
I0309 06:41:10.617606 25157 sched.cpp:2021] Asked to stop the driver
I0309 06:41:10.617656 25164 sched.cpp:1203] Stopping framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.617754 25165 master.cpp:7781] Processing TEARDOWN call for framework ae02960f-793f-4657-b829-1419ca03dda1-0000 (default) at scheduler-bbc218e2-182d-412d-94ae-edc54e84b976@172.17.0.2:33370
I0309 06:41:10.617781 25165 master.cpp:7793] Removing framework ae02960f-793f-4657-b829-1419ca03dda1-0000 (default) at scheduler-bbc218e2-182d-412d-94ae-edc54e84b976@172.17.0.2:33370
I0309 06:41:10.617797 25165 master.cpp:3164] Deactivating framework ae02960f-793f-4657-b829-1419ca03dda1-0000 (default) at scheduler-bbc218e2-182d-412d-94ae-edc54e84b976@172.17.0.2:33370
I0309 06:41:10.617880 25159 hierarchical.cpp:378] Deactivated framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.617920 25165 master.cpp:8361] Updating the state of task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0309 06:41:10.617945 25161 slave.cpp:2664] Asked to shut down framework ae02960f-793f-4657-b829-1419ca03dda1-0000 by master@172.17.0.2:33370
I0309 06:41:10.617969 25161 slave.cpp:2689] Shutting down framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.617986 25161 slave.cpp:5084] Shutting down executor 'default' of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 at executor(120)@172.17.0.2:33370
I0309 06:41:10.618067 25166 exec.cpp:415] Executor asked to shutdown
I0309 06:41:10.618134 25166 exec.cpp:430] Executor::shutdown took 41384ns
I0309 06:41:10.618281 25165 master.cpp:8455] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 on agent ae02960f-793f-4657-b829-1419ca03dda1-S0 at slave(283)@172.17.0.2:33370 (8ff00b6e581d)
I0309 06:41:10.618330 25162 hierarchical.cpp:1110] Recovered cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent ae02960f-793f-4657-b829-1419ca03dda1-S0 from framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.618427 25165 master.cpp:8484] Removing executor 'default' with resources {} of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 on agent ae02960f-793f-4657-b829-1419ca03dda1-S0 at slave(283)@172.17.0.2:33370 (8ff00b6e581d)
I0309 06:41:10.618535 25160 slave.cpp:4389] Got exited event for executor(120)@172.17.0.2:33370
I0309 06:41:10.618594 25160 slave.cpp:4770] Executor 'default' of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 exited with status 0
I0309 06:41:10.618628 25160 slave.cpp:4870] Cleaning up executor 'default' of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 at executor(120)@172.17.0.2:33370
I0309 06:41:10.618727 25159 hierarchical.cpp:325] Removed framework ae02960f-793f-4657-b829-1419ca03dda1-0000
W0309 06:41:10.618746 25165 master.cpp:6383] Ignoring unknown exited executor 'default' of framework ae02960f-793f-4657-b829-1419ca03dda1-0000 on agent ae02960f-793f-4657-b829-1419ca03dda1-S0 at slave(283)@172.17.0.2:33370 (8ff00b6e581d)
I0309 06:41:10.618798 25166 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_BPbMpZ/slaves/ae02960f-793f-4657-b829-1419ca03dda1-S0/frameworks/ae02960f-793f-4657-b829-1419ca03dda1-0000/executors/default/runs/1c0abe87-2829-4ae8-a80a-f8b37c2a3540' for gc 6.99999283869333days in the future
I0309 06:41:10.618858 25160 slave.cpp:4958] Cleaning up framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.618927 25170 status_update_manager.cpp:285] Closing status update streams for framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.618950 25170 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework ae02960f-793f-4657-b829-1419ca03dda1-0000
I0309 06:41:10.618963 25160 slave.cpp:808] Agent terminating
I0309 06:41:10.618964 25167 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_BPbMpZ/slaves/ae02960f-793f-4657-b829-1419ca03dda1-S0/frameworks/ae02960f-793f-4657-b829-1419ca03dda1-0000/executors/default' for gc 6.99999283766222days in the future
I0309 06:41:10.619022 25167 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_BPbMpZ/slaves/ae02960f-793f-4657-b829-1419ca03dda1-S0/frameworks/ae02960f-793f-4657-b829-1419ca03dda1-0000' for gc 6.99999283627259days in the future
I0309 06:41:10.619091 25160 master.cpp:1318] Agent ae02960f-793f-4657-b829-1419ca03dda1-S0 at slave(283)@172.17.0.2:33370 (8ff00b6e581d) disconnected
I0309 06:41:10.619118 25160 master.cpp:3201] Disconnecting agent ae02960f-793f-4657-b829-1419ca03dda1-S0 at slave(283)@172.17.0.2:33370 (8ff00b6e581d)
I0309 06:41:10.619168 25160 master.cpp:3220] Deactivating agent ae02960f-793f-4657-b829-1419ca03dda1-S0 at slave(283)@172.17.0.2:33370 (8ff00b6e581d)
I0309 06:41:10.619240 25161 hierarchical.cpp:657] Agent ae02960f-793f-4657-b829-1419ca03dda1-S0 deactivated
I0309 06:41:10.620586 25157 master.cpp:1157] Master terminating
I0309 06:41:10.620813 25168 hierarchical.cpp:562] Removed agent ae02960f-793f-4657-b829-1419ca03dda1-S0
I0309 06:41:10.638938 25157 cluster.cpp:160] Creating default 'local' authorizer
I0309 06:41:10.639916 25172 master.cpp:437] Master 5e81322b-6951-484d-8247-e42cd52ca7d5 (8ff00b6e581d) started on 172.17.0.2:33370
I0309 06:41:10.639935 25172 master.cpp:439] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/L6GXQ4/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/L6GXQ4/master" --zk_session_timeout="10secs"
I0309 06:41:10.640136 25172 master.cpp:489] Master only allowing authenticated frameworks to register
I0309 06:41:10.640144 25172 master.cpp:503] Master only allowing authenticated agents to register
I0309 06:41:10.640149 25172 master.cpp:516] Master only allowing authenticated HTTP frameworks to register
I0309 06:41:10.640158 25172 credentials.hpp:37] Loading credentials for authentication from '/tmp/L6GXQ4/credentials'
I0309 06:41:10.640282 25172 master.cpp:561] Using default 'crammd5' authenticator
I0309 06:41:10.640346 25172 http.cpp:964] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0309 06:41:10.640424 25172 http.cpp:964] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0309 06:41:10.640480 25172 http.cpp:964] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0309 06:41:10.640545 25172 master.cpp:641] Authorization enabled
I0309 06:41:10.640621 25158 hierarchical.cpp:161] Initialized hierarchical allocator process
I0309 06:41:10.640621 25163 whitelist_watcher.cpp:77] No whitelist given
I0309 06:41:10.641443 25169 master.cpp:2181] Elected as the leading master!
I0309 06:41:10.641458 25169 master.cpp:1705] Recovering from registrar
I0309 06:41:10.641646 25169 registrar.cpp:331] Recovering registrar
I0309 06:41:10.641886 25162 registrar.cpp:364] Successfully fetched the registry (0B) in 208128ns
I0309 06:41:10.641952 25162 registrar.cpp:463] Applied 1 operations in 6751ns; attempting to update the registry
I0309 06:41:10.642340 25162 registrar.cpp:508] Successfully updated the registry in 355072ns
I0309 06:41:10.642400 25162 registrar.cpp:394] Successfully recovered registrar
I0309 06:41:10.642549 25162 master.cpp:1819] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0309 06:41:10.642633 25162 hierarchical.cpp:188] Skipping recovery of hierarchical allocator: nothing to recover
I0309 06:41:10.645279 25157 cluster.cpp:446] Creating default 'local' authorizer
I0309 06:41:10.645844 25158 slave.cpp:215] Mesos agent started on (284)@172.17.0.2:33370
I0309 06:41:10.645862 25158 slave.cpp:216] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/MasterTest_MultipleExecutors_tmDnKC/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterTest_MultipleExecutors_tmDnKC/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/MasterTest_MultipleExecutors_tmDnKC/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/MasterTest_MultipleExecutors_tmDnKC" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/MasterTest_MultipleExecutors_ktOENQ"
I0309 06:41:10.646258 25158 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_tmDnKC/credential'
I0309 06:41:10.646373 25158 slave.cpp:358] Agent using credential for: test-principal
I0309 06:41:10.646392 25158 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_tmDnKC/http_credentials'
I0309 06:41:10.646517 25158 http.cpp:964] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0309 06:41:10.646554 25157 sched.cpp:232] Version: 1.3.0
I0309 06:41:10.646561 25158 http.cpp:964] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0309 06:41:10.646802 25161 sched.cpp:336] New master detected at master@172.17.0.2:33370
I0309 06:41:10.646838 25161 sched.cpp:407] Authenticating with master master@172.17.0.2:33370
I0309 06:41:10.646849 25161 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0309 06:41:10.647032 25170 authenticatee.cpp:121] Creating new client SASL connection
I0309 06:41:10.647107 25158 slave.cpp:545] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0309 06:41:10.647159 25158 slave.cpp:553] Agent attributes: [ ]
I0309 06:41:10.647171 25158 slave.cpp:558] Agent hostname: 8ff00b6e581d
I0309 06:41:10.647260 25164 status_update_manager.cpp:177] Pausing sending status updates
I0309 06:41:10.647311 25170 master.cpp:7268] Authenticating scheduler-623ecfe7-2a21-45ef-a7cf-29ae4ef8771e@172.17.0.2:33370
I0309 06:41:10.647393 25168 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(628)@172.17.0.2:33370
I0309 06:41:10.647503 25168 authenticator.cpp:98] Creating new server SASL connection
I0309 06:41:10.647627 25158 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_ktOENQ/meta'
I0309 06:41:10.647677 25171 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0309 06:41:10.647696 25171 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0309 06:41:10.647891 25158 status_update_manager.cpp:203] Recovering status update manager
I0309 06:41:10.647908 25171 authenticator.cpp:204] Received SASL authentication start
I0309 06:41:10.647967 25171 authenticator.cpp:326] Authentication requires more steps
I0309 06:41:10.647974 25158 slave.cpp:5572] Finished recovery
I0309 06:41:10.648011 25171 authenticatee.cpp:259] Received SASL authentication step
I0309 06:41:10.648061 25171 authenticator.cpp:232] Received SASL authentication step
I0309 06:41:10.648083 25171 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '8ff00b6e581d' server FQDN: '8ff00b6e581d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0309 06:41:10.648098 25171 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0309 06:41:10.648116 25171 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0309 06:41:10.648134 25171 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '8ff00b6e581d' server FQDN: '8ff00b6e581d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0309 06:41:10.648149 25171 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0309 06:41:10.648159 25171 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0309 06:41:10.648176 25171 authenticator.cpp:318] Authentication success
I0309 06:41:10.648221 25171 authenticatee.cpp:299] Authentication success
I0309 06:41:10.648257 25171 master.cpp:7298] Successfully authenticated principal 'test-principal' at scheduler-623ecfe7-2a21-45ef-a7cf-29ae4ef8771e@172.17.0.2:33370
I0309 06:41:10.648284 25158 slave.cpp:5754] Querying resource estimator for oversubscribable resources
I0309 06:41:10.648291 25171 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(628)@172.17.0.2:33370
I0309 06:41:10.648373 25158 sched.cpp:513] Successfully authenticated with master master@172.17.0.2:33370
I0309 06:41:10.648386 25158 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.2:33370
I0309 06:41:10.648419 25158 sched.cpp:869] Will retry registration in 1.461886191secs if necessary
I0309 06:41:10.648438 25171 slave.cpp:936] New master detected at master@172.17.0.2:33370
I0309 06:41:10.648474 25158 master.cpp:2833] Received SUBSCRIBE call for framework 'default' at scheduler-623ecfe7-2a21-45ef-a7cf-29ae4ef8771e@172.17.0.2:33370
I0309 06:41:10.648543 25158 master.cpp:2217] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0309 06:41:10.648573 25173 status_update_manager.cpp:177] Pausing sending status updates
I0309 06:41:10.648478 25171 slave.cpp:971] Detecting new master
I0309 06:41:10.648653 25171 slave.cpp:5768] Received oversubscribable resources {} from the resource estimator
I0309 06:41:10.648741 25162 master.cpp:2910] Subscribing framework default with checkpointing disabled and capabilities [ ]
I0309 06:41:10.648962 25171 hierarchical.cpp:273] Added framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000
I0309 06:41:10.649036 25171 hierarchical.cpp:1856] No allocations performed
I0309 06:41:10.649051 25171 hierarchical.cpp:1946] No inverse offers to send out!
I0309 06:41:10.649065 25171 hierarchical.cpp:1440] Performed allocation for 0 agents in 38863ns
I0309 06:41:10.649077 25165 sched.cpp:759] Framework registered with 5e81322b-6951-484d-8247-e42cd52ca7d5-0000
I0309 06:41:10.649106 25165 sched.cpp:773] Scheduler::registered took 12838ns
I0309 06:41:10.652711 25158 slave.cpp:998] Authenticating with master master@172.17.0.2:33370
I0309 06:41:10.652737 25158 slave.cpp:1009] Using default CRAM-MD5 authenticatee
I0309 06:41:10.652801 25164 authenticatee.cpp:121] Creating new client SASL connection
I0309 06:41:10.652976 25165 master.cpp:7268] Authenticating slave(284)@172.17.0.2:33370
I0309 06:41:10.653049 25161 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(629)@172.17.0.2:33370
I0309 06:41:10.653141 25158 authenticator.cpp:98] Creating new server SASL connection
I0309 06:41:10.653300 25163 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0309 06:41:10.653326 25163 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0309 06:41:10.653364 25163 authenticator.cpp:204] Received SASL authentication start
I0309 06:41:10.653403 25163 authenticator.cpp:326] Authentication requires more steps
I0309 06:41:10.653481 25171 authenticatee.cpp:259] Received SASL authentication step
I0309 06:41:10.653565 25171 authenticator.cpp:232] Received SASL authentication step
I0309 06:41:10.653587 25171 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '8ff00b6e581d' server FQDN: '8ff00b6e581d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0309 06:41:10.653601 25171 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0309 06:41:10.653614 25171 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0309 06:41:10.653626 25171 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '8ff00b6e581d' server FQDN: '8ff00b6e581d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0309 06:41:10.653631 25171 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0309 06:41:10.653640 25171 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0309 06:41:10.653650 25171 authenticator.cpp:318] Authentication success
I0309 06:41:10.653704 25158 authenticatee.cpp:299] Authentication success
I0309 06:41:10.653729 25171 master.cpp:7298] Successfully authenticated principal 'test-principal' at slave(284)@172.17.0.2:33370
I0309 06:41:10.653761 25168 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(629)@172.17.0.2:33370
I0309 06:41:10.653903 25158 slave.cpp:1093] Successfully authenticated with master master@172.17.0.2:33370
I0309 06:41:10.653991 25158 slave.cpp:1521] Will retry registration in 7.576827ms if necessary
I0309 06:41:10.654060 25161 master.cpp:5453] Registering agent at slave(284)@172.17.0.2:33370 (8ff00b6e581d) with id 5e81322b-6951-484d-8247-e42cd52ca7d5-S0
I0309 06:41:10.654202 25169 registrar.cpp:463] Applied 1 operations in 16447ns; attempting to update the registry
I0309 06:41:10.654580 25164 registrar.cpp:508] Successfully updated the registry in 354048ns
I0309 06:41:10.654870 25167 slave.cpp:4347] Received ping from slave-observer(277)@172.17.0.2:33370
I0309 06:41:10.654894 25172 master.cpp:5527] Registered agent 5e81322b-6951-484d-8247-e42cd52ca7d5-S0 at slave(284)@172.17.0.2:33370 (8ff00b6e581d) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0309 06:41:10.654939 25167 slave.cpp:1139] Registered with master master@172.17.0.2:33370; given agent ID 5e81322b-6951-484d-8247-e42cd52ca7d5-S0
I0309 06:41:10.654958 25167 fetcher.cpp:94] Clearing fetcher cache
I0309 06:41:10.654978 25170 hierarchical.cpp:529] Added agent 5e81322b-6951-484d-8247-e42cd52ca7d5-S0 (8ff00b6e581d) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0309 06:41:10.655069 25161 status_update_manager.cpp:184] Resuming sending status updates
I0309 06:41:10.655241 25167 slave.cpp:1167] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_ktOENQ/meta/slaves/5e81322b-6951-484d-8247-e42cd52ca7d5-S0/slave.info'
I0309 06:41:10.655261 25170 hierarchical.cpp:1946] No inverse offers to send out!
I0309 06:41:10.655283 25170 hierarchical.cpp:1440] Performed allocation for 1 agents in 247608ns
I0309 06:41:10.655410 25159 master.cpp:7097] Sending 1 offers to framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000 (default) at scheduler-623ecfe7-2a21-45ef-a7cf-29ae4ef8771e@172.17.0.2:33370
I0309 06:41:10.655536 25167 slave.cpp:1205] Forwarding total oversubscribed resources {}
I0309 06:41:10.655594 25165 sched.cpp:933] Scheduler::resourceOffers took 43946ns
I0309 06:41:10.655621 25173 master.cpp:6114] Received update of agent 5e81322b-6951-484d-8247-e42cd52ca7d5-S0 at slave(284)@172.17.0.2:33370 (8ff00b6e581d) with total oversubscribed resources {}
I0309 06:41:10.656440 25167 master.cpp:3855] Processing ACCEPT call for offers: [ 5e81322b-6951-484d-8247-e42cd52ca7d5-O0 ] on agent 5e81322b-6951-484d-8247-e42cd52ca7d5-S0 at slave(284)@172.17.0.2:33370 (8ff00b6e581d) for framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000 (default) at scheduler-623ecfe7-2a21-45ef-a7cf-29ae4ef8771e@172.17.0.2:33370
I0309 06:41:10.656496 25167 master.cpp:3431] Authorizing framework principal 'test-principal' to launch task 1
I0309 06:41:10.656599 25167 master.cpp:3431] Authorizing framework principal 'test-principal' to launch task 2
W0309 06:41:10.657249 25164 validation.cpp:1113] Executor 'executor-1' for task '1' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0309 06:41:10.657279 25164 validation.cpp:1125] Executor 'executor-1' for task '1' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0309 06:41:10.657402 25164 master.cpp:9113] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 5e81322b-6951-484d-8247-e42cd52ca7d5-S0 at slave(284)@172.17.0.2:33370 (8ff00b6e581d)
I0309 06:41:10.657503 25164 master.cpp:4505] Launching task 1 of framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000 (default) at scheduler-623ecfe7-2a21-45ef-a7cf-29ae4ef8771e@172.17.0.2:33370 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 5e81322b-6951-484d-8247-e42cd52ca7d5-S0 at slave(284)@172.17.0.2:33370 (8ff00b6e581d)
I0309 06:41:10.657692 25162 slave.cpp:1631] Got assigned task '1' for framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000
W0309 06:41:10.657897 25164 validation.cpp:1113] Executor 'executor-2' for task '2' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0309 06:41:10.657924 25164 validation.cpp:1125] Executor 'executor-2' for task '2' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0309 06:41:10.658015 25162 slave.cpp:1791] Launching task '1' for framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000
I0309 06:41:10.658040 25164 master.cpp:9113] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 5e81322b-6951-484d-8247-e42cd52ca7d5-S0 at slave(284)@172.17.0.2:33370 (8ff00b6e581d)
I0309 06:41:10.658131 25164 master.cpp:4505] Launching task 2 of framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000 (default) at scheduler-623ecfe7-2a21-45ef-a7cf-29ae4ef8771e@172.17.0.2:33370 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 5e81322b-6951-484d-8247-e42cd52ca7d5-S0 at slave(284)@172.17.0.2:33370 (8ff00b6e581d)
I0309 06:41:10.658658 25162 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_ktOENQ/slaves/5e81322b-6951-484d-8247-e42cd52ca7d5-S0/frameworks/5e81322b-6951-484d-8247-e42cd52ca7d5-0000/executors/executor-1/runs/07b83167-8375-4627-b478-6ada7f6cf812' to user 'mesos'
I0309 06:41:10.658862 25162 slave.cpp:6499] Launching executor 'executor-1' of framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_ktOENQ/slaves/5e81322b-6951-484d-8247-e42cd52ca7d5-S0/frameworks/5e81322b-6951-484d-8247-e42cd52ca7d5-0000/executors/executor-1/runs/07b83167-8375-4627-b478-6ada7f6cf812'
I0309 06:41:10.659099 25162 slave.cpp:2124] Queued task '1' for executor 'executor-1' of framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000
I0309 06:41:10.659101 25172 hierarchical.cpp:846] Updated allocation of framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000 on agent 5e81322b-6951-484d-8247-e42cd52ca7d5-S0 from cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] to cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000]
I0309 06:41:10.659204 25162 slave.cpp:1631] Got assigned task '2' for framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000
I0309 06:41:10.659368 25172 hierarchical.cpp:1110] Recovered ports(*)(allocated: *):[31000-32000]; disk(*)(allocated: *):1024 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):2; mem(*)(allocated: *):1024) on agent 5e81322b-6951-484d-8247-e42cd52ca7d5-S0 from framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000
I0309 06:41:10.659410 25162 slave.cpp:889] Successfully attached file '/tmp/MasterTest_MultipleExecutors_ktOENQ/slaves/5e81322b-6951-484d-8247-e42cd52ca7d5-S0/frameworks/5e81322b-6951-484d-8247-e42cd52ca7d5-0000/executors/executor-1/runs/07b83167-8375-4627-b478-6ada7f6cf812'
I0309 06:41:10.659415 25172 hierarchical.cpp:1147] Framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000 filtered agent 5e81322b-6951-484d-8247-e42cd52ca7d5-S0 for 5secs
I0309 06:41:10.659453 25162 slave.cpp:1791] Launching task '2' for framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000
I0309 06:41:10.659852 25162 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_ktOENQ/slaves/5e81322b-6951-484d-8247-e42cd52ca7d5-S0/frameworks/5e81322b-6951-484d-8247-e42cd52ca7d5-0000/executors/executor-2/runs/b34d6822-9546-4664-a45e-68f6ff49c3dd' to user 'mesos'
I0309 06:41:10.660037 25162 slave.cpp:6499] Launching executor 'executor-2' of framework 5e81322b-6951-484d-8247-e42cd52ca7d5-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_ktOENQ/slaves/5e81322b-6951-484d-8247-e42cd52ca7d5-S0/frameworks/5e81322b-6951-484d-8247-e42cd52ca7d5-0000/executors/executor-2/runs/b34d6822-9546-4664-a45e-68f6ff49c3dd'
*** Aborted at 1489041670 (unix time) try "date -d @1489041670" if you are using GNU date ***
I0309 06:41:10.660370 25167 exec.cpp:162] Version: 1.3.0
I0309 06:41:10.660454 25159 exec.cpp:212] Executor started at: executor(121)@172.17.0.2:33370 with pid 25157
PC: @ 0x7fb27c6d90cd __GI_getenv
*** SIGSEGV (@0x0) received by PID 25157 (TID 0x7fb274975700) from PID 0; stack trace: ***
@ 0x7fb27d292370 (unknown)
@ 0x7fb27c6d90cd __GI_getenv
@ 0x7fb280c39a84 mesos::internal::slave::executorEnvironment()
@ 0x7fb280c64d6e mesos::internal::slave::Framework::launchExecutor()
@ 0x7fb280c67c03 mesos::internal::slave::Slave::_run()
@ 0x7fb27ff02941 process::ProcessManager::resume()
@ 0x7fb27ff0b9d7 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
@ 0x7fb27d02f230 (unknown)
@ 0x7fb27d28adc5 start_thread
@ 0x7fb27c79873d __clone
make[3]: *** [CMakeFiles/check] Segmentation fault
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make: *** [check] Error 2
+ docker rmi mesos-1489038616-16854
Untagged: mesos-1489038616-16854:latest
Deleted: sha256:04798b0bcb9ed02a922659b05dd59c2e4f5e638218058d78d62705f6577aa10f
Deleted: sha256:3009f704b22135a2627d020b8f2c743f750713500612e89ad5411e633349426b
Deleted: sha256:339d8a41163319900e4acde114ffed30029bab73dcf4c6098c2958f50b6fad0f
Deleted: sha256:30c4d9e54182545ccea87d487c45281ee975d3143b881607023480d4f37df4b3
Deleted: sha256:e0ed2021d8c828512fd4441ea6449c0fb4eb8770d1d5cccaebd3156bef27a5c3
Deleted: sha256:a952bfef9184ae493581d14bf2ee541cb1587cd7efb53df5c7864ae05f7c6efc
Deleted: sha256:97db531c42d3fa31eec48f463769d41a930a4bc4f954df438e938063480d7eb3
Deleted: sha256:d0cf3b49f9c6c19f6401147e3bd0c24bdba62b6e03735ae0578a15009fb77fa8
Deleted: sha256:b6976565626a5373959c52dece0766a3194b1f2569f3eef97b933593d3fd8f54
Deleted: sha256:9ab2f134fd783f7cad55fec1bfeccd550b34a100d1c0b16b0c59141ab7477ee9
Deleted: sha256:17e72a2177fad63e518793a4015753d0c1567b9485d1adfaf4ee0d29be135475
Deleted: sha256:5824b8432162470ce53ad18950800aba8ea25e28e2336a934d5653ca490f5000
Deleted: sha256:318db7d3cf756a4dad738b40b67719b7e80022d7a74cfcaedad45f013c59e9c4
Deleted: sha256:081808dc1b9df8124acce16c0df0afd77f0cb8b751bf36248dd40c111be420ff
Deleted: sha256:f1fba3756b54005491ca89f0934bd03411388122a3f0e05ee68e5db19602084d
Deleted: sha256:e10d7827ef301a38d5c47c8a5fa547e83d670d0b2af5410de21f2334029ee83c
Deleted: sha256:c503d6af647dc4d7f8edaf5b03c92024384dc529d6d59b73220fb08e0f4c5767
Deleted: sha256:920869e2bf40c9ba5435f09636d054070163021c0917145d16f9a6a33a396fab
Deleted: sha256:7d8e2c59ef51f0929d625c8f1fdf25e5a0acb42e1241b3abcb6235bb51786b7f
Deleted: sha256:6356f6d3e87b21fe8b471dd3272b7be1e24a69da0009c743fd904ec2b5bfa569
Deleted: sha256:fe8afa0bb72fce94cbe3d8d39408ed143521ebbe6f55448bcc7287902e52fd87
Deleted: sha256:75d55afc51821bc15404220d91a3021f427fa6859ce262d1a575e7f65891665d
Deleted: sha256:747d612cb6e19fc4faa240218af8a6f57876891662ce8a9e922b52ca708debf2
Deleted: sha256:73996f994a3047927616f50c00d3675155f9f6b7d9461977110646b11dc7cadc
Deleted: sha256:9d61d25abdfeda8efe808c2983243545925c0f3d96ae57e3b86c8bd009c34c17
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3351
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3351/display/redirect?page=changes>