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/02/28 00:23:42 UTC

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3314

See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,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)/3314/display/redirect?page=changes>

Changes:

[bmahler] Added TODOs to the framework and agent capabilities helpers.

[bmahler] Added equality and output operators for agent capabilities.

[bmahler] Added agent capabilities to HierarchicalAllocatorProcess (1/2).

[bmahler] Prevent resource of old agents being allocated to MULTI_ROLE frameworks.

[bmahler] Added agent capabilities to HierarchicalAllocatorProcess (2/2).

[bmahler] Added a test to ensure agent can be upgraded into MULTI_ROLE.

------------------------------------------
[...truncated 26.26 MB...]
I0228 00:23:35.290607 15482 authenticatee.cpp:121] Creating new client SASL connection
I0228 00:23:35.290906 15482 master.cpp:7210] Authenticating slave(704)@172.17.0.2:35116
I0228 00:23:35.291069 15482 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1327)@172.17.0.2:35116
I0228 00:23:35.291231 15486 scheduler.cpp:361] Connected with the master at https://172.17.0.2:35116/master/api/v1/scheduler
I0228 00:23:35.291301 15489 authenticator.cpp:98] Creating new server SASL connection
I0228 00:23:35.291544 15490 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0228 00:23:35.291576 15490 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0228 00:23:35.291682 15492 authenticator.cpp:204] Received SASL authentication start
I0228 00:23:35.291751 15492 authenticator.cpp:326] Authentication requires more steps
I0228 00:23:35.291982 15488 authenticatee.cpp:259] Received SASL authentication step
I0228 00:23:35.292254 15486 authenticator.cpp:232] Received SASL authentication step
I0228 00:23:35.292292 15486 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'fc2f9ae74b77' server FQDN: 'fc2f9ae74b77' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0228 00:23:35.292316 15486 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0228 00:23:35.292367 15486 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0228 00:23:35.292407 15486 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'fc2f9ae74b77' server FQDN: 'fc2f9ae74b77' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0228 00:23:35.292428 15486 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0228 00:23:35.292479 15486 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0228 00:23:35.292506 15486 authenticator.cpp:318] Authentication success
I0228 00:23:35.292634 15488 scheduler.cpp:243] Sending SUBSCRIBE call to https://172.17.0.2:35116/master/api/v1/scheduler
I0228 00:23:35.292652 15490 master.cpp:7240] Successfully authenticated principal 'test-principal' at slave(704)@172.17.0.2:35116
I0228 00:23:35.292712 15483 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1327)@172.17.0.2:35116
I0228 00:23:35.292816 15494 authenticatee.cpp:299] Authentication success
I0228 00:23:35.293288 15494 slave.cpp:1088] Successfully authenticated with master master@172.17.0.2:35116
I0228 00:23:35.293493 15494 slave.cpp:1516] Will retry registration in 7.445871ms if necessary
I0228 00:23:35.293668 15489 master.cpp:5423] Registering agent at slave(704)@172.17.0.2:35116 (fc2f9ae74b77) with id 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0
I0228 00:23:35.294100 15494 registrar.cpp:461] Applied 1 operations in 70722ns; attempting to update the registry
I0228 00:23:35.294176 15493 process.cpp:3704] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0228 00:23:35.297117 15494 registrar.cpp:506] Successfully updated the registry in 2.942208ms
I0228 00:23:35.297869 15483 slave.cpp:4347] Received ping from slave-observer(641)@172.17.0.2:35116
I0228 00:23:35.297938 15482 master.cpp:5497] Registered agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 at slave(704)@172.17.0.2:35116 (fc2f9ae74b77) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0228 00:23:35.298157 15483 slave.cpp:1134] Registered with master master@172.17.0.2:35116; given agent ID 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0
I0228 00:23:35.298183 15483 fetcher.cpp:94] Clearing fetcher cache
I0228 00:23:35.298334 15493 status_update_manager.cpp:184] Resuming sending status updates
I0228 00:23:35.298403 15494 hierarchical.cpp:518] Added agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 (fc2f9ae74b77) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0228 00:23:35.298593 15483 slave.cpp:1162] Checkpointing SlaveInfo to '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_oWVx9C/meta/slaves/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0/slave.info'
I0228 00:23:35.298679 15494 hierarchical.cpp:1838] No allocations performed
I0228 00:23:35.298741 15494 hierarchical.cpp:1422] Performed allocation for 1 agents in 204871ns
I0228 00:23:35.298956 15483 slave.cpp:1200] Forwarding total oversubscribed resources {}
I0228 00:23:35.299103 15493 master.cpp:6056] Received update of agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 at slave(704)@172.17.0.2:35116 (fc2f9ae74b77) with total oversubscribed resources {}
I0228 00:23:35.334717 15493 http.cpp:437] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:53164
I0228 00:23:35.336663 15493 master.cpp:2474] Received subscription request for HTTP framework 'default'
I0228 00:23:35.336762 15493 master.cpp:2158] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0228 00:23:35.337424 15493 master.cpp:2589] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I0228 00:23:35.338438 15484 hierarchical.cpp:286] Added framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.338443 15488 master.hpp:2134] Sending heartbeat to 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.339972 15484 hierarchical.cpp:1928] No inverse offers to send out!
I0228 00:23:35.340095 15484 hierarchical.cpp:1422] Performed allocation for 1 agents in 1.499195ms
I0228 00:23:35.340694 15493 master.cpp:7039] Sending 1 offers to framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 (default)
I0228 00:23:35.378058 15485 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from https://172.17.0.2:35116/master/api/v1/scheduler
I0228 00:23:35.380024 15496 scheduler.cpp:676] Enqueuing event HEARTBEAT received from https://172.17.0.2:35116/master/api/v1/scheduler
I0228 00:23:35.381131 15491 scheduler.cpp:676] Enqueuing event OFFERS received from https://172.17.0.2:35116/master/api/v1/scheduler
I0228 00:23:35.383803 15487 scheduler.cpp:243] Sending ACCEPT call to https://172.17.0.2:35116/master/api/v1/scheduler
I0228 00:23:35.386453 15490 process.cpp:3704] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0228 00:23:35.426331 15492 http.cpp:437] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:53163
I0228 00:23:35.429149 15492 master.cpp:3825] Processing ACCEPT call for offers: [ 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-O0 ] on agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 at slave(704)@172.17.0.2:35116 (fc2f9ae74b77) for framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 (default)
I0228 00:23:35.429297 15492 master.cpp:3401] Authorizing framework principal 'test-principal' to launch task dc88a181-4410-4cb5-9b95-3c7dd9089ae1
W0228 00:23:35.432652 15484 validation.cpp:1104] Executor 'default' for task 'dc88a181-4410-4cb5-9b95-3c7dd9089ae1' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0228 00:23:35.432693 15484 validation.cpp:1116] Executor 'default' for task 'dc88a181-4410-4cb5-9b95-3c7dd9089ae1' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0228 00:23:35.433423 15484 master.cpp:9101] Adding task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 at slave(704)@172.17.0.2:35116 (fc2f9ae74b77)
I0228 00:23:35.433850 15484 master.cpp:4475] Launching task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 at slave(704)@172.17.0.2:35116 (fc2f9ae74b77)
I0228 00:23:35.434447 15493 slave.cpp:1626] Got assigned task 'dc88a181-4410-4cb5-9b95-3c7dd9089ae1' for framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.435324 15493 slave.cpp:1786] Launching task 'dc88a181-4410-4cb5-9b95-3c7dd9089ae1' for framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.436182 15493 paths.cpp:547] Trying to chown '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_oWVx9C/slaves/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0/frameworks/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000/executors/default/runs/b5d9f216-ccd5-4bc5-baec-febb2bf88afc' to user 'mesos'
I0228 00:23:35.436517 15493 slave.cpp:6481] Launching executor 'default' of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 with resources {} in work directory '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_oWVx9C/slaves/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0/frameworks/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000/executors/default/runs/b5d9f216-ccd5-4bc5-baec-febb2bf88afc'
I0228 00:23:35.437372 15493 slave.cpp:2119] Queued task 'dc88a181-4410-4cb5-9b95-3c7dd9089ae1' for executor 'default' of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.437398 15490 hierarchical.cpp:835] Updated allocation of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 on agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-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]
I0228 00:23:35.437456 15493 slave.cpp:884] Successfully attached file '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_oWVx9C/slaves/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0/frameworks/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000/executors/default/runs/b5d9f216-ccd5-4bc5-baec-febb2bf88afc'
I0228 00:23:35.439630 15484 executor.cpp:192] Version: 1.3.0
I0228 00:23:35.461802 15497 executor.cpp:401] Connected with the agent
I0228 00:23:35.462347 15495 executor.cpp:302] Sending SUBSCRIBE call to https://172.17.0.2:35116/slave(704)/api/v1/executor
I0228 00:23:35.463238 15497 process.cpp:3704] Handling HTTP event for process 'slave(704)' with path: '/slave(704)/api/v1/executor'
I0228 00:23:35.502061 15497 http.cpp:327] HTTP POST for /slave(704)/api/v1/executor from 172.17.0.2:53167
I0228 00:23:35.502295 15497 slave.cpp:3170] Received Subscribe request for HTTP executor 'default' of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.503811 15497 slave.cpp:2332] Sending queued task 'dc88a181-4410-4cb5-9b95-3c7dd9089ae1' to executor 'default' of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 (via HTTP)
I0228 00:23:35.542451 15495 executor.cpp:716] Enqueuing event SUBSCRIBED received from https://172.17.0.2:35116/slave(704)/api/v1/executor
I0228 00:23:35.543727 15486 executor.cpp:716] Enqueuing event LAUNCH received from https://172.17.0.2:35116/slave(704)/api/v1/executor
I0228 00:23:35.547145 15495 executor.cpp:302] Sending UPDATE call to https://172.17.0.2:35116/slave(704)/api/v1/executor
I0228 00:23:35.548352 15492 process.cpp:3704] Handling HTTP event for process 'slave(704)' with path: '/slave(704)/api/v1/executor'
I0228 00:23:35.586047 15493 http.cpp:327] HTTP POST for /slave(704)/api/v1/executor from 172.17.0.2:53168
I0228 00:23:35.586226 15493 slave.cpp:3817] Handling status update TASK_RUNNING (UUID: b86d758a-2569-4e09-8639-f10de6b7d175) for task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.587079 15484 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: b86d758a-2569-4e09-8639-f10de6b7d175) for task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.587146 15484 status_update_manager.cpp:500] Creating StatusUpdate stream for task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.587669 15484 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: b86d758a-2569-4e09-8639-f10de6b7d175) for task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 to the agent
I0228 00:23:35.588008 15482 slave.cpp:4257] Forwarding the update TASK_RUNNING (UUID: b86d758a-2569-4e09-8639-f10de6b7d175) for task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 to master@172.17.0.2:35116
I0228 00:23:35.588286 15482 slave.cpp:4151] Status update manager successfully handled status update TASK_RUNNING (UUID: b86d758a-2569-4e09-8639-f10de6b7d175) for task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.588492 15487 master.cpp:6201] Status update TASK_RUNNING (UUID: b86d758a-2569-4e09-8639-f10de6b7d175) for task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 from agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 at slave(704)@172.17.0.2:35116 (fc2f9ae74b77)
I0228 00:23:35.588578 15487 master.cpp:6269] Forwarding status update TASK_RUNNING (UUID: b86d758a-2569-4e09-8639-f10de6b7d175) for task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.589293 15493 executor.cpp:716] Enqueuing event ACKNOWLEDGED received from https://172.17.0.2:35116/slave(704)/api/v1/executor
I0228 00:23:35.589457 15487 master.cpp:8350] Updating the state of task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0228 00:23:35.591295 15485 scheduler.cpp:676] Enqueuing event UPDATE received from https://172.17.0.2:35116/master/api/v1/scheduler
I0228 00:23:35.592757 15489 scheduler.cpp:243] Sending TEARDOWN call to https://172.17.0.2:35116/master/api/v1/scheduler
I0228 00:23:35.593968 15495 process.cpp:3704] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0228 00:23:35.634377 15485 http.cpp:437] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:53163
I0228 00:23:35.634598 15485 master.cpp:7764] Removing framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 (default)
I0228 00:23:35.634629 15485 master.cpp:3134] Deactivating framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 (default)
I0228 00:23:35.634809 15482 hierarchical.cpp:415] Deactivated framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.634871 15485 master.cpp:8350] Updating the state of task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0228 00:23:35.634872 15492 slave.cpp:2659] Asked to shut down framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 by master@172.17.0.2:35116
I0228 00:23:35.634943 15492 slave.cpp:2684] Shutting down framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.634997 15492 slave.cpp:5084] Shutting down executor 'default' of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 (via HTTP)
I0228 00:23:35.635746 15485 master.cpp:8444] Removing task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 on agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 at slave(704)@172.17.0.2:35116 (fc2f9ae74b77)
I0228 00:23:35.635906 15483 executor.cpp:716] Enqueuing event SHUTDOWN received from https://172.17.0.2:35116/slave(704)/api/v1/executor
I0228 00:23:35.636194 15485 master.cpp:8473] Removing executor 'default' with resources {} of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 on agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 at slave(704)@172.17.0.2:35116 (fc2f9ae74b77)
I0228 00:23:35.636638 15482 hierarchical.cpp:1092] 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 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 from framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.637061 15482 hierarchical.cpp:362] Removed framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
E0228 00:23:35.638059 15484 scheduler.cpp:649] End-Of-File received from master. The master closed the event stream
I0228 00:23:35.638710 15487 scheduler.cpp:444] Re-detecting master
I0228 00:23:35.639425 15487 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0228 00:23:35.639494 15487 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0228 00:23:35.639602 15487 scheduler.cpp:470] New master detected at master@172.17.0.2:35116
I0228 00:23:35.639634 15487 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0228 00:23:35.643030 15496 slave.cpp:4770] Executor 'default' of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 exited with status 0
I0228 00:23:35.643157 15496 slave.cpp:4870] Cleaning up executor 'default' of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 (via HTTP)
W0228 00:23:35.643553 15489 master.cpp:6325] Ignoring unknown exited executor 'default' of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 on agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 at slave(704)@172.17.0.2:35116 (fc2f9ae74b77)
I0228 00:23:35.644081 15492 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_oWVx9C/slaves/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0/frameworks/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000/executors/default/runs/b5d9f216-ccd5-4bc5-baec-febb2bf88afc' for gc 6.99999255016296days in the future
I0228 00:23:35.644143 15496 slave.cpp:4958] Cleaning up framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.644289 15493 status_update_manager.cpp:285] Closing status update streams for framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.644309 15492 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_oWVx9C/slaves/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0/frameworks/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000/executors/default' for gc 6.99999254538074days in the future
I0228 00:23:35.644362 15493 status_update_manager.cpp:531] Cleaning up status update stream for task dc88a181-4410-4cb5-9b95-3c7dd9089ae1 of framework 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000
I0228 00:23:35.644373 15496 slave.cpp:803] Agent terminating
I0228 00:23:35.644495 15492 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_oWVx9C/slaves/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0/frameworks/9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000' for gc 6.99999254313778days in the future
I0228 00:23:35.644675 15484 master.cpp:1264] Agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 at slave(704)@172.17.0.2:35116 (fc2f9ae74b77) disconnected
I0228 00:23:35.644758 15484 master.cpp:3171] Disconnecting agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 at slave(704)@172.17.0.2:35116 (fc2f9ae74b77)
I0228 00:23:35.644865 15484 master.cpp:3190] Deactivating agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 at slave(704)@172.17.0.2:35116 (fc2f9ae74b77)
I0228 00:23:35.645032 15488 hierarchical.cpp:646] Agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0 deactivated
I0228 00:23:35.648264 15489 master.cpp:1103] Master terminating
I0228 00:23:35.649143 15485 hierarchical.cpp:551] Removed agent 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-S0
W0228 00:23:35.650312 32475 master.hpp:2562] Failed to close HTTP pipe for 9db164e0-fd83-4abc-9e0f-1bc0427f3dee-0000 (default)
[       OK ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/2 (777 ms)
[ RUN      ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/3
W0228 00:23:35.659993 15498 process.cpp:3029] Attempted to spawn a process (__http_connection__(1076)@172.17.0.2:35116) after finalizing libprocess!
*** Aborted at 1488241415 (unix time) try "date -d @1488241415" if you are using GNU date ***
I0228 00:23:35.662271 32475 process.cpp:1246] libprocess is initialized on 172.17.0.2:55234 with 16 worker threads
I0228 00:23:35.664372 32475 cluster.cpp:160] Creating default 'local' authorizer
I0228 00:23:35.667582 15506 master.cpp:383] Master a4c251cb-006a-400c-a3aa-e6521c8a122c (fc2f9ae74b77) started on 172.17.0.2:55234
I0228 00:23:35.667614 15506 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/wwZhXc/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="/mesos/mesos-1.3.0/_inst/share/mesos/webui" --work_dir="/tmp/wwZhXc/master" --zk_session_timeout="10secs"
I0228 00:23:35.668226 15506 master.cpp:435] Master only allowing authenticated frameworks to register
I0228 00:23:35.668241 15506 master.cpp:449] Master only allowing authenticated agents to register
I0228 00:23:35.668249 15506 master.cpp:462] Master only allowing authenticated HTTP frameworks to register
I0228 00:23:35.668270 15506 credentials.hpp:37] Loading credentials for authentication from '/tmp/wwZhXc/credentials'
I0228 00:23:35.668609 15506 master.cpp:507] Using default 'crammd5' authenticator
I0228 00:23:35.668761 15506 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0228 00:23:35.669028 15506 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0228 00:23:35.669172 15506 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0228 00:23:35.669297 15506 master.cpp:587] Authorization enabled
I0228 00:23:35.669482 15507 hierarchical.cpp:161] Initialized hierarchical allocator process
I0228 00:23:35.669513 15505 whitelist_watcher.cpp:77] No whitelist given
I0228 00:23:35.672212 15514 master.cpp:2122] Elected as the leading master!
I0228 00:23:35.672252 15514 master.cpp:1646] Recovering from registrar
I0228 00:23:35.672435 15508 registrar.cpp:329] Recovering registrar
PC: @     0x2ad8de2372fa process::PID<>::PID()
*** SIGSEGV (@0x0) received by PID 32475 (TID 0x2ad8eb86d700) from PID 0; stack trace: ***
    @     0x2ad91e8df2d7 (unknown)
