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/06 03:46:07 UTC
Build failed in Jenkins: Mesos-Buildbot » autotools,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3616
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,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)/3616/display/redirect>
------------------------------------------
[...truncated 26.06 MB...]
I0506 03:46:00.676282 13843 scheduler.cpp:243] Sending SUBSCRIBE call to https://172.17.0.2:58252/master/api/v1/scheduler
I0506 03:46:00.676915 13843 authenticator.cpp:204] Received SASL authentication start
I0506 03:46:00.677637 13843 authenticator.cpp:326] Authentication requires more steps
I0506 03:46:00.677850 13843 authenticatee.cpp:259] Received SASL authentication step
I0506 03:46:00.678306 13843 authenticator.cpp:232] Received SASL authentication step
I0506 03:46:00.678521 13843 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'e29e14bfe67a' server FQDN: 'e29e14bfe67a' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0506 03:46:00.678676 13843 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0506 03:46:00.678851 13843 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0506 03:46:00.679010 13843 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'e29e14bfe67a' server FQDN: 'e29e14bfe67a' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0506 03:46:00.679158 13843 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0506 03:46:00.679318 13843 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0506 03:46:00.679467 13843 authenticator.cpp:318] Authentication success
I0506 03:46:00.678097 13841 process.cpp:3704] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0506 03:46:00.679868 13843 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1310)@172.17.0.2:58252
I0506 03:46:00.679777 13844 authenticatee.cpp:299] Authentication success
I0506 03:46:00.680311 13844 slave.cpp:1088] Successfully authenticated with master master@172.17.0.2:58252
I0506 03:46:00.680517 13844 slave.cpp:1515] Will retry registration in 1.09924ms if necessary
I0506 03:46:00.681023 13841 master.cpp:7229] Successfully authenticated principal 'test-principal' at slave(698)@172.17.0.2:58252
I0506 03:46:00.681325 13841 master.cpp:5396] Registering agent at slave(698)@172.17.0.2:58252 (e29e14bfe67a) with id 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0
I0506 03:46:00.681828 13845 registrar.cpp:461] Applied 1 operations in 101748ns; attempting to update the registry
I0506 03:46:00.682904 13841 slave.cpp:1515] Will retry registration in 610308ns if necessary
I0506 03:46:00.683125 13841 master.cpp:5384] Ignoring register agent message from slave(698)@172.17.0.2:58252 (e29e14bfe67a) as admission is already in progress
I0506 03:46:00.684290 13841 slave.cpp:1515] Will retry registration in 77.094736ms if necessary
I0506 03:46:00.684530 13841 master.cpp:5384] Ignoring register agent message from slave(698)@172.17.0.2:58252 (e29e14bfe67a) as admission is already in progress
I0506 03:46:00.686772 13845 registrar.cpp:506] Successfully updated the registry in 4.45696ms
I0506 03:46:00.688092 13843 slave.cpp:4346] Received ping from slave-observer(632)@172.17.0.2:58252
I0506 03:46:00.688100 13841 master.cpp:5470] Registered agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 at slave(698)@172.17.0.2:58252 (e29e14bfe67a) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0506 03:46:00.688257 13843 slave.cpp:1134] Registered with master master@172.17.0.2:58252; given agent ID 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0
I0506 03:46:00.688287 13843 fetcher.cpp:94] Clearing fetcher cache
I0506 03:46:00.688438 13841 status_update_manager.cpp:184] Resuming sending status updates
I0506 03:46:00.688462 13842 hierarchical.cpp:516] Added agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 (e29e14bfe67a) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0506 03:46:00.688673 13843 slave.cpp:1162] Checkpointing SlaveInfo to '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_qmlnci/meta/slaves/4ad5b476-1404-449a-86ab-6d56c1c0562a-S0/slave.info'
I0506 03:46:00.688705 13842 hierarchical.cpp:1810] No allocations performed
I0506 03:46:00.688768 13842 hierarchical.cpp:1394] Performed allocation for 1 agents in 184292ns
I0506 03:46:00.689110 13843 slave.cpp:1200] Forwarding total oversubscribed resources {}
I0506 03:46:00.689267 13841 master.cpp:6045] Received update of agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 at slave(698)@172.17.0.2:58252 (e29e14bfe67a) with total oversubscribed resources {}
I0506 03:46:00.689478 13843 hierarchical.cpp:589] Agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 (e29e14bfe67a) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {})
I0506 03:46:00.689651 13843 hierarchical.cpp:1810] No allocations performed
I0506 03:46:00.689697 13843 hierarchical.cpp:1394] Performed allocation for 1 agents in 140955ns
I0506 03:46:00.715951 13846 http.cpp:420] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:41081
I0506 03:46:00.719652 13846 master.cpp:2423] Received subscription request for HTTP framework 'default'
I0506 03:46:00.719930 13846 master.cpp:2160] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0506 03:46:00.720963 13847 master.cpp:2537] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0506 03:46:00.723058 13848 hierarchical.cpp:286] Added framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:00.724771 13848 hierarchical.cpp:1900] No inverse offers to send out!
I0506 03:46:00.724931 13848 hierarchical.cpp:1394] Performed allocation for 1 agents in 1.511068ms
I0506 03:46:00.725770 13851 master.hpp:2119] Sending heartbeat to 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:00.726439 13847 master.cpp:7028] Sending 1 offers to framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 (default)
I0506 03:46:00.759323 13846 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from https://172.17.0.2:58252/master/api/v1/scheduler
I0506 03:46:00.761090 13853 scheduler.cpp:676] Enqueuing event HEARTBEAT received from https://172.17.0.2:58252/master/api/v1/scheduler
I0506 03:46:00.763756 13850 scheduler.cpp:676] Enqueuing event OFFERS received from https://172.17.0.2:58252/master/api/v1/scheduler
I0506 03:46:00.768079 13849 scheduler.cpp:243] Sending ACCEPT call to https://172.17.0.2:58252/master/api/v1/scheduler
I0506 03:46:00.770771 13850 process.cpp:3704] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0506 03:46:00.808444 13852 http.cpp:420] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:41082
I0506 03:46:00.811708 13852 master.cpp:3776] Processing ACCEPT call for offers: [ 4ad5b476-1404-449a-86ab-6d56c1c0562a-O0 ] on agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 at slave(698)@172.17.0.2:58252 (e29e14bfe67a) for framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 (default)
I0506 03:46:00.811854 13852 master.cpp:3352] Authorizing framework principal 'test-principal' to launch task 75b1d34a-6f60-48a4-b188-95d742cdc9ac
W0506 03:46:00.815192 13852 validation.cpp:1064] Executor 'default' for task '75b1d34a-6f60-48a4-b188-95d742cdc9ac' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0506 03:46:00.815291 13852 validation.cpp:1076] Executor 'default' for task '75b1d34a-6f60-48a4-b188-95d742cdc9ac' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0506 03:46:00.816118 13852 master.cpp:9089] Adding task 75b1d34a-6f60-48a4-b188-95d742cdc9ac with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 at slave(698)@172.17.0.2:58252 (e29e14bfe67a)
I0506 03:46:00.816623 13852 master.cpp:4426] Launching task 75b1d34a-6f60-48a4-b188-95d742cdc9ac of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 at slave(698)@172.17.0.2:58252 (e29e14bfe67a)
I0506 03:46:00.817414 13854 slave.cpp:1625] Got assigned task '75b1d34a-6f60-48a4-b188-95d742cdc9ac' for framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:00.818581 13854 slave.cpp:1785] Launching task '75b1d34a-6f60-48a4-b188-95d742cdc9ac' for framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:00.820411 13852 hierarchical.cpp:807] Updated allocation of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 on agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-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]
I0506 03:46:00.821861 13854 paths.cpp:547] Trying to chown '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_qmlnci/slaves/4ad5b476-1404-449a-86ab-6d56c1c0562a-S0/frameworks/4ad5b476-1404-449a-86ab-6d56c1c0562a-0000/executors/default/runs/5554cb1e-a1cf-454a-9e1d-7b6077d3488c' to user 'mesos'
I0506 03:46:00.822413 13854 slave.cpp:6472] Launching executor 'default' of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 with resources {} in work directory '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_qmlnci/slaves/4ad5b476-1404-449a-86ab-6d56c1c0562a-S0/frameworks/4ad5b476-1404-449a-86ab-6d56c1c0562a-0000/executors/default/runs/5554cb1e-a1cf-454a-9e1d-7b6077d3488c'
I0506 03:46:00.823616 13854 slave.cpp:2118] Queued task '75b1d34a-6f60-48a4-b188-95d742cdc9ac' for executor 'default' of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:00.823904 13854 slave.cpp:884] Successfully attached file '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_qmlnci/slaves/4ad5b476-1404-449a-86ab-6d56c1c0562a-S0/frameworks/4ad5b476-1404-449a-86ab-6d56c1c0562a-0000/executors/default/runs/5554cb1e-a1cf-454a-9e1d-7b6077d3488c'
I0506 03:46:00.826195 13849 executor.cpp:192] Version: 1.2.1
I0506 03:46:00.846269 13850 executor.cpp:401] Connected with the agent
I0506 03:46:00.846992 13844 executor.cpp:302] Sending SUBSCRIBE call to https://172.17.0.2:58252/slave(698)/api/v1/executor
I0506 03:46:00.848510 13852 process.cpp:3704] Handling HTTP event for process 'slave(698)' with path: '/slave(698)/api/v1/executor'
I0506 03:46:00.891482 13841 http.cpp:307] HTTP POST for /slave(698)/api/v1/executor from 172.17.0.2:41090
I0506 03:46:00.891818 13841 slave.cpp:3169] Received Subscribe request for HTTP executor 'default' of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:00.894472 13841 slave.cpp:2331] Sending queued task '75b1d34a-6f60-48a4-b188-95d742cdc9ac' to executor 'default' of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 (via HTTP)
I0506 03:46:00.936588 13850 executor.cpp:716] Enqueuing event SUBSCRIBED received from https://172.17.0.2:58252/slave(698)/api/v1/executor
I0506 03:46:00.938294 13855 executor.cpp:716] Enqueuing event LAUNCH received from https://172.17.0.2:58252/slave(698)/api/v1/executor
I0506 03:46:00.939272 13850 executor.cpp:302] Sending UPDATE call to https://172.17.0.2:58252/slave(698)/api/v1/executor
I0506 03:46:00.940631 13843 process.cpp:3704] Handling HTTP event for process 'slave(698)' with path: '/slave(698)/api/v1/executor'
I0506 03:46:00.979668 13846 http.cpp:307] HTTP POST for /slave(698)/api/v1/executor from 172.17.0.2:41092
I0506 03:46:00.980013 13846 slave.cpp:3816] Handling status update TASK_RUNNING (UUID: fe504f4f-2181-432a-a85c-0048f7c2e356) for task 75b1d34a-6f60-48a4-b188-95d742cdc9ac of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:00.981779 13849 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: fe504f4f-2181-432a-a85c-0048f7c2e356) for task 75b1d34a-6f60-48a4-b188-95d742cdc9ac of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:00.981973 13849 status_update_manager.cpp:500] Creating StatusUpdate stream for task 75b1d34a-6f60-48a4-b188-95d742cdc9ac of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:00.982699 13849 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: fe504f4f-2181-432a-a85c-0048f7c2e356) for task 75b1d34a-6f60-48a4-b188-95d742cdc9ac of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 to the agent
I0506 03:46:00.982995 13846 slave.cpp:4256] Forwarding the update TASK_RUNNING (UUID: fe504f4f-2181-432a-a85c-0048f7c2e356) for task 75b1d34a-6f60-48a4-b188-95d742cdc9ac of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 to master@172.17.0.2:58252
I0506 03:46:00.983238 13846 slave.cpp:4150] Status update manager successfully handled status update TASK_RUNNING (UUID: fe504f4f-2181-432a-a85c-0048f7c2e356) for task 75b1d34a-6f60-48a4-b188-95d742cdc9ac of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:00.983477 13849 master.cpp:6190] Status update TASK_RUNNING (UUID: fe504f4f-2181-432a-a85c-0048f7c2e356) for task 75b1d34a-6f60-48a4-b188-95d742cdc9ac of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 from agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 at slave(698)@172.17.0.2:58252 (e29e14bfe67a)
I0506 03:46:00.983675 13849 master.cpp:6258] Forwarding status update TASK_RUNNING (UUID: fe504f4f-2181-432a-a85c-0048f7c2e356) for task 75b1d34a-6f60-48a4-b188-95d742cdc9ac of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:00.984272 13843 executor.cpp:716] Enqueuing event ACKNOWLEDGED received from https://172.17.0.2:58252/slave(698)/api/v1/executor
I0506 03:46:00.984580 13849 master.cpp:8338] Updating the state of task 75b1d34a-6f60-48a4-b188-95d742cdc9ac of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0506 03:46:00.986625 13843 scheduler.cpp:676] Enqueuing event UPDATE received from https://172.17.0.2:58252/master/api/v1/scheduler
I0506 03:46:00.987838 13849 scheduler.cpp:243] Sending TEARDOWN call to https://172.17.0.2:58252/master/api/v1/scheduler
I0506 03:46:00.988878 13842 process.cpp:3704] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0506 03:46:01.027966 13854 http.cpp:420] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:41082
I0506 03:46:01.028491 13854 master.cpp:7753] Removing framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 (default)
I0506 03:46:01.028688 13854 master.cpp:3081] Deactivating framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 (default)
I0506 03:46:01.028985 13851 hierarchical.cpp:415] Deactivated framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:01.029070 13851 slave.cpp:2658] Asked to shut down framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 by master@172.17.0.2:58252
I0506 03:46:01.029093 13854 master.cpp:8338] Updating the state of task 75b1d34a-6f60-48a4-b188-95d742cdc9ac of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0506 03:46:01.029106 13851 slave.cpp:2683] Shutting down framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:01.029187 13851 slave.cpp:5075] Shutting down executor 'default' of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 (via HTTP)
I0506 03:46:01.030125 13854 master.cpp:8432] Removing task 75b1d34a-6f60-48a4-b188-95d742cdc9ac with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 on agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 at slave(698)@172.17.0.2:58252 (e29e14bfe67a)
I0506 03:46:01.030616 13851 hierarchical.cpp:1064] 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 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 from framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:01.030661 13854 master.cpp:8461] Removing executor 'default' with resources {} of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 on agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 at slave(698)@172.17.0.2:58252 (e29e14bfe67a)
I0506 03:46:01.030958 13846 executor.cpp:716] Enqueuing event SHUTDOWN received from https://172.17.0.2:58252/slave(698)/api/v1/executor
I0506 03:46:01.031293 13856 hierarchical.cpp:362] Removed framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
E0506 03:46:01.032773 13844 scheduler.cpp:649] End-Of-File received from master. The master closed the event stream
I0506 03:46:01.033334 13844 scheduler.cpp:444] Re-detecting master
I0506 03:46:01.033938 13844 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0506 03:46:01.034122 13844 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0506 03:46:01.034354 13844 scheduler.cpp:470] New master detected at master@172.17.0.2:58252
I0506 03:46:01.036625 13844 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0506 03:46:01.044442 13850 slave.cpp:4761] Executor 'default' of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 exited with status 0
I0506 03:46:01.044868 13850 slave.cpp:4861] Cleaning up executor 'default' of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 (via HTTP)
W0506 03:46:01.044981 13846 master.cpp:6314] Ignoring unknown exited executor 'default' of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 on agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 at slave(698)@172.17.0.2:58252 (e29e14bfe67a)
I0506 03:46:01.045750 13850 slave.cpp:4949] Cleaning up framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:01.046049 13856 status_update_manager.cpp:285] Closing status update streams for framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:01.046103 13856 status_update_manager.cpp:531] Cleaning up status update stream for task 75b1d34a-6f60-48a4-b188-95d742cdc9ac of framework 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000
I0506 03:46:01.045859 13854 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_qmlnci/slaves/4ad5b476-1404-449a-86ab-6d56c1c0562a-S0/frameworks/4ad5b476-1404-449a-86ab-6d56c1c0562a-0000/executors/default/runs/5554cb1e-a1cf-454a-9e1d-7b6077d3488c' for gc 6.99999947296296days in the future
I0506 03:46:01.046484 13854 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_qmlnci/slaves/4ad5b476-1404-449a-86ab-6d56c1c0562a-S0/frameworks/4ad5b476-1404-449a-86ab-6d56c1c0562a-0000/executors/default' for gc 6.99999947104296days in the future
I0506 03:46:01.046706 13848 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_qmlnci/slaves/4ad5b476-1404-449a-86ab-6d56c1c0562a-S0/frameworks/4ad5b476-1404-449a-86ab-6d56c1c0562a-0000' for gc 6.99999946027852days in the future
I0506 03:46:01.046718 13850 slave.cpp:803] Agent terminating
I0506 03:46:01.046950 13844 master.cpp:1264] Agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 at slave(698)@172.17.0.2:58252 (e29e14bfe67a) disconnected
I0506 03:46:01.046982 13844 master.cpp:3118] Disconnecting agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 at slave(698)@172.17.0.2:58252 (e29e14bfe67a)
I0506 03:46:01.047068 13844 master.cpp:3137] Deactivating agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 at slave(698)@172.17.0.2:58252 (e29e14bfe67a)
I0506 03:46:01.047188 13842 hierarchical.cpp:618] Agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0 deactivated
I0506 03:46:01.049324 13843 master.cpp:1103] Master terminating
I0506 03:46:01.050238 13844 hierarchical.cpp:549] Removed agent 4ad5b476-1404-449a-86ab-6d56c1c0562a-S0
W0506 03:46:01.051175 30922 master.hpp:2546] Failed to close HTTP pipe for 4ad5b476-1404-449a-86ab-6d56c1c0562a-0000 (default)
[ OK ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/2 (628 ms)
[ RUN ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/3
W0506 03:46:01.067124 13857 process.cpp:3029] Attempted to spawn a process (__http_connection__(1066)@172.17.0.2:58252) after finalizing libprocess!
*** Aborted at 1494042361 (unix time) try "date -d @1494042361" if you are using GNU date ***
I0506 03:46:01.069926 30922 process.cpp:1246] libprocess is initialized on 172.17.0.2:45625 with 16 worker threads
I0506 03:46:01.073364 30922 cluster.cpp:160] Creating default 'local' authorizer
I0506 03:46:01.078029 13872 master.cpp:383] Master d87e746f-d064-4186-8351-f187f22ba675 (e29e14bfe67a) started on 172.17.0.2:45625
I0506 03:46:01.078096 13872 master.cpp:385] 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/ODXhBv/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="/mesos/mesos-1.2.1/_inst/share/mesos/webui" --work_dir="/tmp/ODXhBv/master" --zk_session_timeout="10secs"
I0506 03:46:01.078702 13872 master.cpp:435] Master only allowing authenticated frameworks to register
I0506 03:46:01.078721 13872 master.cpp:449] Master only allowing authenticated agents to register
I0506 03:46:01.078727 13872 master.cpp:462] Master only allowing authenticated HTTP frameworks to register
I0506 03:46:01.078732 13872 credentials.hpp:37] Loading credentials for authentication from '/tmp/ODXhBv/credentials'
I0506 03:46:01.079066 13872 master.cpp:507] Using default 'crammd5' authenticator
I0506 03:46:01.079244 13872 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0506 03:46:01.079419 13872 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0506 03:46:01.079545 13872 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0506 03:46:01.079677 13872 master.cpp:587] Authorization enabled
I0506 03:46:01.079864 13864 hierarchical.cpp:161] Initialized hierarchical allocator process
I0506 03:46:01.079876 13871 whitelist_watcher.cpp:77] No whitelist given
I0506 03:46:01.083341 13858 master.cpp:2124] Elected as the leading master!
I0506 03:46:01.083374 13858 master.cpp:1646] Recovering from registrar
I0506 03:46:01.083484 13863 registrar.cpp:329] Recovering registrar
PC: @ 0x2b4013da99e8 process::PID<>::PID()
*** SIGSEGV (@0x0) received by PID 30922 (TID 0x2b40215d0700) from PID 0; stack trace: ***
@ 0x2b406c7d92d7 (unknown)
I0506 03:46:01.085755 13868 registrar.cpp:362] Successfully fetched the registry (0B) in 2.210048ms
I0506 03:46:01.085965 13868 registrar.cpp:461] Applied 1 operations in 43006ns; attempting to update the registry
@ 0x2b406c7dd5b9 (unknown)
@ 0x2b401668c330 (unknown)
I0506 03:46:01.089725 13865 registrar.cpp:506] Successfully updated the registry in 3.691008ms
I0506 03:46:01.089901 13865 registrar.cpp:392] Successfully recovered registrar
I0506 03:46:01.090414 13858 master.cpp:1762] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0506 03:46:01.090512 13869 hierarchical.cpp:188] Skipping recovery of hierarchical allocator: nothing to recover
I0506 03:46:01.095067 30922 cluster.cpp:446] Creating default 'local' authorizer
I0506 03:46:01.096705 13871 slave.cpp:211] Mesos agent started on (699)@172.17.0.2:45625
I0506 03:46:01.096755 13871 slave.cpp:212] 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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_gMHr2D/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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_gMHr2D/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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_gMHr2D/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.1/_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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_gMHr2D" --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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_SG2QOz"
I0506 03:46:01.097365 13871 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_gMHr2D/credential'
I0506 03:46:01.097416 30922 scheduler.cpp:184] Version: 1.2.1
I0506 03:46:01.097584 13871 slave.cpp:354] Agent using credential for: test-principal
I0506 03:46:01.097610 13871 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_gMHr2D/http_credentials'
I0506 03:46:01.097884 13871 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0506 03:46:01.098098 13871 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0506 03:46:01.098093 13858 scheduler.cpp:470] New master detected at master@172.17.0.2:45625
I0506 03:46:01.098178 13858 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0506 03:46:01.099393 13871 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0506 03:46:01.099474 13871 slave.cpp:549] Agent attributes: [ ]
I0506 03:46:01.099494 13871 slave.cpp:554] Agent hostname: e29e14bfe67a
I0506 03:46:01.099640 13865 status_update_manager.cpp:177] Pausing sending status updates
I0506 03:46:01.101271 13872 state.cpp:62] Recovering state from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_SG2QOz/meta'
@ 0x2b4013da99e8 process::PID<>::PID()
I0506 03:46:01.103027 13873 status_update_manager.cpp:203] Recovering status update manager
I0506 03:46:01.103487 13867 slave.cpp:5550] Finished recovery
I0506 03:46:01.104034 13867 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0506 03:46:01.104393 13868 status_update_manager.cpp:177] Pausing sending status updates
I0506 03:46:01.104403 13858 slave.cpp:931] New master detected at master@172.17.0.2:45625
I0506 03:46:01.104486 13858 slave.cpp:966] Detecting new master
I0506 03:46:01.104671 13858 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
@ 0x2b4013d86ebc process::Process<>::self()
@ 0x2b4013d6cabc process::ProcessManager::spawn()
@ 0x2b4013d73296 process::spawn()
@ 0x2b4013ca8c8c process::spawn<>()
@ 0x2b4013ca8bdb process::http::Connection::Data::Data()
@ 0x2b4013ca8b76 _ZN9__gnu_cxx13new_allocatorIN7process4http10Connection4DataEE9constructIS4_JRKNS1_7network8internal6SocketINS7_7AddressEEEEEEvPT_DpOT0_
@ 0x2b4013ca8b1d _ZNSt16allocator_traitsISaIN7process4http10Connection4DataEEE12_S_constructIS3_JRKNS0_7network8internal6SocketINS7_7AddressEEEEEENSt9enable_ifIXsr18__construct_helperIT_DpT0_EE5valueEvE4typeERS4_PSF_DpOSG_
@ 0x2b4013ca8770 _ZNSt16allocator_traitsISaIN7process4http10Connection4DataEEE9constructIS3_JRKNS0_7network8internal6SocketINS7_7AddressEEEEEEDTcl12_S_constructfp_fp0_spclsr3stdE7forwardIT0_Efp1_EEERS4_PT_DpOSE_
@ 0x2b4013ca869a _ZNSt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS3_ELN9__gnu_cxx12_Lock_policyE2EEC2IJRKNS0_7network8internal6SocketINS9_7AddressEEEEEES4_DpOT_
@ 0x2b4013ca854b _ZN9__gnu_cxx13new_allocatorISt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS5_ELNS_12_Lock_policyE2EEE9constructIS8_JKS6_RKNS2_7network8internal6SocketINSC_7AddressEEEEEEvPT_DpOT0_
@ 0x2b4013ca84b2 _ZNSt16allocator_traitsISaISt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS4_ELN9__gnu_cxx12_Lock_policyE2EEEE12_S_constructIS8_JKS5_RKNS1_7network8internal6SocketINSD_7AddressEEEEEENSt9enable_ifIXsr18__construct_helperIT_DpT0_EE5valueEvE4typeERS9_PSL_DpOSM_
@ 0x2b4013ca83a5 _ZNSt16allocator_traitsISaISt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS4_ELN9__gnu_cxx12_Lock_policyE2EEEE9constructIS8_JKS5_RKNS1_7network8internal6SocketINSD_7AddressEEEEEEDTcl12_S_constructfp_fp0_spclsr3stdE7forwardIT0_Efp1_EEERS9_PT_DpOSK_
@ 0x2b4013ca8218 _ZNSt14__shared_countILN9__gnu_cxx12_Lock_policyE2EEC2IN7process4http10Connection4DataESaIS7_EJRKNS4_7network8internal6SocketINS9_7AddressEEEEEESt19_Sp_make_shared_tagPT_RKT0_DpOT1_
@ 0x2b4013ca812f _ZNSt12__shared_ptrIN7process4http10Connection4DataELN9__gnu_cxx12_Lock_policyE2EEC2ISaIS3_EJRKNS0_7network8internal6SocketINS9_7AddressEEEEEESt19_Sp_make_shared_tagRKT_DpOT0_
@ 0x2b4013ca80bd _ZNSt10shared_ptrIN7process4http10Connection4DataEEC2ISaIS3_EJRKNS0_7network8internal6SocketINS7_7AddressEEEEEESt19_Sp_make_shared_tagRKT_DpOT0_
@ 0x2b4013ca7fff _ZSt15allocate_sharedIN7process4http10Connection4DataESaIS3_EJRKNS0_7network8internal6SocketINS5_7AddressEEEEESt10shared_ptrIT_ERKT0_DpOT1_
@ 0x2b4013c8254d _ZSt11make_sharedIN7process4http10Connection4DataEJRKNS0_7network8internal6SocketINS4_7AddressEEEEESt10shared_ptrIT_EDpOT0_
@ 0x2b4013c3bd1d process::http::Connection::Connection()
@ 0x2b4013c7074f process::http::connect()::$_1::operator()()
@ 0x2b4013c704cf std::_Function_handler<>::_M_invoke()
@ 0x2b4012fc352d std::function<>::operator()()
@ 0x2b4012fc34d0 _ZNSt5_BindIFSt8functionIFN7process6FutureINS1_4http10ConnectionEEEvEEvEE6__callIS5_JRK7NothingEJEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
@ 0x2b4012fc3485 _ZNSt5_BindIFSt8functionIFN7process6FutureINS1_4http10ConnectionEEEvEEvEEclIJRK7NothingES5_EET0_DpOT_
@ 0x2b4012fc3124 std::_Function_handler<>::_M_invoke()
@ 0x2b4012fc519a std::function<>::operator()()
@ 0x2b4012fc3d61 process::internal::thenf<>()
@ 0x2b4012fc4a33 _ZNSt5_BindIFPFvRKSt8functionIFN7process6FutureINS1_4http10ConnectionEEERK7NothingEERKSt10shared_ptrINS1_7PromiseIS4_EEERKNS2_IS6_EEESA_SG_St12_PlaceholderILi1EEEE6__callIvJSL_EJLm0ELm1ELm2EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
@ 0x2b4012fc4976 _ZNSt5_BindIFPFvRKSt8functionIFN7process6FutureINS1_4http10ConnectionEEERK7NothingEERKSt10shared_ptrINS1_7PromiseIS4_EEERKNS2_IS6_EEESA_SG_St12_PlaceholderILi1EEEEclIJSL_EvEET0_DpOT_
make[4]: *** [check-local] Segmentation fault
make[4]: Leaving directory `/mesos/mesos-1.2.1/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.2.1/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.2.1/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.2.1/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1494039957-14484
Untagged: mesos-1494039957-14484:latest
Deleted: sha256:7e50ac9ec772b7c53faed4401b37a662f678807814ba54207fd1723e68f0b4f0
Deleted: sha256:0b5cd19d71651b8b97664098ad5bb2af0c33d3c4114d02fcaac4b03465bfab3a
Deleted: sha256:457166db332d29d04981920d85192d8a71be300be1e0817aff9f340db154f212
Deleted: sha256:f908ec587454a009583ae3c27840ebc5221d8781b64836cf1f2a66c3e67dd532
Deleted: sha256:244016d27693a666a6fe63bb6ba6d2bf768777d811ebd3da12ce5cc76ae2cbb6
Deleted: sha256:516ae6fc40f8aa8e2122025e2791743b1f141f925b969204476dd844d05ca99b
Deleted: sha256:3107dd030dd4dfc0e3148170dadc174f1ef99acd96913ac0c7f8740b393de977
Deleted: sha256:0a153ca8961b02664128d694c12a4dd6930669e57d0ee75a7bbd8c71815d9a8a
Deleted: sha256:c039d068c51b9f5d2b55edbd21695c14e061e6a398f25e2f983d0474f8966e90
Deleted: sha256:b8c0533b697c0fd8a5009ebcdd80dbb1e721e16e06d794c0412d704ff9f6514f
Deleted: sha256:ebc819560ee38a21d02c47445a7ad7ae3e294e92f68bb7f25622c3f1198bfe7c
Deleted: sha256:cd5346beec4b1aaf8c772d56e11f52fc7eaa18c9451eeee665984d61cc3ff6d5
Deleted: sha256:735149390b97fb4657402024d70a9d85e9acb3dc8e29c09881b5e1dd774280fa
Deleted: sha256:b3499bfeb4ae71ad1db4aafb74076fce344d77fd91eb591a7fe9cd84da2d8221
Deleted: sha256:764a44b4853a779f8872f703929474a5d1df570bfb527d7352bd65245a8ad3be
Deleted: sha256:33803bc526bad40a795c40c2d99ea74016f29afb081002112ee40a50f8561356
Deleted: sha256:2ada1c72f5e9b82eb46d07eb93e0d73d8a66dd886fb766268b66adf9048d605c
Deleted: sha256:e6bc8430d94e4150aa0a125b83031a6dc05cd1f4e5751424602533527e1b4e1a
Deleted: sha256:74b3137e0b7f790f3e632a21149c36d8daafa9657168b8df48b2409ae040802e
Deleted: sha256:97265457155830caa42879186b985d1201c599214c4ed43adeb40719b0c7faa4
Deleted: sha256:f0620b1384ca41472160148320012ccbcaff611a391711e4f5eeb0cff354ae67
Deleted: sha256:1a00967646d4d8ab08b1c44062b032bede1e5f82229c6dbd217a5a96a554aa03
Deleted: sha256:68653c8f889232b713b11426e3281ca69e2ebb67b53ed9a5cf3a7ed24837bc67
Deleted: sha256:61bd2b3b73db6ba12e7dfc7ef7d6511f78ba9c8278f3250ce5df4fe7de791bcd
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Buildbot » autotools,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3617
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,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)/3617/display/redirect?page=changes>