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)/3567/display/redirect>
------------------------------------------ [...truncated 27.63 MB...] I0426 18:15:40.843886 16319 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0426 18:15:40.843948 16319 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0426 18:15:40.843991 16319 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '30d44d580515' server FQDN: '30d44d580515' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0426 18:15:40.844017 16319 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0426 18:15:40.844053 16319 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0426 18:15:40.844094 16319 authenticator.cpp:318] Authentication success I0426 18:15:40.844257 16310 authenticatee.cpp:299] Authentication success I0426 18:15:40.844300 16312 master.cpp:7287] Successfully authenticated principal 'test-principal' at slave(732)@172.17.0.2:45290 I0426 18:15:40.844735 16305 slave.cpp:1075] Successfully authenticated with master [email protected]:45290 I0426 18:15:40.844981 16305 slave.cpp:1503] Will retry registration in 1.997513ms if necessary I0426 18:15:40.845208 16307 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1357)@172.17.0.2:45290 I0426 18:15:40.845240 16317 master.cpp:5447] Registering agent at slave(732)@172.17.0.2:45290 (30d44d580515) with id d2d8da94-b1fa-4406-a057-fab0614c35af-S0 I0426 18:15:40.845803 16309 registrar.cpp:493] Applied 1 operations in 122065ns; attempting to update the registry I0426 18:15:40.846207 16311 scheduler.cpp:361] Connected with the master at https://172.17.0.2:45290/master/api/v1/scheduler I0426 18:15:40.846722 16309 registrar.cpp:550] Successfully updated the registry in 825856ns I0426 18:15:40.847548 16309 slave.cpp:1503] Will retry registration in 32.515422ms if necessary I0426 18:15:40.848058 16310 scheduler.cpp:243] Sending SUBSCRIBE call to https://172.17.0.2:45290/master/api/v1/scheduler I0426 18:15:40.848081 16308 slave.cpp:4745] Received ping from slave-observer(667)@172.17.0.2:45290 I0426 18:15:40.848181 16318 master.cpp:5521] Registered agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0426 18:15:40.848336 16308 slave.cpp:1121] Registered with master [email protected]:45290; given agent ID d2d8da94-b1fa-4406-a057-fab0614c35af-S0 I0426 18:15:40.848489 16308 fetcher.cpp:94] Clearing fetcher cache I0426 18:15:40.848592 16317 hierarchical.cpp:527] Added agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 (30d44d580515) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0426 18:15:40.848740 16309 status_update_manager.cpp:184] Resuming sending status updates I0426 18:15:40.848935 16317 hierarchical.cpp:1862] No allocations performed I0426 18:15:40.848999 16317 hierarchical.cpp:1446] Performed allocation for 1 agents in 217440ns I0426 18:15:40.849020 16308 slave.cpp:1149] Checkpointing SlaveInfo to '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_GgaTmR/meta/slaves/d2d8da94-b1fa-4406-a057-fab0614c35af-S0/slave.info' I0426 18:15:40.849459 16308 slave.cpp:1187] Forwarding total oversubscribed resources {} I0426 18:15:40.849880 16318 master.cpp:5417] Agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) already registered, resending acknowledgement W0426 18:15:40.850050 16315 slave.cpp:1173] Already registered with master [email protected]:45290 I0426 18:15:40.850085 16318 master.cpp:6106] Received update of agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) with total oversubscribed resources {} I0426 18:15:40.850092 16315 slave.cpp:1187] Forwarding total oversubscribed resources {} I0426 18:15:40.850338 16318 process.cpp:3722] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0426 18:15:40.850807 16318 master.cpp:6106] Received update of agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) with total oversubscribed resources {} I0426 18:15:40.890270 16308 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40525 I0426 18:15:40.893086 16308 master.cpp:2515] Received subscription request for HTTP framework 'default' I0426 18:15:40.893134 16308 master.cpp:2199] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I0426 18:15:40.893726 16320 master.cpp:2630] Subscribing framework 'default' with checkpointing disabled and capabilities [ ] I0426 18:15:40.894733 16309 hierarchical.cpp:271] Added framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:40.894899 16306 master.hpp:2167] Sending heartbeat to d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:40.896234 16309 hierarchical.cpp:1952] No inverse offers to send out! I0426 18:15:40.896317 16309 hierarchical.cpp:1446] Performed allocation for 1 agents in 1.444827ms I0426 18:15:40.896939 16311 master.cpp:7087] Sending 1 offers to framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 (default) I0426 18:15:40.937748 16314 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from https://172.17.0.2:45290/master/api/v1/scheduler I0426 18:15:40.939713 16305 scheduler.cpp:676] Enqueuing event HEARTBEAT received from https://172.17.0.2:45290/master/api/v1/scheduler I0426 18:15:40.940609 16309 scheduler.cpp:676] Enqueuing event OFFERS received from https://172.17.0.2:45290/master/api/v1/scheduler I0426 18:15:40.943091 16311 scheduler.cpp:243] Sending ACCEPT call to https://172.17.0.2:45290/master/api/v1/scheduler I0426 18:15:40.945195 16312 process.cpp:3722] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0426 18:15:40.986162 16311 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40526 I0426 18:15:40.988625 16311 master.cpp:3853] Processing ACCEPT call for offers: [ d2d8da94-b1fa-4406-a057-fab0614c35af-O0 ] on agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) for framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 (default) I0426 18:15:40.988755 16311 master.cpp:3429] Authorizing framework principal 'test-principal' to launch task ecf95a6b-fd22-44ea-9098-d6da6feb3537 W0426 18:15:40.991559 16315 validation.cpp:1113] Executor 'default' for task 'ecf95a6b-fd22-44ea-9098-d6da6feb3537' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases. W0426 18:15:40.991613 16315 validation.cpp:1125] Executor 'default' for task 'ecf95a6b-fd22-44ea-9098-d6da6feb3537' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases. I0426 18:15:40.992138 16315 master.cpp:9102] Adding task ecf95a6b-fd22-44ea-9098-d6da6feb3537 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) I0426 18:15:40.992501 16315 master.cpp:4503] Launching task ecf95a6b-fd22-44ea-9098-d6da6feb3537 of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) I0426 18:15:40.993111 16311 slave.cpp:1613] Got assigned task 'ecf95a6b-fd22-44ea-9098-d6da6feb3537' for framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:40.993744 16311 slave.cpp:1894] Authorizing task 'ecf95a6b-fd22-44ea-9098-d6da6feb3537' for framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:40.993803 16311 slave.cpp:6582] Authorizing framework principal 'test-principal' to launch task ecf95a6b-fd22-44ea-9098-d6da6feb3537 I0426 18:15:40.994819 16310 slave.cpp:2081] Launching task 'ecf95a6b-fd22-44ea-9098-d6da6feb3537' for framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:40.995263 16313 hierarchical.cpp:852] Updated allocation of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 on agent d2d8da94-b1fa-4406-a057-fab0614c35af-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] I0426 18:15:40.996862 16310 paths.cpp:556] Trying to chown '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_GgaTmR/slaves/d2d8da94-b1fa-4406-a057-fab0614c35af-S0/frameworks/d2d8da94-b1fa-4406-a057-fab0614c35af-0000/executors/default/runs/b11d9f05-ae1a-4c05-abff-81a906b3e1cc' to user 'mesos' I0426 18:15:40.997086 16310 slave.cpp:6926] Launching executor 'default' of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 with resources {} in work directory '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_GgaTmR/slaves/d2d8da94-b1fa-4406-a057-fab0614c35af-S0/frameworks/d2d8da94-b1fa-4406-a057-fab0614c35af-0000/executors/default/runs/b11d9f05-ae1a-4c05-abff-81a906b3e1cc' I0426 18:15:40.997834 16310 slave.cpp:2310] Queued task 'ecf95a6b-fd22-44ea-9098-d6da6feb3537' for executor 'default' of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:40.997908 16310 slave.cpp:871] Successfully attached file '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_GgaTmR/slaves/d2d8da94-b1fa-4406-a057-fab0614c35af-S0/frameworks/d2d8da94-b1fa-4406-a057-fab0614c35af-0000/executors/default/runs/b11d9f05-ae1a-4c05-abff-81a906b3e1cc' I0426 18:15:41.000674 16316 executor.cpp:192] Version: 1.3.0 I0426 18:15:41.018990 16315 executor.cpp:410] Connected with the agent I0426 18:15:41.019618 16320 executor.cpp:307] Sending SUBSCRIBE call to https://172.17.0.2:45290/slave(732)/api/v1/executor I0426 18:15:41.020710 16309 process.cpp:3722] Handling HTTP event for process 'slave(732)' with path: '/slave(732)/api/v1/executor' I0426 18:15:41.058651 16319 http.cpp:1115] HTTP POST for /slave(732)/api/v1/executor from 172.17.0.2:40527 I0426 18:15:41.058898 16319 slave.cpp:3568] Received Subscribe request for HTTP executor 'default' of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:41.060211 16319 slave.cpp:2523] Sending queued task 'ecf95a6b-fd22-44ea-9098-d6da6feb3537' to executor 'default' of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 (via HTTP) I0426 18:15:41.097856 16308 executor.cpp:725] Enqueuing event SUBSCRIBED received from https://172.17.0.2:45290/slave(732)/api/v1/executor I0426 18:15:41.098773 16305 executor.cpp:725] Enqueuing event LAUNCH received from https://172.17.0.2:45290/slave(732)/api/v1/executor I0426 18:15:41.101217 16309 executor.cpp:307] Sending UPDATE call to https://172.17.0.2:45290/slave(732)/api/v1/executor I0426 18:15:41.102274 16314 process.cpp:3722] Handling HTTP event for process 'slave(732)' with path: '/slave(732)/api/v1/executor' I0426 18:15:41.142889 16312 http.cpp:1115] HTTP POST for /slave(732)/api/v1/executor from 172.17.0.2:40528 I0426 18:15:41.143162 16312 slave.cpp:4215] Handling status update TASK_RUNNING (UUID: 0d610d47-549b-4460-b0c5-ffb3fdffac19) for task ecf95a6b-fd22-44ea-9098-d6da6feb3537 of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:41.143930 16307 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 0d610d47-549b-4460-b0c5-ffb3fdffac19) for task ecf95a6b-fd22-44ea-9098-d6da6feb3537 of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:41.143981 16307 status_update_manager.cpp:500] Creating StatusUpdate stream for task ecf95a6b-fd22-44ea-9098-d6da6feb3537 of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:41.144598 16307 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 0d610d47-549b-4460-b0c5-ffb3fdffac19) for task ecf95a6b-fd22-44ea-9098-d6da6feb3537 of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 to the agent I0426 18:15:41.144911 16318 slave.cpp:4655] Forwarding the update TASK_RUNNING (UUID: 0d610d47-549b-4460-b0c5-ffb3fdffac19) for task ecf95a6b-fd22-44ea-9098-d6da6feb3537 of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 to [email protected]:45290 I0426 18:15:41.145110 16318 slave.cpp:4549] Status update manager successfully handled status update TASK_RUNNING (UUID: 0d610d47-549b-4460-b0c5-ffb3fdffac19) for task ecf95a6b-fd22-44ea-9098-d6da6feb3537 of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:41.145257 16317 master.cpp:6251] Status update TASK_RUNNING (UUID: 0d610d47-549b-4460-b0c5-ffb3fdffac19) for task ecf95a6b-fd22-44ea-9098-d6da6feb3537 of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 from agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) I0426 18:15:41.145323 16317 master.cpp:6319] Forwarding status update TASK_RUNNING (UUID: 0d610d47-549b-4460-b0c5-ffb3fdffac19) for task ecf95a6b-fd22-44ea-9098-d6da6feb3537 of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:41.146021 16317 master.cpp:8350] Updating the state of task ecf95a6b-fd22-44ea-9098-d6da6feb3537 of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) I0426 18:15:41.146488 16310 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from https://172.17.0.2:45290/slave(732)/api/v1/executor I0426 18:15:41.147670 16316 scheduler.cpp:676] Enqueuing event UPDATE received from https://172.17.0.2:45290/master/api/v1/scheduler I0426 18:15:41.149387 16320 scheduler.cpp:243] Sending TEARDOWN call to https://172.17.0.2:45290/master/api/v1/scheduler I0426 18:15:41.150740 16305 process.cpp:3722] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0426 18:15:41.189905 16315 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40526 I0426 18:15:41.190176 16315 master.cpp:7782] Removing framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 (default) I0426 18:15:41.190207 16315 master.cpp:3162] Deactivating framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 (default) I0426 18:15:41.190372 16314 hierarchical.cpp:376] Deactivated framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:41.190425 16305 slave.cpp:3057] Asked to shut down framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 by [email protected]:45290 I0426 18:15:41.190471 16305 slave.cpp:3082] Shutting down framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:41.190500 16315 master.cpp:8350] Updating the state of task ecf95a6b-fd22-44ea-9098-d6da6feb3537 of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0426 18:15:41.190546 16305 slave.cpp:5475] Shutting down executor 'default' of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 (via HTTP) I0426 18:15:41.191237 16315 master.cpp:8444] Removing task ecf95a6b-fd22-44ea-9098-d6da6feb3537 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 on agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) I0426 18:15:41.191429 16318 executor.cpp:725] Enqueuing event SHUTDOWN received from https://172.17.0.2:45290/slave(732)/api/v1/executor I0426 18:15:41.191673 16315 master.cpp:8473] Removing executor 'default' with resources {} of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 on agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) I0426 18:15:41.191931 16307 hierarchical.cpp:1116] 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 d2d8da94-b1fa-4406-a057-fab0614c35af-S0 from framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:41.192252 16307 hierarchical.cpp:323] Removed framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 E0426 18:15:41.192816 16310 scheduler.cpp:649] End-Of-File received from master. The master closed the event stream I0426 18:15:41.193223 16312 scheduler.cpp:444] Re-detecting master I0426 18:15:41.193668 16312 scheduler.cpp:395] Ignoring disconnection attempt from stale connection I0426 18:15:41.193755 16312 scheduler.cpp:395] Ignoring disconnection attempt from stale connection I0426 18:15:41.194026 16312 scheduler.cpp:470] New master detected at [email protected]:45290 I0426 18:15:41.195633 16312 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master I0426 18:15:41.198410 16310 slave.cpp:5161] Executor 'default' of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 exited with status 0 I0426 18:15:41.198565 16310 slave.cpp:5261] Cleaning up executor 'default' of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 (via HTTP) W0426 18:15:41.198719 16316 master.cpp:6374] Ignoring unknown exited executor 'default' of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 on agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) I0426 18:15:41.198832 16308 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_GgaTmR/slaves/d2d8da94-b1fa-4406-a057-fab0614c35af-S0/frameworks/d2d8da94-b1fa-4406-a057-fab0614c35af-0000/executors/default/runs/b11d9f05-ae1a-4c05-abff-81a906b3e1cc' for gc 6.99999769998815days in the future I0426 18:15:41.199033 16310 slave.cpp:5349] Cleaning up framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:41.199035 16306 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_GgaTmR/slaves/d2d8da94-b1fa-4406-a057-fab0614c35af-S0/frameworks/d2d8da94-b1fa-4406-a057-fab0614c35af-0000/executors/default' for gc 6.99999769759407days in the future I0426 18:15:41.199139 16320 status_update_manager.cpp:285] Closing status update streams for framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:41.199271 16320 status_update_manager.cpp:531] Cleaning up status update stream for task ecf95a6b-fd22-44ea-9098-d6da6feb3537 of framework d2d8da94-b1fa-4406-a057-fab0614c35af-0000 I0426 18:15:41.199429 16305 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_GgaTmR/slaves/d2d8da94-b1fa-4406-a057-fab0614c35af-S0/frameworks/d2d8da94-b1fa-4406-a057-fab0614c35af-0000' for gc 6.99999769481482days in the future I0426 18:15:41.199462 16310 slave.cpp:790] Agent terminating I0426 18:15:41.199664 16319 master.cpp:1315] Agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) disconnected I0426 18:15:41.199694 16319 master.cpp:3199] Disconnecting agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) I0426 18:15:41.199756 16319 master.cpp:3218] Deactivating agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 at slave(732)@172.17.0.2:45290 (30d44d580515) I0426 18:15:41.199852 16313 hierarchical.cpp:655] Agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 deactivated I0426 18:15:41.202664 16309 master.cpp:1157] Master terminating I0426 18:15:41.203271 16312 hierarchical.cpp:560] Removed agent d2d8da94-b1fa-4406-a057-fab0614c35af-S0 W0426 18:15:41.205003 31324 master.hpp:2650] Failed to close HTTP pipe for d2d8da94-b1fa-4406-a057-fab0614c35af-0000 (default) [ OK ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/2 (1063 ms) [ RUN ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/3 W0426 18:15:41.215677 16321 process.cpp:3047] Attempted to spawn a process (__http_connection__(1152)@172.17.0.2:45290) after finalizing libprocess! *** Aborted at 1493230541 (unix time) try "date -d @1493230541" if you are using GNU date *** I0426 18:15:41.218628 31324 process.cpp:1264] libprocess is initialized on 172.17.0.2:44905 with 16 worker threads I0426 18:15:41.220950 31324 cluster.cpp:162] Creating default 'local' authorizer I0426 18:15:41.224297 16330 master.cpp:438] Master d6342227-279e-4502-83b0-15044250fd64 (30d44d580515) started on 172.17.0.2:44905 I0426 18:15:41.224354 16330 master.cpp:440] 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/29bCrL/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.3.0/_inst/share/mesos/webui" --work_dir="/tmp/29bCrL/master" --zk_session_timeout="10secs" I0426 18:15:41.224771 16330 master.cpp:490] Master only allowing authenticated frameworks to register I0426 18:15:41.224848 16330 master.cpp:504] Master only allowing authenticated agents to register I0426 18:15:41.224905 16330 master.cpp:517] Master only allowing authenticated HTTP frameworks to register I0426 18:15:41.224951 16330 credentials.hpp:37] Loading credentials for authentication from '/tmp/29bCrL/credentials' I0426 18:15:41.225281 16330 master.cpp:562] Using default 'crammd5' authenticator I0426 18:15:41.225458 16330 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0426 18:15:41.225666 16330 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0426 18:15:41.225852 16330 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0426 18:15:41.226047 16330 master.cpp:642] Authorization enabled I0426 18:15:41.226212 16322 hierarchical.cpp:159] Initialized hierarchical allocator process I0426 18:15:41.226243 16331 whitelist_watcher.cpp:77] No whitelist given I0426 18:15:41.229904 16331 master.cpp:2163] Elected as the leading master! I0426 18:15:41.229933 16331 master.cpp:1702] Recovering from registrar I0426 18:15:41.230139 16323 registrar.cpp:345] Recovering registrar I0426 18:15:41.233036 16325 registrar.cpp:389] Successfully fetched the registry (0B) in 2.793984ms I0426 18:15:41.233206 16325 registrar.cpp:493] Applied 1 operations in 52304ns; attempting to update the registry PC: @ 0x2ac088ffc0b8 process::PID<>::PID() *** SIGSEGV (@0x0) received by PID 31324 (TID 0x2ac0968bc700) from PID 0; stack trace: *** @ 0x2ac0d59a62d7 (unknown) @ 0x2ac0d59aa5b9 (unknown) @ 0x2ac08b977330 (unknown) I0426 18:15:41.236215 16325 registrar.cpp:550] Successfully updated the registry in 2.934016ms I0426 18:15:41.236358 16325 registrar.cpp:422] Successfully recovered registrar I0426 18:15:41.237092 16324 hierarchical.cpp:186] Skipping recovery of hierarchical allocator: nothing to recover I0426 18:15:41.237092 16335 master.cpp:1801] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0426 18:15:41.241683 31324 cluster.cpp:448] Creating default 'local' authorizer I0426 18:15:41.243340 16325 slave.cpp:225] Mesos agent started on (733)@172.17.0.2:44905 I0426 18:15:41.243957 31324 scheduler.cpp:184] Version: 1.3.0 I0426 18:15:41.243399 16325 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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QVlE7J/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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QVlE7J/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QVlE7J/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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QVlE7J/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" --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_QVlE7J" --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_oFECMK" I0426 18:15:41.244182 16325 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QVlE7J/credential' I0426 18:15:41.244443 16325 slave.cpp:258] Agent using credential for: test-principal I0426 18:15:41.244626 16325 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QVlE7J/http_credentials' I0426 18:15:41.244796 16337 scheduler.cpp:470] New master detected at [email protected]:44905 I0426 18:15:41.245163 16325 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor' I0426 18:15:41.245314 16325 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor' I0426 18:15:41.245643 16325 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0426 18:15:41.245781 16325 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly' I0426 18:15:41.246196 16325 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0426 18:15:41.246325 16325 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite' I0426 18:15:41.247452 16337 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master I0426 18:15:41.248397 16325 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0426 18:15:41.248499 16325 slave.cpp:533] Agent attributes: [ ] I0426 18:15:41.248515 16325 slave.cpp:538] Agent hostname: 30d44d580515 I0426 18:15:41.248677 16332 status_update_manager.cpp:177] Pausing sending status updates @ 0x2ac088ffc0b8 process::PID<>::PID() I0426 18:15:41.250031 16329 state.cpp:62] Recovering state from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_oFECMK/meta' I0426 18:15:41.250355 16323 status_update_manager.cpp:203] Recovering status update manager I0426 18:15:41.250818 16336 slave.cpp:5963] Finished recovery I0426 18:15:41.251261 16336 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0426 18:15:41.251483 16334 status_update_manager.cpp:177] Pausing sending status updates I0426 18:15:41.251485 16336 slave.cpp:918] New master detected at [email protected]:44905 I0426 18:15:41.251574 16336 slave.cpp:953] Detecting new master I0426 18:15:41.251720 16336 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator @ 0x2ac088fd938c process::Process<>::self() @ 0x2ac088fbeeac process::ProcessManager::spawn() @ 0x2ac088fc5686 process::spawn() @ 0x2ac088efb0cc process::spawn<>() @ 0x2ac088efb01b process::http::Connection::Data::Data() @ 0x2ac088efafb6 _ZN9__gnu_cxx13new_allocatorIN7process4http10Connection4DataEE9constructIS4_JRKNS1_7network8internal6SocketINS7_7AddressEEEEEEvPT_DpOT0_ @ 0x2ac088efaf5d _ZNSt16allocator_traitsISaIN7process4http10Connection4DataEEE12_S_constructIS3_JRKNS0_7network8internal6SocketINS7_7AddressEEEEEENSt9enable_ifIXsr18__construct_helperIT_DpT0_EE5valueEvE4typeERS4_PSF_DpOSG_ @ 0x2ac088efabb0 _ZNSt16allocator_traitsISaIN7process4http10Connection4DataEEE9constructIS3_JRKNS0_7network8internal6SocketINS7_7AddressEEEEEEDTcl12_S_constructfp_fp0_spclsr3stdE7forwardIT0_Efp1_EEERS4_PT_DpOSE_ @ 0x2ac088efaada _ZNSt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS3_ELN9__gnu_cxx12_Lock_policyE2EEC2IJRKNS0_7network8internal6SocketINS9_7AddressEEEEEES4_DpOT_ @ 0x2ac088efa98b _ZN9__gnu_cxx13new_allocatorISt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS5_ELNS_12_Lock_policyE2EEE9constructIS8_JKS6_RKNS2_7network8internal6SocketINSC_7AddressEEEEEEvPT_DpOT0_ @ 0x2ac088efa8f2 _ZNSt16allocator_traitsISaISt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS4_ELN9__gnu_cxx12_Lock_policyE2EEEE12_S_constructIS8_JKS5_RKNS1_7network8internal6SocketINSD_7AddressEEEEEENSt9enable_ifIXsr18__construct_helperIT_DpT0_EE5valueEvE4typeERS9_PSL_DpOSM_ @ 0x2ac088efa7e5 _ZNSt16allocator_traitsISaISt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS4_ELN9__gnu_cxx12_Lock_policyE2EEEE9constructIS8_JKS5_RKNS1_7network8internal6SocketINSD_7AddressEEEEEEDTcl12_S_constructfp_fp0_spclsr3stdE7forwardIT0_Efp1_EEERS9_PT_DpOSK_ @ 0x2ac088efa658 _ZNSt14__shared_countILN9__gnu_cxx12_Lock_policyE2EEC2IN7process4http10Connection4DataESaIS7_EJRKNS4_7network8internal6SocketINS9_7AddressEEEEEESt19_Sp_make_shared_tagPT_RKT0_DpOT1_ @ 0x2ac088efa56f _ZNSt12__shared_ptrIN7process4http10Connection4DataELN9__gnu_cxx12_Lock_policyE2EEC2ISaIS3_EJRKNS0_7network8internal6SocketINS9_7AddressEEEEEESt19_Sp_make_shared_tagRKT_DpOT0_ @ 0x2ac088efa4fd _ZNSt10shared_ptrIN7process4http10Connection4DataEEC2ISaIS3_EJRKNS0_7network8internal6SocketINS7_7AddressEEEEEESt19_Sp_make_shared_tagRKT_DpOT0_ @ 0x2ac088efa43f _ZSt15allocate_sharedIN7process4http10Connection4DataESaIS3_EJRKNS0_7network8internal6SocketINS5_7AddressEEEEESt10shared_ptrIT_ERKT0_DpOT1_ @ 0x2ac088ed48ad _ZSt11make_sharedIN7process4http10Connection4DataEJRKNS0_7network8internal6SocketINS4_7AddressEEEEESt10shared_ptrIT_EDpOT0_ @ 0x2ac088e8dd5d process::http::Connection::Connection() @ 0x2ac088ec296f process::http::connect()::$_1::operator()() @ 0x2ac088ec26ef std::_Function_handler<>::_M_invoke() @ 0x2ac088201bdd std::function<>::operator()() @ 0x2ac088201b80 _ZNSt5_BindIFSt8functionIFN7process6FutureINS1_4http10ConnectionEEEvEEvEE6__callIS5_JRK7NothingEJEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE @ 0x2ac088201b35 _ZNSt5_BindIFSt8functionIFN7process6FutureINS1_4http10ConnectionEEEvEEvEEclIJRK7NothingES5_EET0_DpOT_ @ 0x2ac0882017d4 std::_Function_handler<>::_M_invoke() @ 0x2ac08820384a std::function<>::operator()() @ 0x2ac088202411 process::internal::thenf<>() @ 0x2ac0882030e3 _ZNSt5_BindIFPFvRKSt8functionIFN7process6FutureINS1_4http10ConnectionEEERK7NothingEERKSt10shared_ptrINS1_7PromiseIS4_EEERKNS2_IS6_EEESA_SG_St12_PlaceholderILi1EEEE6__callIvJSL_EJLm0ELm1ELm2EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE @ 0x2ac088203026 _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-1493227891-7171 Untagged: mesos-1493227891-7171:latest Deleted: sha256:f9ef7e525d9862e4f870df3b12d22b805207e9dbc42b2640067a1568b0b2dd78 Deleted: sha256:aa4feb1dfda6e2931393fb9b004ec20ee93c99aaecf45a0107ad547db79bb817 Deleted: sha256:7ab06a4896dbf71eac23b4bfbf2bace2493ea77f8a8f6a149871eac816d3a070 Deleted: sha256:fab189fbad0c913dae559fe378a026e041514f2ed3c8aebb1ca25700cdf7421b Deleted: sha256:6e671af40dc6b98cd102ad93a4ea4ce9e820ad3f1a2821ee79c0ce45ce1d65c1 Deleted: sha256:068a3dfb2a138c5b392e11c0a31b19130ce9572debca828cb6e0b24cd254ee68 Deleted: sha256:30105689f86ad2eb2ef745ed0780ee50bf0c18d003d353c149b9687bd0768c44 Deleted: sha256:1c54802da89f3f6b71b849576ef325845567278b0859e7b86aff4e8587bf210a Deleted: sha256:f51798843fdcdb180654ec860b72f300e57fc3638c65d95be7d2b63699cd6502 Deleted: sha256:3609a8cdace094c589681ba326a06dedf66836b8975cc39d61f46803e705944c Deleted: sha256:e7e3ec14b3f1315708450e915f43ac6de795f5e4ea7339ac5f819fb027d8f5ba Deleted: sha256:9b5df462f34c02176e3ef66650118fd073d16f6f1c4c4246ce8543ddd44e160a Deleted: sha256:f0986578903d02929c9c551032748f8eaa3d3a7f92ee1cfe1fbd45ce7bbf8755 Deleted: sha256:265928cab9021821cbb54753a9f75b0440a814a163dd01671eeaf81c00fac11d Deleted: sha256:f5c27ead8630052cd3a0b8095d826fb815f39d614cc4af8c35aa941e0932ba9b Deleted: sha256:bc91480b95d1474e665eb5c43f48da727fa34ba62c84717c31cb34a43c81e453 Deleted: sha256:2670b07c6dc6870655c1fabb488da39a1e47893d6e1ea3cc45ed5ba282095b15 Deleted: sha256:e2b1240e001b098567f908b346be01cfb44ed7dd88d48f3fc42ba4c4d1962be8 Deleted: sha256:173e91b5aee524c4fb3810427bf0e4550f84ce6af3c493dddee9eb610735f1fe Deleted: sha256:26a8f208a98bf76e9431a8eb6c6597bc80f3fbfc06df8d81d355a4faceb43ced Deleted: sha256:7b4d25dfca36ab23be1f3b34e98891139c6d084bfad113fd4605c69dbb1f0da4 Deleted: sha256:4b917a1168669a431b2970902c45b0aecf0834e9d8e634a3042b0edf9d0af166 Deleted: sha256:041870037833136714bf7df953e671ef6583e2ec9a215453391871a00d559432 Deleted: sha256:f6780752d9146fb1aba4ae38a6f5b5be769634b682de737acaeaebe3c0586a0e Build step 'Execute shell' marked build as failure