I0228 00:23:35.675483 15501 registrar.cpp:362] Successfully fetched the registry (0B) in 2.977792ms
I0228 00:23:35.675619 15501 registrar.cpp:461] Applied 1 operations in 19580ns; attempting to update the registry
    @     0x2ad91e8e35b9 (unknown)
    @     0x2ad8e0908330 (unknown)
I0228 00:23:35.678985 15504 registrar.cpp:506] Successfully updated the registry in 3.286784ms
I0228 00:23:35.679169 15504 registrar.cpp:392] Successfully recovered registrar
I0228 00:23:35.679735 15510 master.cpp:1760] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0228 00:23:35.679788 15514 hierarchical.cpp:188] Skipping recovery of hierarchical allocator: nothing to recover
I0228 00:23:35.685385 32475 cluster.cpp:446] Creating default 'local' authorizer
I0228 00:23:35.686908 15512 slave.cpp:211] Mesos agent started on (705)@172.17.0.2:55234
I0228 00:23:35.687398 32475 scheduler.cpp:184] Version: 1.3.0
I0228 00:23:35.686934 15512 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_kPSHtw/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_kPSHtw/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_kPSHtw/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.3.0/_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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_kPSHtw" --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_DvauIR"
I0228 00:23:35.687655 15512 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_kPSHtw/credential'
I0228 00:23:35.687837 15512 slave.cpp:354] Agent using credential for: test-principal
I0228 00:23:35.687866 15512 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_kPSHtw/http_credentials'
I0228 00:23:35.687952 15514 scheduler.cpp:470] New master detected at master@172.17.0.2:55234
I0228 00:23:35.688194 15512 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0228 00:23:35.688355 15512 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
    @     0x2ad8de2372fa process::PID<>::PID()
