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/05/10 08:31:53 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3647
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3647/display/redirect?page=changes>
Changes:
[neil.conway] Enhanced stout's Version to support prerelease and build labels.
[neil.conway] Switched to using unsigned types to represent versions in stout.
[neil.conway] Checked validity of master and agent version numbers on startup.
[neil.conway] Prevent old Mesos agents from registering or re-registering.
[neil.conway] Fixed `Version::validateIdentifier()` for Unicode edge case.
[neil.conway] Allowed leading zeros in input to stout's Version parser.
[neil.conway] Cleaned up comments in stout's Version.
[neil.conway] Added MESOS-{1987,6976,7389,7464,7484} to 1.3.0 CHANGELOG.
------------------------------------------
[...truncated 13.25 MB...]
I0510 08:31:27.665279 26009 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: b27a7039-28f9-490f-b418-4fb6ff0ddfe4) for task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 to the agent
I0510 08:31:27.665405 26011 slave.cpp:4655] Forwarding the update TASK_RUNNING (UUID: b27a7039-28f9-490f-b418-4fb6ff0ddfe4) for task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 to master@172.17.0.3:55624
I0510 08:31:27.665524 26011 slave.cpp:4549] Status update manager successfully handled status update TASK_RUNNING (UUID: b27a7039-28f9-490f-b418-4fb6ff0ddfe4) for task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.665557 26011 slave.cpp:4565] Sending acknowledgement for status update TASK_RUNNING (UUID: b27a7039-28f9-490f-b418-4fb6ff0ddfe4) for task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 to executor(125)@172.17.0.3:55624
I0510 08:31:27.665554 26001 master.cpp:6469] Status update TASK_RUNNING (UUID: b27a7039-28f9-490f-b418-4fb6ff0ddfe4) for task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 from agent 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0 at slave(314)@172.17.0.3:55624 (f4b88a125653)
I0510 08:31:27.665594 26001 master.cpp:6537] Forwarding status update TASK_RUNNING (UUID: b27a7039-28f9-490f-b418-4fb6ff0ddfe4) for task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.665657 26004 exec.cpp:374] Executor received status update acknowledgement b27a7039-28f9-490f-b418-4fb6ff0ddfe4 for task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.665683 26001 master.cpp:8568] Updating the state of task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0510 08:31:27.665783 26011 sched.cpp:1041] Scheduler::statusUpdate took 59569ns
I0510 08:31:27.665925 26003 master.cpp:5194] Processing ACKNOWLEDGE call b27a7039-28f9-490f-b418-4fb6ff0ddfe4 for task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 (default) at scheduler-439f2c30-ff41-4520-9815-4deb3e882bd3@172.17.0.3:55624 on agent 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0
I0510 08:31:27.666064 26008 status_update_manager.cpp:395] Received status update acknowledgement (UUID: b27a7039-28f9-490f-b418-4fb6ff0ddfe4) for task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.666147 26001 exec.cpp:396] Executor received framework message
I0510 08:31:27.666216 26001 exec.cpp:405] Executor::frameworkMessage took 57724ns
I0510 08:31:27.666221 26005 slave.cpp:3504] Status update manager successfully handled status update acknowledgement (UUID: b27a7039-28f9-490f-b418-4fb6ff0ddfe4) for task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.666641 26008 slave.cpp:4723] Sending message for framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 to scheduler-439f2c30-ff41-4520-9815-4deb3e882bd3@172.17.0.3:55624
I0510 08:31:27.666748 26001 sched.cpp:1177] Scheduler::frameworkMessage took 42624ns
I0510 08:31:27.666906 25995 sched.cpp:2021] Asked to stop the driver
I0510 08:31:27.666960 25999 sched.cpp:1203] Stopping framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.667070 25996 master.cpp:7988] Processing TEARDOWN call for framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 (default) at scheduler-439f2c30-ff41-4520-9815-4deb3e882bd3@172.17.0.3:55624
I0510 08:31:27.667098 25996 master.cpp:8000] Removing framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 (default) at scheduler-439f2c30-ff41-4520-9815-4deb3e882bd3@172.17.0.3:55624
I0510 08:31:27.667119 25996 master.cpp:3160] Deactivating framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 (default) at scheduler-439f2c30-ff41-4520-9815-4deb3e882bd3@172.17.0.3:55624
I0510 08:31:27.667187 25996 master.cpp:8568] Updating the state of task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0510 08:31:27.667245 26004 slave.cpp:3057] Asked to shut down framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 by master@172.17.0.3:55624
I0510 08:31:27.667268 26004 slave.cpp:3082] Shutting down framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.667280 26004 slave.cpp:5482] Shutting down executor 'default' of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 at executor(125)@172.17.0.3:55624
I0510 08:31:27.667197 26007 hierarchical.cpp:374] Deactivated framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.667387 26001 exec.cpp:415] Executor asked to shutdown
I0510 08:31:27.667426 26001 exec.cpp:430] Executor::shutdown took 18065ns
I0510 08:31:27.667387 25996 master.cpp:8662] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 on agent 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0 at slave(314)@172.17.0.3:55624 (f4b88a125653)
I0510 08:31:27.667486 26001 slave.cpp:4787] Got exited event for executor(125)@172.17.0.3:55624
I0510 08:31:27.667547 25996 master.cpp:8691] Removing executor 'default' with resources {} of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 on agent 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0 at slave(314)@172.17.0.3:55624 (f4b88a125653)
I0510 08:31:27.667590 26007 hierarchical.cpp:1114] 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 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0 from framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.667716 26007 hierarchical.cpp:325] Removed framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.668530 26003 slave.cpp:5168] Executor 'default' of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 exited with status 0
I0510 08:31:27.668593 26003 slave.cpp:5268] Cleaning up executor 'default' of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 at executor(125)@172.17.0.3:55624
W0510 08:31:27.668660 26000 master.cpp:6592] Ignoring unknown exited executor 'default' of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000 on agent 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0 at slave(314)@172.17.0.3:55624 (f4b88a125653)
I0510 08:31:27.668800 26000 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_EOhT5b/slaves/674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0/frameworks/674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000/executors/default/runs/565edf48-b9a9-400d-8fb4-81728f8e62f2' for gc 6.99999226016296days in the future
I0510 08:31:27.668891 26003 slave.cpp:5356] Cleaning up framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.668962 25997 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_EOhT5b/slaves/674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0/frameworks/674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000/executors/default' for gc 6.99999225855407days in the future
I0510 08:31:27.668980 25996 status_update_manager.cpp:285] Closing status update streams for framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.669030 25996 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000
I0510 08:31:27.669121 25998 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_EOhT5b/slaves/674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0/frameworks/674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-0000' for gc 6.99999225670222days in the future
I0510 08:31:27.669158 26006 slave.cpp:790] Agent terminating
I0510 08:31:27.669256 26006 master.cpp:1313] Agent 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0 at slave(314)@172.17.0.3:55624 (f4b88a125653) disconnected
I0510 08:31:27.669284 26006 master.cpp:3197] Disconnecting agent 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0 at slave(314)@172.17.0.3:55624 (f4b88a125653)
I0510 08:31:27.669312 26006 master.cpp:3216] Deactivating agent 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0 at slave(314)@172.17.0.3:55624 (f4b88a125653)
I0510 08:31:27.669474 25999 hierarchical.cpp:653] Agent 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0 deactivated
I0510 08:31:27.670733 25995 master.cpp:1155] Master terminating
I0510 08:31:27.670917 25998 hierarchical.cpp:558] Removed agent 674b00d8-d5bc-4368-bbfc-4c8aa240a3e7-S0
I0510 08:31:27.674631 25995 cluster.cpp:162] Creating default 'local' authorizer
I0510 08:31:27.675726 26006 master.cpp:436] Master dd3fbaa9-2664-403c-8fb5-278f657e046d (f4b88a125653) started on 172.17.0.3:55624
I0510 08:31:27.675756 26006 master.cpp:438] 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/VaW4eW/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" --port="5050" --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/VaW4eW/master" --zk_session_timeout="10secs"
I0510 08:31:27.675905 26006 master.cpp:488] Master only allowing authenticated frameworks to register
I0510 08:31:27.675915 26006 master.cpp:502] Master only allowing authenticated agents to register
I0510 08:31:27.675920 26006 master.cpp:515] Master only allowing authenticated HTTP frameworks to register
I0510 08:31:27.675928 26006 credentials.hpp:37] Loading credentials for authentication from '/tmp/VaW4eW/credentials'
I0510 08:31:27.676054 26006 master.cpp:560] Using default 'crammd5' authenticator
I0510 08:31:27.676103 26006 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0510 08:31:27.676174 26006 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0510 08:31:27.676240 26006 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0510 08:31:27.676311 26006 master.cpp:640] Authorization enabled
I0510 08:31:27.676389 26000 whitelist_watcher.cpp:77] No whitelist given
I0510 08:31:27.676411 26008 hierarchical.cpp:158] Initialized hierarchical allocator process
I0510 08:31:27.677238 26000 master.cpp:2161] Elected as the leading master!
I0510 08:31:27.677258 26000 master.cpp:1700] Recovering from registrar
I0510 08:31:27.677366 25996 registrar.cpp:345] Recovering registrar
I0510 08:31:27.677664 25996 registrar.cpp:389] Successfully fetched the registry (0B) in 272128ns
I0510 08:31:27.677705 25996 registrar.cpp:493] Applied 1 operations in 11460ns; attempting to update the registry
I0510 08:31:27.677897 26005 registrar.cpp:550] Successfully updated the registry in 148992ns
I0510 08:31:27.677949 26005 registrar.cpp:422] Successfully recovered registrar
I0510 08:31:27.678194 26008 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0510 08:31:27.678292 26009 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover
I0510 08:31:27.680636 25995 cluster.cpp:448] Creating default 'local' authorizer
I0510 08:31:27.681202 25997 slave.cpp:225] Mesos agent started on (315)@172.17.0.3:55624
I0510 08:31:27.681231 25997 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --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_HpP5rO/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_secret_key="/tmp/MasterTest_MultipleExecutors_HpP5rO/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterTest_MultipleExecutors_HpP5rO/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/MasterTest_MultipleExecutors_HpP5rO/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" --port="5051" --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_HpP5rO" --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_6AUzln"
I0510 08:31:27.681440 25997 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_HpP5rO/credential'
I0510 08:31:27.681532 25997 slave.cpp:258] Agent using credential for: test-principal
I0510 08:31:27.681558 25997 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_HpP5rO/http_credentials'
I0510 08:31:27.681741 25997 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0510 08:31:27.681794 25997 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0510 08:31:27.681902 25997 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0510 08:31:27.681946 25995 sched.cpp:232] Version: 1.3.0
I0510 08:31:27.682016 25997 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0510 08:31:27.682155 25997 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0510 08:31:27.682170 26009 sched.cpp:336] New master detected at master@172.17.0.3:55624
I0510 08:31:27.682209 25997 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0510 08:31:27.682214 26009 sched.cpp:407] Authenticating with master master@172.17.0.3:55624
I0510 08:31:27.682261 26009 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0510 08:31:27.682363 26001 authenticatee.cpp:121] Creating new client SASL connection
I0510 08:31:27.682567 26004 master.cpp:7475] Authenticating scheduler-1e0e3eac-6fcf-4ab0-ad3c-cf00ca6cde10@172.17.0.3:55624
I0510 08:31:27.682647 26002 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(675)@172.17.0.3:55624
I0510 08:31:27.682780 26003 authenticator.cpp:98] Creating new server SASL connection
I0510 08:31:27.682858 25997 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0510 08:31:27.682903 25997 slave.cpp:533] Agent attributes: [ ]
I0510 08:31:27.682909 25997 slave.cpp:538] Agent hostname: f4b88a125653
I0510 08:31:27.682948 26011 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0510 08:31:27.682978 26011 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0510 08:31:27.683049 26009 status_update_manager.cpp:177] Pausing sending status updates
I0510 08:31:27.683115 25999 authenticator.cpp:204] Received SASL authentication start
I0510 08:31:27.683167 25999 authenticator.cpp:326] Authentication requires more steps
I0510 08:31:27.683238 25999 authenticatee.cpp:259] Received SASL authentication step
I0510 08:31:27.683331 26007 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_6AUzln/meta'
I0510 08:31:27.683517 26010 status_update_manager.cpp:203] Recovering status update manager
I0510 08:31:27.683533 26003 authenticator.cpp:232] Received SASL authentication step
I0510 08:31:27.683562 26003 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f4b88a125653' server FQDN: 'f4b88a125653' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0510 08:31:27.683578 26003 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0510 08:31:27.683590 26003 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0510 08:31:27.683604 26003 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f4b88a125653' server FQDN: 'f4b88a125653' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0510 08:31:27.683622 26003 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0510 08:31:27.683636 26003 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0510 08:31:27.683657 26003 authenticator.cpp:318] Authentication success
I0510 08:31:27.683748 26010 authenticatee.cpp:299] Authentication success
I0510 08:31:27.683768 25997 master.cpp:7505] Successfully authenticated principal 'test-principal' at scheduler-1e0e3eac-6fcf-4ab0-ad3c-cf00ca6cde10@172.17.0.3:55624
I0510 08:31:27.683800 26000 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(675)@172.17.0.3:55624
I0510 08:31:27.683914 26011 sched.cpp:513] Successfully authenticated with master master@172.17.0.3:55624
I0510 08:31:27.683914 26001 slave.cpp:5970] Finished recovery
I0510 08:31:27.683938 26011 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.3:55624
I0510 08:31:27.683976 26011 sched.cpp:869] Will retry registration in 1.752149678secs if necessary
I0510 08:31:27.684056 25999 master.cpp:2813] Received SUBSCRIBE call for framework 'default' at scheduler-1e0e3eac-6fcf-4ab0-ad3c-cf00ca6cde10@172.17.0.3:55624
I0510 08:31:27.684082 25999 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0510 08:31:27.684274 25999 master.cpp:2890] Subscribing framework default with checkpointing disabled and capabilities [ ]
I0510 08:31:27.684337 26001 slave.cpp:6152] Querying resource estimator for oversubscribable resources
I0510 08:31:27.684458 25997 slave.cpp:6166] Received oversubscribable resources {} from the resource estimator
I0510 08:31:27.684530 26000 sched.cpp:759] Framework registered with dd3fbaa9-2664-403c-8fb5-278f657e046d-0000
I0510 08:31:27.684546 25998 hierarchical.cpp:273] Added framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000
I0510 08:31:27.684571 26000 sched.cpp:773] Scheduler::registered took 29357ns
I0510 08:31:27.684589 25997 slave.cpp:918] New master detected at master@172.17.0.3:55624
I0510 08:31:27.684623 26004 status_update_manager.cpp:177] Pausing sending status updates
I0510 08:31:27.684638 25997 slave.cpp:953] Detecting new master
I0510 08:31:27.684661 25998 hierarchical.cpp:1850] No allocations performed
I0510 08:31:27.684697 25998 hierarchical.cpp:1940] No inverse offers to send out!
I0510 08:31:27.684718 25998 hierarchical.cpp:1434] Performed allocation for 0 agents in 75126ns
I0510 08:31:27.690834 26009 slave.cpp:980] Authenticating with master master@172.17.0.3:55624
I0510 08:31:27.690871 26009 slave.cpp:991] Using default CRAM-MD5 authenticatee
I0510 08:31:27.690965 26002 authenticatee.cpp:121] Creating new client SASL connection
I0510 08:31:27.691136 25996 master.cpp:7475] Authenticating slave(315)@172.17.0.3:55624
I0510 08:31:27.691206 26005 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(676)@172.17.0.3:55624
I0510 08:31:27.691303 26008 authenticator.cpp:98] Creating new server SASL connection
I0510 08:31:27.691452 26007 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0510 08:31:27.691479 26007 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0510 08:31:27.691542 26006 authenticator.cpp:204] Received SASL authentication start
I0510 08:31:27.691591 26006 authenticator.cpp:326] Authentication requires more steps
I0510 08:31:27.691637 26006 authenticatee.cpp:259] Received SASL authentication step
I0510 08:31:27.691717 26001 authenticator.cpp:232] Received SASL authentication step
I0510 08:31:27.691750 26001 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f4b88a125653' server FQDN: 'f4b88a125653' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0510 08:31:27.691768 26001 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0510 08:31:27.691790 26001 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0510 08:31:27.691810 26001 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f4b88a125653' server FQDN: 'f4b88a125653' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0510 08:31:27.691820 26001 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0510 08:31:27.691826 26001 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0510 08:31:27.691841 26001 authenticator.cpp:318] Authentication success
I0510 08:31:27.691901 26007 authenticatee.cpp:299] Authentication success
I0510 08:31:27.691928 25996 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(676)@172.17.0.3:55624
I0510 08:31:27.691962 26006 master.cpp:7505] Successfully authenticated principal 'test-principal' at slave(315)@172.17.0.3:55624
I0510 08:31:27.692077 26007 slave.cpp:1075] Successfully authenticated with master master@172.17.0.3:55624
I0510 08:31:27.692137 26007 slave.cpp:1503] Will retry registration in 3.941922ms if necessary
I0510 08:31:27.692193 26002 master.cpp:5429] Received register agent message from slave(315)@172.17.0.3:55624 (f4b88a125653)
I0510 08:31:27.692216 26002 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0510 08:31:27.692395 26005 master.cpp:5564] Registering agent at slave(315)@172.17.0.3:55624 (f4b88a125653) with id dd3fbaa9-2664-403c-8fb5-278f657e046d-S0
I0510 08:31:27.692523 26001 registrar.cpp:493] Applied 1 operations in 30467ns; attempting to update the registry
I0510 08:31:27.692831 26001 registrar.cpp:550] Successfully updated the registry in 278016ns
I0510 08:31:27.693069 26001 slave.cpp:4745] Received ping from slave-observer(308)@172.17.0.3:55624
I0510 08:31:27.693092 26006 master.cpp:5639] Registered agent dd3fbaa9-2664-403c-8fb5-278f657e046d-S0 at slave(315)@172.17.0.3:55624 (f4b88a125653) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0510 08:31:27.693142 26001 slave.cpp:1121] Registered with master master@172.17.0.3:55624; given agent ID dd3fbaa9-2664-403c-8fb5-278f657e046d-S0
I0510 08:31:27.693168 26001 fetcher.cpp:94] Clearing fetcher cache
I0510 08:31:27.693200 26010 hierarchical.cpp:525] Added agent dd3fbaa9-2664-403c-8fb5-278f657e046d-S0 (f4b88a125653) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0510 08:31:27.693281 26000 status_update_manager.cpp:184] Resuming sending status updates
I0510 08:31:27.693493 26001 slave.cpp:1149] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_6AUzln/meta/slaves/dd3fbaa9-2664-403c-8fb5-278f657e046d-S0/slave.info'
I0510 08:31:27.693558 26010 hierarchical.cpp:1940] No inverse offers to send out!
I0510 08:31:27.693583 26010 hierarchical.cpp:1434] Performed allocation for 1 agents in 287254ns
I0510 08:31:27.693747 26007 master.cpp:7305] Sending 1 offers to framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000 (default) at scheduler-1e0e3eac-6fcf-4ab0-ad3c-cf00ca6cde10@172.17.0.3:55624
I0510 08:31:27.693771 26001 slave.cpp:1187] Forwarding total oversubscribed resources {}
I0510 08:31:27.693845 26007 master.cpp:6324] Received update of agent dd3fbaa9-2664-403c-8fb5-278f657e046d-S0 at slave(315)@172.17.0.3:55624 (f4b88a125653) with total oversubscribed resources {}
I0510 08:31:27.693918 26004 sched.cpp:933] Scheduler::resourceOffers took 45724ns
I0510 08:31:27.694757 26003 master.cpp:3875] Processing ACCEPT call for offers: [ dd3fbaa9-2664-403c-8fb5-278f657e046d-O0 ] on agent dd3fbaa9-2664-403c-8fb5-278f657e046d-S0 at slave(315)@172.17.0.3:55624 (f4b88a125653) for framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000 (default) at scheduler-1e0e3eac-6fcf-4ab0-ad3c-cf00ca6cde10@172.17.0.3:55624
I0510 08:31:27.694802 26003 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task 1
I0510 08:31:27.694876 26003 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task 2
W0510 08:31:27.695509 26009 validation.cpp:1284] 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.
W0510 08:31:27.695536 26009 validation.cpp:1296] 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.
I0510 08:31:27.695641 26009 master.cpp:9320] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent dd3fbaa9-2664-403c-8fb5-278f657e046d-S0 at slave(315)@172.17.0.3:55624 (f4b88a125653)
I0510 08:31:27.695739 26009 master.cpp:4531] Launching task 1 of framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000 (default) at scheduler-1e0e3eac-6fcf-4ab0-ad3c-cf00ca6cde10@172.17.0.3:55624 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent dd3fbaa9-2664-403c-8fb5-278f657e046d-S0 at slave(315)@172.17.0.3:55624 (f4b88a125653)
I0510 08:31:27.695914 25998 slave.cpp:1613] Got assigned task '1' for framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000
W0510 08:31:27.696146 26009 validation.cpp:1284] 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.
W0510 08:31:27.696172 26009 validation.cpp:1296] 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.
I0510 08:31:27.696195 25998 slave.cpp:1894] Authorizing task '1' for framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000
I0510 08:31:27.696234 25998 slave.cpp:6589] Authorizing framework principal 'test-principal' to launch task 1
I0510 08:31:27.696290 26009 master.cpp:9320] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent dd3fbaa9-2664-403c-8fb5-278f657e046d-S0 at slave(315)@172.17.0.3:55624 (f4b88a125653)
I0510 08:31:27.696378 26009 master.cpp:4531] Launching task 2 of framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000 (default) at scheduler-1e0e3eac-6fcf-4ab0-ad3c-cf00ca6cde10@172.17.0.3:55624 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent dd3fbaa9-2664-403c-8fb5-278f657e046d-S0 at slave(315)@172.17.0.3:55624 (f4b88a125653)
I0510 08:31:27.696576 26004 slave.cpp:1613] Got assigned task '2' for framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000
I0510 08:31:27.696789 26004 slave.cpp:2081] Launching task '1' for framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000
I0510 08:31:27.697103 25996 hierarchical.cpp:850] Updated allocation of framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000 on agent dd3fbaa9-2664-403c-8fb5-278f657e046d-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]
I0510 08:31:27.697281 25996 hierarchical.cpp:1114] 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 dd3fbaa9-2664-403c-8fb5-278f657e046d-S0 from framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000
I0510 08:31:27.697312 25996 hierarchical.cpp:1151] Framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000 filtered agent dd3fbaa9-2664-403c-8fb5-278f657e046d-S0 for 5secs
I0510 08:31:27.697332 26004 paths.cpp:573] Trying to chown '/tmp/MasterTest_MultipleExecutors_6AUzln/slaves/dd3fbaa9-2664-403c-8fb5-278f657e046d-S0/frameworks/dd3fbaa9-2664-403c-8fb5-278f657e046d-0000/executors/executor-1/runs/4a85217a-8869-4ba9-9363-f77832e4666e' to user 'mesos'
I0510 08:31:27.697510 26004 slave.cpp:6933] Launching executor 'executor-1' of framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_6AUzln/slaves/dd3fbaa9-2664-403c-8fb5-278f657e046d-S0/frameworks/dd3fbaa9-2664-403c-8fb5-278f657e046d-0000/executors/executor-1/runs/4a85217a-8869-4ba9-9363-f77832e4666e'
I0510 08:31:27.697748 26004 slave.cpp:2310] Queued task '1' for executor 'executor-1' of framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000
I0510 08:31:27.697799 26004 slave.cpp:1894] Authorizing task '2' for framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000
I0510 08:31:27.697823 26004 slave.cpp:6589] Authorizing framework principal 'test-principal' to launch task 2
I0510 08:31:27.697998 26004 slave.cpp:871] Successfully attached file '/tmp/MasterTest_MultipleExecutors_6AUzln/slaves/dd3fbaa9-2664-403c-8fb5-278f657e046d-S0/frameworks/dd3fbaa9-2664-403c-8fb5-278f657e046d-0000/executors/executor-1/runs/4a85217a-8869-4ba9-9363-f77832e4666e'
I0510 08:31:27.698282 26004 slave.cpp:2081] Launching task '2' for framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000
I0510 08:31:27.698690 26004 paths.cpp:573] Trying to chown '/tmp/MasterTest_MultipleExecutors_6AUzln/slaves/dd3fbaa9-2664-403c-8fb5-278f657e046d-S0/frameworks/dd3fbaa9-2664-403c-8fb5-278f657e046d-0000/executors/executor-2/runs/b8ddb4e9-5c1d-43a6-8c48-3d30c24213dc' to user 'mesos'
I0510 08:31:27.698848 26004 slave.cpp:6933] Launching executor 'executor-2' of framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_6AUzln/slaves/dd3fbaa9-2664-403c-8fb5-278f657e046d-S0/frameworks/dd3fbaa9-2664-403c-8fb5-278f657e046d-0000/executors/executor-2/runs/b8ddb4e9-5c1d-43a6-8c48-3d30c24213dc'
I0510 08:31:27.699059 26004 slave.cpp:2310] Queued task '2' for executor 'executor-2' of framework dd3fbaa9-2664-403c-8fb5-278f657e046d-0000
*** Aborted at 1494405087 (unix time) try "date -d @1494405087" if you are using GNU date ***
I0510 08:31:27.699306 26003 exec.cpp:162] Version: 1.3.0
I0510 08:31:27.699367 25999 exec.cpp:212] Executor started at: executor(126)@172.17.0.3:55624 with pid 25995
PC: @ 0x2ac45e29382d (unknown)
*** SIGSEGV (@0x41) received by PID 25995 (TID 0x2ac46621f700) from PID 65; stack trace: ***
@ 0x2ac45d82a330 (unknown)
@ 0x2ac45e29382d (unknown)
@ 0x2ac458c1aeb5 mesos::internal::slave::executorEnvironment()
@ 0x2ac458c16074 mesos::internal::slave::Slave::launchExecutor()
@ 0x2ac45a571ae7 process::ProcessManager::resume()
@ 0x2ac45a586c9f std::thread::_Impl<>::_M_run()
@ 0x2ac45dae9a60 (unknown)
@ 0x2ac45d822184 start_thread
@ 0x2ac45e355bed (unknown)
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-1494401906-9949
Untagged: mesos-1494401906-9949:latest
Deleted: sha256:49e2e5d919e86cf471d7a097c5c742888a9a9c3fad6914049591d97bcfbbc4d8
Deleted: sha256:9fb3e5374b57b1a461ac687f61950d03830d9b8f3bd9982afe6a27ccbf791bce
Deleted: sha256:02915b7351f7d697baefd7a7e02063aeba5764287d79c7b8e37c3ab0723f8c51
Deleted: sha256:995edab462b8eca845b8794f46598c957f15ced9da9d6cc1a89a5ce1dbbca759
Deleted: sha256:915076889689da44455b64228ea1852d3b5dd5cf554790c8de44aa21a091ab63
Deleted: sha256:cb3d76e112f6200bfcf3eefd3c5cb78ba3e9285560decfbd61f509c9e4e5663b
Deleted: sha256:7e5c2982c2bc8df0d0eee594d2bed6cf60ef66616b7d90c93f7d4971075b7849
Deleted: sha256:33d67133f6a8b86b8a3f020c41f15aaf1ba650283465962062a48c8286ae485d
Deleted: sha256:76d3966af05ff142da9d9e0a36f9ce2e47aa9f433271b262499f92f8edb1f20a
Deleted: sha256:3c3a303ccbe37afd18588cbdcbcd799a78a7d3e710e53e4ab98822e96cf9e78f
Deleted: sha256:a4181133d37cab0cb6f83655a87797f53d9c46fbd0cbdca0a1d45d65fde483b5
Deleted: sha256:3f21305083e0867bc99b49a5d1b869fedfcc4042c45e1911cdbe1125a3f0989f
Deleted: sha256:6b40b6645aab30ec266743c655dac9da188f817f208c6236958d041ce555b9d4
Deleted: sha256:336b3740820f7abf04893e8f28386143ea751ba70ba9247559c98e899f9bc6c4
Deleted: sha256:564b9eba6b89d5545ea5724c5e721c6c2a18095226a7d7cb0ade64cb90032c1b
Deleted: sha256:458f9662d1807a7872deef90bf550ec843d7382f58f18c65a9a4bc20b52a882b
Deleted: sha256:7bbfa954dc3692420320c6133b134c89677e8cc0243ea7602bddb95fd03405ff
Deleted: sha256:1bcfd06a147c833f2ca20e7f4a308923b1e9f465e4fe428b1983266e7cbe97d6
Deleted: sha256:7c9d975c014ac54d9d6b34404cfdeb056a92cef6121e618a6d57128aa33899e9
Deleted: sha256:27033c3081b037960fb4cf5722c56b98e96dfb74a356dc98026b7e8ebbeedcdd
Deleted: sha256:ccefc30959e199387a2ef90ba98e9d177d363bbdd2d2ba8ed6499a98960d97ad
Deleted: sha256:4dd259a9e8003fb80da5790bbc6c30c2a4730be23a5d84691a5c1bdd0f4cc8fc
Deleted: sha256:7182c6ff663990cce8ac07a8e1d8bc09fc04bb32697cc7b5cc609a07e6a21bfb
Deleted: sha256:8816bb7add57ae69da26ace78c8f3f29280d48bea9c7e534aac78046de49adb4
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com
Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3648
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3648/display/redirect?page=changes>