I0228 00:23:35.689894 15512 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0228 00:23:35.689982 15512 slave.cpp:549] Agent attributes: [  ]
I0228 00:23:35.689996 15512 slave.cpp:554] Agent hostname: fc2f9ae74b77
I0228 00:23:35.690150 15507 status_update_manager.cpp:177] Pausing sending status updates
I0228 00:23:35.690371 15514 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0228 00:23:35.691659 15514 state.cpp:62] Recovering state from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_DvauIR/meta'
I0228 00:23:35.692328 15505 status_update_manager.cpp:203] Recovering status update manager
I0228 00:23:35.692775 15508 slave.cpp:5559] Finished recovery
I0228 00:23:35.693286 15508 slave.cpp:5733] Querying resource estimator for oversubscribable resources
I0228 00:23:35.693593 15511 status_update_manager.cpp:177] Pausing sending status updates
I0228 00:23:35.693590 15514 slave.cpp:931] New master detected at master@172.17.0.2:55234
I0228 00:23:35.693697 15514 slave.cpp:966] Detecting new master
I0228 00:23:35.693871 15514 slave.cpp:5747] Received oversubscribable resources {} from the resource estimator
    @     0x2ad8de22f025 process::Process<>::self()
    @     0x2ad8de211d7d process::ProcessManager::spawn()
    @     0x2ad8de218fee process::spawn()
    @     0x2ad8de167bcf process::spawn<>()
    @     0x2ad8de164a4f process::http::Connection::Data::Data()
    @     0x2ad8de194770 _ZN9__gnu_cxx13new_allocatorIN7process4http10Connection4DataEE9constructIS4_JRKNS1_7network8internal6SocketINS7_7AddressEEEEEEvPT_DpOT0_
    @     0x2ad8de1938ca std::allocator_traits<>::_S_construct<>()
    @     0x2ad8de191f0c _ZNSt16allocator_traitsISaIN7process4http10Connection4DataEEE9constructIS3_IRKNS0_7network8internal6SocketINS7_7AddressEEEEEEDTcl12_S_constructfp_fp0_spcl7forwardIT0_Efp1_EEERS4_PT_DpOSE_
    @     0x2ad8de18f8bf std::_Sp_counted_ptr_inplace<>::_Sp_counted_ptr_inplace<>()
    @     0x2ad8de18c0a1 __gnu_cxx::new_allocator<>::construct<>()
    @     0x2ad8de18709d std::allocator_traits<>::_S_construct<>()
    @     0x2ad8de1816f2 _ZNSt16allocator_traitsISaISt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS4_ELN9__gnu_cxx12_Lock_policyE2EEEE9constructIS8_IKS5_RKNS1_7network8internal6SocketINSD_7AddressEEEEEEDTcl12_S_constructfp_fp0_spcl7forwardIT0_Efp1_EEERS9_PT_DpOSK_
    @     0x2ad8de17bb21 _ZNSt14__shared_countILN9__gnu_cxx12_Lock_policyE2EEC2IN7process4http10Connection4DataESaIS7_EJRKNS4_7network8internal6SocketINS9_7AddressEEEEEESt19_Sp_make_shared_tagPT_RKT0_DpOT1_
    @     0x2ad8de175c7e _ZNSt12__shared_ptrIN7process4http10Connection4DataELN9__gnu_cxx12_Lock_policyE2EEC1ISaIS3_EJRKNS0_7network8internal6SocketINS9_7AddressEEEEEESt19_Sp_make_shared_tagRKT_DpOT0_
    @     0x2ad8de170f3e std::shared_ptr<>::shared_ptr<>()
    @     0x2ad8de16c8f8 _ZSt15allocate_sharedIN7process4http10Connection4DataESaIS3_EJRKNS0_7network8internal6SocketINS5_7AddressEEEEESt10shared_ptrIT_ERKT0_DpOT1_
    @     0x2ad8de167ca2 _ZSt11make_sharedIN7process4http10Connection4DataEJRKNS0_7network8internal6SocketINS4_7AddressEEEEESt10shared_ptrIT_EDpOT0_
    @     0x2ad8de125861 process::http::Connection::Connection()
    @     0x2ad8de125a36 _ZZN7process4http7connectERKNS_7network7AddressENS0_6SchemeEENKUlvE_clEv
    @     0x2ad8de139378 _ZNSt17_Function_handlerIFN7process6FutureINS0_4http10ConnectionEEEvEZNS2_7connectERKNS0_7network7AddressENS2_6SchemeEEUlvE_E9_M_invokeERKSt9_Any_data
    @     0x2ad8dd771acb std::function<>::operator()()
    @     0x2ad8dd76ba7b _ZNSt5_BindIFSt8functionIFN7process6FutureINS1_4http10ConnectionEEEvEEvEE6__callIS5_IRK7NothingEIEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE
    @     0x2ad8dd764fd3 _ZNSt5_BindIFSt8functionIFN7process6FutureINS1_4http10ConnectionEEEvEEvEEclIJRK7NothingES5_EET0_DpOT_
    @     0x2ad8dd75d046 std::_Function_handler<>::_M_invoke()
    @     0x2ad8dd771ba9 std::function<>::operator()()
    @     0x2ad8dd76bb0f process::internal::thenf<>()
    @     0x2ad8dd77c737 _ZNSt5_BindIFPFvRKSt8functionIFN7process6FutureINS1_4http10ConnectionEEERK7NothingEERKSt10shared_ptrINS1_7PromiseIS4_EEERKNS2_IS6_EEESA_SG_St12_PlaceholderILi1EEEE6__callIvJSL_EJLm0ELm1ELm2EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
    @     0x2ad8dd77827d _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.3.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.3.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.3.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.3.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1488238322-20668
Untagged: mesos-1488238322-20668:latest
Deleted: sha256:2ced65b1da36f303db9070970a43d81702d1ed14216c9405076595689f72bd48
Deleted: sha256:58d5088fb6acbf4dc2415c59b537baec677f6409dab70517daeaae43a92cac0c
Deleted: sha256:453ee5c4a45ec663c4c5e91b617a9a0f4801ca5d2e58d6d58c990756b2ead180
Deleted: sha256:62e0e96efa81e67498d76da63b4c6312f67d7989b267db2f87fddc7027eb1f2d
Deleted: sha256:4c5d05ca2d5b97b8b1d99370b07e3f7fffe21ecfc3556a7e7ccd760d1df3a611
Deleted: sha256:74eabf2ccee6677345229e69b9294d12ddfb29fc36b57dbadd3f1db08f4902f3
Deleted: sha256:af57f67303b19639e1f785562ce1191c80c85135c2eff082a3399360dc932312
Deleted: sha256:6aac3a793fd279bfe992674e3ae0c8dc381611f2e9dc052970d8c909b7185b81
Deleted: sha256:adaeaaebc25ab57bc40ade931ee37d962e2d5c284a7fb714889748325f2596be
Deleted: sha256:5a8dacfe7ede69c0d1ae7b23b4f2c56f6434971b71779864f2e325cd11f21a23
Deleted: sha256:088c0213b1746c91cfa983fb634b1417dce7aa3cc4aff82ee9d361ba3d6a9b9b
Deleted: sha256:edc2fab822c878317e40c79af4f143f762bf67e19456fc233e3ef27fdd4640c1
Deleted: sha256:7277ef705c374911cedd4b1684f89b8286a720efb3ee0606f67068372a2734aa
Deleted: sha256:29f03d017dcf6d9ec35299522ffe84692c2f658466425eb375aae7522c9610b8
Deleted: sha256:995a91da7cd450e8077aa9f29732621f9f3413550f20e5c65820f591f20e0515
Deleted: sha256:d88e6a159969fc818a6c742c003e465f45b85b2767884535b7e555ceed0e635f
Deleted: sha256:53a98dee65b4a94ccba33a817f3d696c88cefb6be291727ea9b5fef09afa3dd3
Deleted: sha256:d82fc98be37d7eb7dd9e819348c7a888daddafe7aa5468b523603d33431a9739
Deleted: sha256:35353bcafd8d1b1962958b0e51d915c454bf47549bbd81eb5ad0b74c6d3bb256
Deleted: sha256:589815a763001e29bae83f8f34e03a8d6ef7cab07e8af7b595a3855904ea8255
Deleted: sha256:10520dd6af6538bb9138d80a918effd523f90a8949b876af2afde1ec5a63fc51
Deleted: sha256:bea20a88ebca60664d174e829fddac42cd6cd9ed091cb9e8b55b0b782118448c
Deleted: sha256:9a38e515baef50bd76ef53d883fc3c461ecf0a72b04dd3deef5239c03fae73de
Deleted: sha256:a1021e25c5997211418d15787b76e75498625c5df35abcf266b6a5cb570b2b6f
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos-Buildbot » autotools,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3315

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,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)/3315/display/redirect?page=changes>