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/08/16 01:42:34 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4116
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4116/display/redirect?page=changes>
Changes:
[anand] Added the field `signal` to the `KillNestedContainer` call.
[anand] Added the `kill()` function to the containerizer interface.
[anand] Added `kill()` call to the composing containerizer.
[anand] Made `killNestedContainer()` use `kill()` on the containerizer.
[anand] Made the default executor support signal escalation.
[anand] Added support for kill policies to the default executor.
[anand] Added `kill()` support to the test containerizer interface.
------------------------------------------
[...truncated 27.71 MB...]
I0816 01:42:26.526839 6611 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0816 01:42:26.526844 6611 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0816 01:42:26.526855 6611 authenticator.cpp:318] Authentication success
I0816 01:42:26.526926 6618 authenticatee.cpp:299] Authentication success
I0816 01:42:26.527017 6618 master.cpp:7867] Successfully authenticated principal 'test-principal' at slave(743)@172.17.0.2:43082
I0816 01:42:26.527078 6611 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1362)@172.17.0.2:43082
I0816 01:42:26.527257 6616 slave.cpp:1128] Successfully authenticated with master master@172.17.0.2:43082
I0816 01:42:26.527493 6616 slave.cpp:1572] Will retry registration in 16.908745ms if necessary
I0816 01:42:26.527662 6615 master.cpp:5712] Received register agent message from slave(743)@172.17.0.2:43082 (f7cdd33077cc)
I0816 01:42:26.527782 6615 master.cpp:3803] Authorizing agent with principal 'test-principal'
I0816 01:42:26.528251 6621 master.cpp:5772] Authorized registration of agent at slave(743)@172.17.0.2:43082 (f7cdd33077cc)
I0816 01:42:26.528342 6621 master.cpp:5865] Registering agent at slave(743)@172.17.0.2:43082 (f7cdd33077cc) with id 2274f542-cd47-4c19-aa89-75e95be229f2-S0
I0816 01:42:26.528738 6608 registrar.cpp:495] Applied 1 operations in 61018ns; attempting to update the registry
I0816 01:42:26.530308 6612 scheduler.cpp:361] Connected with the master at https://172.17.0.2:43082/master/api/v1/scheduler
I0816 01:42:26.530911 6608 registrar.cpp:552] Successfully updated the registry in 2.100992ms
I0816 01:42:26.531157 6623 master.cpp:5912] Admitted agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc)
I0816 01:42:26.531579 6611 scheduler.cpp:243] Sending SUBSCRIBE call to https://172.17.0.2:43082/master/api/v1/scheduler
I0816 01:42:26.531759 6615 slave.cpp:4887] Received ping from slave-observer(673)@172.17.0.2:43082
I0816 01:42:26.531926 6615 slave.cpp:1174] Registered with master master@172.17.0.2:43082; given agent ID 2274f542-cd47-4c19-aa89-75e95be229f2-S0
I0816 01:42:26.531740 6623 master.cpp:5943] Registered agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0816 01:42:26.532047 6611 status_update_manager.cpp:184] Resuming sending status updates
I0816 01:42:26.532075 6610 hierarchical.cpp:593] Added agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 (f7cdd33077cc) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0816 01:42:26.532306 6610 hierarchical.cpp:1943] No allocations performed
I0816 01:42:26.532310 6615 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_fIlJs8/meta/slaves/2274f542-cd47-4c19-aa89-75e95be229f2-S0/slave.info'
I0816 01:42:26.532363 6610 hierarchical.cpp:1486] Performed allocation for 1 agents in 156434ns
I0816 01:42:26.532699 6615 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0816 01:42:26.532841 6614 master.cpp:6688] Received update of agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc) with total oversubscribed resources {}
I0816 01:42:26.533077 6613 hierarchical.cpp:660] Agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 (f7cdd33077cc) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0816 01:42:26.533306 6616 process.cpp:3933] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0816 01:42:26.573623 6610 http.cpp:1166] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:45643
I0816 01:42:26.575650 6610 master.cpp:2545] Received subscription request for HTTP framework 'default'
I0816 01:42:26.575762 6610 master.cpp:2228] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0816 01:42:26.576431 6614 master.cpp:2681] Subscribing framework 'default' with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I0816 01:42:26.577235 6611 master.hpp:2217] Sending heartbeat to 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.577277 6613 hierarchical.cpp:303] Added framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.578610 6613 hierarchical.cpp:2033] No inverse offers to send out!
I0816 01:42:26.578665 6613 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.213071ms
I0816 01:42:26.579195 6610 master.cpp:7667] Sending 1 offers to framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 (default)
I0816 01:42:26.617272 6620 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from https://172.17.0.2:43082/master/api/v1/scheduler
I0816 01:42:26.619038 6616 scheduler.cpp:676] Enqueuing event HEARTBEAT received from https://172.17.0.2:43082/master/api/v1/scheduler
I0816 01:42:26.619825 6622 scheduler.cpp:676] Enqueuing event OFFERS received from https://172.17.0.2:43082/master/api/v1/scheduler
I0816 01:42:26.621978 6620 scheduler.cpp:243] Sending ACCEPT call to https://172.17.0.2:43082/master/api/v1/scheduler
I0816 01:42:26.624686 6622 process.cpp:3933] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0816 01:42:26.661473 6610 http.cpp:1166] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:45642
I0816 01:42:26.663998 6610 master.cpp:9164] Removing offer 2274f542-cd47-4c19-aa89-75e95be229f2-O0
I0816 01:42:26.664216 6610 master.cpp:4153] Processing ACCEPT call for offers: [ 2274f542-cd47-4c19-aa89-75e95be229f2-O0 ] on agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc) for framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 (default)
I0816 01:42:26.664345 6610 master.cpp:3530] Authorizing framework principal 'test-principal' to launch task e8c6361b-3421-449b-b2b6-37c4a15cb92b
W0816 01:42:26.666574 6623 validation.cpp:1294] Executor 'default' for task 'e8c6361b-3421-449b-b2b6-37c4a15cb92b' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0816 01:42:26.666623 6623 validation.cpp:1306] Executor 'default' for task 'e8c6361b-3421-449b-b2b6-37c4a15cb92b' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0816 01:42:26.667107 6623 master.cpp:9724] Adding task e8c6361b-3421-449b-b2b6-37c4a15cb92b with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc)
I0816 01:42:26.667647 6623 master.cpp:4816] Launching task e8c6361b-3421-449b-b2b6-37c4a15cb92b of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 (default) with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc)
I0816 01:42:26.668287 6621 slave.cpp:1701] Got assigned task 'e8c6361b-3421-449b-b2b6-37c4a15cb92b' for framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.669025 6621 slave.cpp:1982] Authorizing task 'e8c6361b-3421-449b-b2b6-37c4a15cb92b' for framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.669082 6621 slave.cpp:6709] Authorizing framework principal 'test-principal' to launch task e8c6361b-3421-449b-b2b6-37c4a15cb92b
I0816 01:42:26.669385 6623 hierarchical.cpp:887] Updated allocation of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 on agent 2274f542-cd47-4c19-aa89-75e95be229f2-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]
I0816 01:42:26.669973 6616 slave.cpp:2169] Launching task 'e8c6361b-3421-449b-b2b6-37c4a15cb92b' for framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.670698 6616 paths.cpp:578] Trying to chown '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_fIlJs8/slaves/2274f542-cd47-4c19-aa89-75e95be229f2-S0/frameworks/2274f542-cd47-4c19-aa89-75e95be229f2-0000/executors/default/runs/77ec0948-d4b5-4f4a-8e19-155ffa8ee10b' to user 'mesos'
I0816 01:42:26.670960 6616 slave.cpp:7165] Launching executor 'default' of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 with resources [] in work directory '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_fIlJs8/slaves/2274f542-cd47-4c19-aa89-75e95be229f2-S0/frameworks/2274f542-cd47-4c19-aa89-75e95be229f2-0000/executors/default/runs/77ec0948-d4b5-4f4a-8e19-155ffa8ee10b'
I0816 01:42:26.671906 6616 slave.cpp:2398] Queued task 'e8c6361b-3421-449b-b2b6-37c4a15cb92b' for executor 'default' of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.672006 6616 slave.cpp:924] Successfully attached file '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_fIlJs8/slaves/2274f542-cd47-4c19-aa89-75e95be229f2-S0/frameworks/2274f542-cd47-4c19-aa89-75e95be229f2-0000/executors/default/runs/77ec0948-d4b5-4f4a-8e19-155ffa8ee10b'
I0816 01:42:26.672086 6616 slave.cpp:924] Successfully attached file '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_fIlJs8/slaves/2274f542-cd47-4c19-aa89-75e95be229f2-S0/frameworks/2274f542-cd47-4c19-aa89-75e95be229f2-0000/executors/default/runs/77ec0948-d4b5-4f4a-8e19-155ffa8ee10b'
I0816 01:42:26.672407 6616 slave.cpp:2856] Launching container 77ec0948-d4b5-4f4a-8e19-155ffa8ee10b for executor 'default' of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.676367 6609 executor.cpp:192] Version: 1.4.0
I0816 01:42:26.697729 6611 executor.cpp:410] Connected with the agent
I0816 01:42:26.698400 6620 executor.cpp:307] Sending SUBSCRIBE call to https://172.17.0.2:43082/slave(743)/api/v1/executor
I0816 01:42:26.699475 6618 process.cpp:3933] Handling HTTP event for process 'slave(743)' with path: '/slave(743)/api/v1/executor'
I0816 01:42:26.739447 6612 http.cpp:1166] HTTP POST for /slave(743)/api/v1/executor from 172.17.0.2:45644
I0816 01:42:26.739718 6612 slave.cpp:3673] Received Subscribe request for HTTP executor 'default' of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.740991 6612 slave.cpp:2603] Sending queued task 'e8c6361b-3421-449b-b2b6-37c4a15cb92b' to executor 'default' of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 (via HTTP)
I0816 01:42:26.781436 6611 executor.cpp:725] Enqueuing event SUBSCRIBED received from https://172.17.0.2:43082/slave(743)/api/v1/executor
I0816 01:42:26.782114 6611 executor.cpp:725] Enqueuing event LAUNCH received from https://172.17.0.2:43082/slave(743)/api/v1/executor
I0816 01:42:26.782974 6616 executor.cpp:307] Sending UPDATE call to https://172.17.0.2:43082/slave(743)/api/v1/executor
I0816 01:42:26.784356 6623 process.cpp:3933] Handling HTTP event for process 'slave(743)' with path: '/slave(743)/api/v1/executor'
I0816 01:42:26.823106 6616 http.cpp:1166] HTTP POST for /slave(743)/api/v1/executor from 172.17.0.2:45645
I0816 01:42:26.823268 6616 slave.cpp:4345] Handling status update TASK_RUNNING (UUID: 5fdaa94a-8ad8-416a-a76f-2862e20b3c95) for task e8c6361b-3421-449b-b2b6-37c4a15cb92b of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.824075 6616 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 5fdaa94a-8ad8-416a-a76f-2862e20b3c95) for task e8c6361b-3421-449b-b2b6-37c4a15cb92b of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.824132 6616 status_update_manager.cpp:500] Creating StatusUpdate stream for task e8c6361b-3421-449b-b2b6-37c4a15cb92b of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.824663 6616 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 5fdaa94a-8ad8-416a-a76f-2862e20b3c95) for task e8c6361b-3421-449b-b2b6-37c4a15cb92b of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 to the agent
I0816 01:42:26.825008 6622 slave.cpp:4797] Forwarding the update TASK_RUNNING (UUID: 5fdaa94a-8ad8-416a-a76f-2862e20b3c95) for task e8c6361b-3421-449b-b2b6-37c4a15cb92b of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 to master@172.17.0.2:43082
I0816 01:42:26.825248 6622 slave.cpp:4691] Status update manager successfully handled status update TASK_RUNNING (UUID: 5fdaa94a-8ad8-416a-a76f-2862e20b3c95) for task e8c6361b-3421-449b-b2b6-37c4a15cb92b of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.825474 6615 master.cpp:6846] Status update TASK_RUNNING (UUID: 5fdaa94a-8ad8-416a-a76f-2862e20b3c95) for task e8c6361b-3421-449b-b2b6-37c4a15cb92b of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 from agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc)
I0816 01:42:26.825526 6615 master.cpp:6908] Forwarding status update TASK_RUNNING (UUID: 5fdaa94a-8ad8-416a-a76f-2862e20b3c95) for task e8c6361b-3421-449b-b2b6-37c4a15cb92b of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.826191 6615 master.cpp:8933] Updating the state of task e8c6361b-3421-449b-b2b6-37c4a15cb92b of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0816 01:42:26.826225 6611 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from https://172.17.0.2:43082/slave(743)/api/v1/executor
I0816 01:42:26.827606 6615 scheduler.cpp:676] Enqueuing event UPDATE received from https://172.17.0.2:43082/master/api/v1/scheduler
I0816 01:42:26.828955 6620 scheduler.cpp:243] Sending TEARDOWN call to https://172.17.0.2:43082/master/api/v1/scheduler
I0816 01:42:26.830271 6609 process.cpp:3933] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0816 01:42:26.869642 6610 http.cpp:1166] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:45642
I0816 01:42:26.869828 6610 master.cpp:8360] Removing framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 (default)
I0816 01:42:26.869856 6610 master.cpp:3264] Deactivating framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 (default)
I0816 01:42:26.870020 6613 hierarchical.cpp:412] Deactivated framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.870098 6610 master.cpp:8933] Updating the state of task e8c6361b-3421-449b-b2b6-37c4a15cb92b of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0816 01:42:26.870126 6613 slave.cpp:3159] Asked to shut down framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 by master@172.17.0.2:43082
I0816 01:42:26.870170 6613 slave.cpp:3184] Shutting down framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.870223 6613 slave.cpp:5651] Shutting down executor 'default' of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 (via HTTP)
I0816 01:42:26.871109 6621 executor.cpp:725] Enqueuing event SHUTDOWN received from https://172.17.0.2:43082/slave(743)/api/v1/executor
I0816 01:42:26.870977 6610 master.cpp:9027] Removing task e8c6361b-3421-449b-b2b6-37c4a15cb92b with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 on agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc)
I0816 01:42:26.871574 6623 hierarchical.cpp:1161] 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 2274f542-cd47-4c19-aa89-75e95be229f2-S0 from framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.871652 6610 master.cpp:9056] Removing executor 'default' with resources [] of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 on agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc)
I0816 01:42:26.873178 6611 hierarchical.cpp:355] Removed framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
E0816 01:42:26.874140 6623 scheduler.cpp:649] End-Of-File received from master. The master closed the event stream
I0816 01:42:26.875098 6612 scheduler.cpp:444] Re-detecting master
I0816 01:42:26.875807 6612 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0816 01:42:26.875880 6612 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0816 01:42:26.876282 6612 scheduler.cpp:470] New master detected at master@172.17.0.2:43082
I0816 01:42:26.876328 6612 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0816 01:42:26.880707 6610 slave.cpp:5329] Executor 'default' of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 exited with status 0
I0816 01:42:26.881037 6610 slave.cpp:5429] Cleaning up executor 'default' of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 (via HTTP)
I0816 01:42:26.881386 6617 gc.cpp:59] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_fIlJs8/slaves/2274f542-cd47-4c19-aa89-75e95be229f2-S0/frameworks/2274f542-cd47-4c19-aa89-75e95be229f2-0000/executors/default/runs/77ec0948-d4b5-4f4a-8e19-155ffa8ee10b' for gc 6.99998980030222days in the future
W0816 01:42:26.881404 6621 master.cpp:6963] Ignoring unknown exited executor 'default' of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000 on agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc)
I0816 01:42:26.881587 6617 gc.cpp:59] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_fIlJs8/slaves/2274f542-cd47-4c19-aa89-75e95be229f2-S0/frameworks/2274f542-cd47-4c19-aa89-75e95be229f2-0000/executors/default' for gc 6.99998979716444days in the future
I0816 01:42:26.881618 6610 slave.cpp:5525] Cleaning up framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.881837 6616 status_update_manager.cpp:285] Closing status update streams for framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.881928 6616 status_update_manager.cpp:531] Cleaning up status update stream for task e8c6361b-3421-449b-b2b6-37c4a15cb92b of framework 2274f542-cd47-4c19-aa89-75e95be229f2-0000
I0816 01:42:26.881978 6610 slave.cpp:843] Agent terminating
I0816 01:42:26.882055 6620 gc.cpp:59] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_fIlJs8/slaves/2274f542-cd47-4c19-aa89-75e95be229f2-S0/frameworks/2274f542-cd47-4c19-aa89-75e95be229f2-0000' for gc 6.99998979429333days in the future
I0816 01:42:26.882237 6620 master.cpp:1318] Agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc) disconnected
I0816 01:42:26.882268 6620 master.cpp:3301] Disconnecting agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc)
I0816 01:42:26.882360 6620 master.cpp:3320] Deactivating agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 at slave(743)@172.17.0.2:43082 (f7cdd33077cc)
I0816 01:42:26.882529 6618 hierarchical.cpp:690] Agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0 deactivated
I0816 01:42:26.887104 950 master.cpp:1160] Master terminating
I0816 01:42:26.887832 6623 hierarchical.cpp:626] Removed agent 2274f542-cd47-4c19-aa89-75e95be229f2-S0
W0816 01:42:26.889530 950 master.hpp:2700] Failed to close HTTP pipe for 2274f542-cd47-4c19-aa89-75e95be229f2-0000 (default)
[ OK ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/2 (791 ms)
[ RUN ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/3
I0816 01:42:26.899493 6624 process.cpp:1072] Failed to accept socket: future discarded
W0816 01:42:26.899726 6624 process.cpp:3215] Attempted to spawn a process (__http_connection__(1275)@172.17.0.2:43082) after finalizing libprocess!
*** Aborted at 1502847746 (unix time) try "date -d @1502847746" if you are using GNU date ***
I0816 01:42:26.902469 950 process.cpp:1393] libprocess is initialized on 172.17.0.2:36552 with 16 worker threads
PC: @ 0x7fe3055b4fe0 process::PID<>::PID()
*** SIGSEGV (@0x0) received by PID 950 (TID 0x7fe2f252b700) from PID 0; stack trace: ***
@ 0x7fe300b01370 (unknown)
I0816 01:42:26.904706 950 cluster.cpp:162] Creating default 'local' authorizer
@ 0x7fe3055b4fe0 process::PID<>::PID()
I0816 01:42:26.907466 6636 master.cpp:442] Master 06c32629-7d7c-44d8-83d2-eeeecd0bf270 (f7cdd33077cc) started on 172.17.0.2:36552
I0816 01:42:26.907483 6636 master.cpp:444] 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/TqBg7Y/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/TqBg7Y/master" --zk_session_timeout="10secs"
I0816 01:42:26.907924 6636 master.cpp:494] Master only allowing authenticated frameworks to register
I0816 01:42:26.907939 6636 master.cpp:508] Master only allowing authenticated agents to register
I0816 01:42:26.907944 6636 master.cpp:521] Master only allowing authenticated HTTP frameworks to register
I0816 01:42:26.907951 6636 credentials.hpp:37] Loading credentials for authentication from '/tmp/TqBg7Y/credentials'
I0816 01:42:26.908357 6636 master.cpp:566] Using default 'crammd5' authenticator
I0816 01:42:26.908560 6636 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0816 01:42:26.908758 6636 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0816 01:42:26.908896 6636 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
@ 0x7fe3055a774b process::Process<>::self()
I0816 01:42:26.909071 6636 master.cpp:646] Authorization enabled
I0816 01:42:26.909296 6633 hierarchical.cpp:171] Initialized hierarchical allocator process
I0816 01:42:26.909315 6637 whitelist_watcher.cpp:77] No whitelist given
@ 0x7fe30557f95a process::ProcessManager::spawn()
@ 0x7fe3055856f8 process::spawn()
I0816 01:42:26.912906 6640 master.cpp:2163] Elected as the leading master!
I0816 01:42:26.912932 6640 master.cpp:1702] Recovering from registrar
I0816 01:42:26.913130 6627 registrar.cpp:347] Recovering registrar
@ 0x7fe30546ac8b process::spawn<>()
I0816 01:42:26.915922 6629 registrar.cpp:391] Successfully fetched the registry (0B) in 2.748928ms
I0816 01:42:26.916111 6629 registrar.cpp:495] Applied 1 operations in 33086ns; attempting to update the registry
I0816 01:42:26.916796 6629 registrar.cpp:552] Successfully updated the registry in 621056ns
@ 0x7fe305461ccb process::http::Connection::Data::Data()
I0816 01:42:26.916929 6629 registrar.cpp:424] Successfully recovered registrar
I0816 01:42:26.917281 6640 master.cpp:1801] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0816 01:42:26.917388 6639 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
@ 0x7fe3054cb296 __gnu_cxx::new_allocator<>::construct<>()
@ 0x7fe3054c95e5 _ZNSt16allocator_traitsISaIN7process4http10Connection4DataEEE12_S_constructIS3_JRKNS0_7network8internal6SocketINS7_7AddressEEEEEENSt9enable_ifIXsrNS5_18__construct_helperIT_JDpT0_EEE5valueEvE4typeERS4_PSG_DpOSH_
I0816 01:42:26.921799 950 process.cpp:3228] Attempting to spawn already spawned process files@172.17.0.2:36552
I0816 01:42:26.922127 950 cluster.cpp:448] Creating default 'local' authorizer
@ 0x7fe3054c6be2 _ZNSt16allocator_traitsISaIN7process4http10Connection4DataEEE9constructIS3_IRKNS0_7network8internal6SocketINS7_7AddressEEEEEEDTcl12_S_constructfp_fp0_spcl7forwardIT0_Efp1_EEERS4_PT_DpOSE_
@ 0x7fe3054c2da9 std::_Sp_counted_ptr_inplace<>::_Sp_counted_ptr_inplace<>()
I0816 01:42:26.923984 6629 slave.cpp:250] Mesos agent started on (744)@172.17.0.2:36552
I0816 01:42:26.924046 6629 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_zOpr4V/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_zOpr4V/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_zOpr4V/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_zOpr4V/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_zOpr4V/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_zOpr4V/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_zOpr4V" --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_x4tQAs"
I0816 01:42:26.924425 6629 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_zOpr4V/credential'
I0816 01:42:26.924608 950 scheduler.cpp:184] Version: 1.4.0
I0816 01:42:26.924612 6629 slave.cpp:283] Agent using credential for: test-principal
I0816 01:42:26.924639 6629 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_zOpr4V/http_credentials'
I0816 01:42:26.924888 6629 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
@ 0x7fe3054bcffd _ZN9__gnu_cxx13new_allocatorISt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS5_ELNS_12_Lock_policyE2EEE9constructIS8_JKS6_RKNS2_7network8internal6SocketINSC_7AddressEEEEEEvPT_DpOT0_
I0816 01:42:26.925007 6629 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0816 01:42:26.925272 6629 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0816 01:42:26.925370 6629 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0816 01:42:26.925439 6631 scheduler.cpp:470] New master detected at master@172.17.0.2:36552
I0816 01:42:26.925552 6629 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0816 01:42:26.925647 6629 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0816 01:42:26.927000 6631 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0816 01:42:26.926944 6629 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
@ 0x7fe3054b43fb std::allocator_traits<>::_S_construct<>()
I0816 01:42:26.927186 6629 slave.cpp:573] Agent attributes: [ ]
I0816 01:42:26.927202 6629 slave.cpp:582] Agent hostname: f7cdd33077cc
I0816 01:42:26.927361 6630 status_update_manager.cpp:177] Pausing sending status updates
@ 0x7fe3054a92ec _ZNSt16allocator_traitsISaISt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS4_ELN9__gnu_cxx12_Lock_policyE2EEEE9constructIS8_JKS5_RKNS1_7network8internal6SocketINSD_7AddressEEEEEEDTcl12_S_constructfp_fp0_spcl7forwardIT0_Efp1_EEERS9_PT_DpOSK_
I0816 01:42:26.928661 6636 state.cpp:64] Recovering state from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_x4tQAs/meta'
I0816 01:42:26.929011 6632 status_update_manager.cpp:203] Recovering status update manager
I0816 01:42:26.929424 6626 slave.cpp:6210] Finished recovery
@ 0x7fe30549ba55 _ZNSt14__shared_countILN9__gnu_cxx12_Lock_policyE2EEC1IN7process4http10Connection4DataESaIS7_EJRKNS4_7network8internal6SocketINS9_7AddressEEEEEESt19_Sp_make_shared_tagPT_RKT0_DpOT1_
I0816 01:42:26.929931 6626 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0816 01:42:26.930197 6638 status_update_manager.cpp:177] Pausing sending status updates
I0816 01:42:26.930209 6631 slave.cpp:971] New master detected at master@172.17.0.2:36552
I0816 01:42:26.930274 6631 slave.cpp:1006] Detecting new master
I0816 01:42:26.930470 6631 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
@ 0x7fe30548e01c _ZNSt12__shared_ptrIN7process4http10Connection4DataELN9__gnu_cxx12_Lock_policyE2EEC2ISaIS3_EJRKNS0_7network8internal6SocketINS9_7AddressEEEEEESt19_Sp_make_shared_tagRKT_DpOT0_
@ 0x7fe305481b9c _ZNSt10shared_ptrIN7process4http10Connection4DataEEC1ISaIS3_EJRKNS0_7network8internal6SocketINS7_7AddressEEEEEESt19_Sp_make_shared_tagRKT_DpOT0_
@ 0x7fe3054762ce std::allocate_shared<>()
@ 0x7fe30546ad73 _ZSt11make_sharedIN7process4http10Connection4DataEJRKNS0_7network8internal6SocketINS4_7AddressEEEEESt10shared_ptrIT_EDpOT0_
@ 0x7fe305420504 process::http::Connection::Connection()
@ 0x7fe305420779 _ZZN7process4http7connectERKNS_7network7AddressENS0_6SchemeEENKUlvE_clEv
@ 0x7fe305433d2f _ZNSt17_Function_handlerIFN7process6FutureINS0_4http10ConnectionEEEvEZNS2_7connectERKNS0_7network7AddressENS2_6SchemeEEUlvE_E9_M_invokeERKSt9_Any_data
@ 0x7fe30a8e982d std::function<>::operator()()
@ 0x7fe30a8e3265 _ZNSt5_BindIFSt8functionIFN7process6FutureINS1_4http10ConnectionEEEvEEvEE6__callIS5_IRK7NothingEIEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE
@ 0x7fe30a8dacdd _ZNSt5_BindIFSt8functionIFN7process6FutureINS1_4http10ConnectionEEEvEEvEEclIJRK7NothingES5_EET0_DpOT_
@ 0x7fe30a8d0e59 std::_Function_handler<>::_M_invoke()
@ 0x7fe30a8daeff std::function<>::operator()()
@ 0x7fe30a8d0fcf process::internal::thenf<>()
@ 0x7fe30a8e998d _ZNSt5_BindIFPFvRKSt8functionIFN7process6FutureINS1_4http10ConnectionEEERK7NothingEERKSt10shared_ptrINS1_7PromiseIS4_EEERKNS2_IS6_EEESA_SG_St12_PlaceholderILi1EEEE6__callIvJSL_EJLm0ELm1ELm2EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
@ 0x7fe30a8e33d7 _ZNSt5_BindIFPFvRKSt8functionIFN7process6FutureINS1_4http10ConnectionEEERK7NothingEERKSt10shared_ptrINS1_7PromiseIS4_EEERKNS2_IS6_EEESA_SG_St12_PlaceholderILi1EEEEclIJSL_EvEET0_DpOT_
@ 0x7fe30a8db1df std::_Function_handler<>::_M_invoke()
@ 0x26c73bb std::function<>::operator()()
make[3]: *** [CMakeFiles/check] Segmentation fault
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1502844917-26723
Untagged: mesos-1502844917-26723:latest
Deleted: sha256:6e7b220987d5eeee1c4c147ce95eaa66c9df435771fe947738286c2af231cfd1
Deleted: sha256:4dc16c8fabacc6b8ad818580774f9b8b8d485e696e1e04c46d01b1b43fea0ebd
Deleted: sha256:f8273fe6771a892dfe17907ce6872a0a6401d8472ef248c445f85e7edd42a326
Deleted: sha256:87685cc77eee5bd18581ce62b35e8a860e776863c580df3394e4760b7d578118
Deleted: sha256:c87358243cb7bb222bc7841223c90d3f2d82fda623cae00c1b98571b706eb995
Deleted: sha256:b86a33af19e2a174d14b07129c01760a2f8e95adb2a235d94fb8ce7736814d0f
Deleted: sha256:5cde01748e29cd340ce660e72921d692602bf5a8e15615eaa9ced3b45f9fca60
Deleted: sha256:b3ea850aa0a0fbb3f80b0ad21addbba06bd5a022722ffad276b36de0bf95aab2
Deleted: sha256:89570e266fcaeaf13a6c2523757ccf0fc63d38ecbcac590175474ddff4675b65
Deleted: sha256:ec7c0eef424a689f14dd1222e106a82d660dad26d60f2d69ef328581a9b351fd
Deleted: sha256:d8e111bad35fe9cd08391746b6a752fbd8f36d563cdd02e986445188321ce8be
Deleted: sha256:2f09b2975cc405369d245a7b78383ce9eeaa519a0f5c572d1a6dbfafc71155e0
Deleted: sha256:5e5e8ef46cf31039f21069f06cd1875ae7ef85d1b08ebf84308aa7bacecd8945
Deleted: sha256:6338d98bc35dbd6279f6d0d12eadc5e8391162c09803f7759ad0f915aec2db17
Deleted: sha256:2126f5a1887bc6beb9d22fe61e37b4254a5f497754df4bd34e666e7a470cb4c4
Deleted: sha256:81a76b92c7048d9de20c0f3949842c1c437fcb8a8950fe3394e8388bdb20e729
Deleted: sha256:6ef3bebddf535c02e7216a12f2d9f00b324d937cb2ec9b5de073a162dfc7615a
Deleted: sha256:46328ca7f9ebda4e231bd46290d47f4d709cd9695b7922d4db5d567804fcaabb
Deleted: sha256:06b4bd4eaa147778634ef3c367c6ae456eda5f1d605191e6a14927c1aeb0b4bf
Deleted: sha256:9be12db349ea549c95736bf19dff0bec2576203b9e7daa99c273d6564f3e6e3c
Deleted: sha256:64e6572d00ca906388e0a65d066782e19f569c5e853d9ff2bb3b3cdbe78f83b2
Deleted: sha256:ab5d480ee4f0fe2373db90fbdf1b46f236a8e4942fd90a2e9beb6ac17b40a507
Deleted: sha256:d7c0d3db7cf9c743286456b38d29d495207428dba751aabed875d977d3725528
Deleted: sha256:1fc8c9c52dc1ba6d7d4ddfbda208eebceb1b917bdc6185cb901882a87c5c016e
Deleted: sha256:a36c45b1e52956c720a882e00c9d92cd37d666c14ef686e6a99a74306c11b76e
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4118
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4118/display/redirect?page=changes>
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4117
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4117/display/redirect?page=changes>
Changes:
[anand] Added the field `signal` to the `KillNestedContainer` call.
[anand] Added the `kill()` function to the containerizer interface.
[anand] Added `kill()` call to the composing containerizer.
[anand] Made `killNestedContainer()` use `kill()` on the containerizer.
[anand] Made the default executor support signal escalation.
[anand] Added support for kill policies to the default executor.
[anand] Added `kill()` support to the test containerizer interface.
------------------------------------------
[...truncated 17.79 MB...]
I0816 04:19:19.680569 957 hierarchical.cpp:1152] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; cpus{REV}:2, allocated: cpus(allocated: *){REV}:2) on agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0 from framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.680624 957 hierarchical.cpp:1189] Framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 filtered agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0 for 5secs
I0816 04:19:19.680707 963 slave.cpp:7165] Launching executor 'exit 1' of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 with resources [{"allocation_info":{"role":"*"},"name":"cpus","revocable":{},"scalar":{"value":1.0},"type":"SCALAR"}] in work directory '/tmp/OversubscriptionTest_RevocableOffer_ggin3b/slaves/b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0/frameworks/b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000/executors/exit 1/runs/1cdcda9a-be1d-4967-a5c6-ef8e3f79f2d4'
I0816 04:19:19.681644 963 slave.cpp:2398] Queued task '0c0ceae2-1ba9-442c-8833-44cb172bc3b4' for executor 'exit 1' of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.681740 963 slave.cpp:924] Successfully attached file '/tmp/OversubscriptionTest_RevocableOffer_ggin3b/slaves/b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0/frameworks/b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000/executors/exit 1/runs/1cdcda9a-be1d-4967-a5c6-ef8e3f79f2d4'
I0816 04:19:19.681784 963 slave.cpp:924] Successfully attached file '/tmp/OversubscriptionTest_RevocableOffer_ggin3b/slaves/b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0/frameworks/b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000/executors/exit 1/runs/1cdcda9a-be1d-4967-a5c6-ef8e3f79f2d4'
I0816 04:19:19.682024 963 slave.cpp:2856] Launching container 1cdcda9a-be1d-4967-a5c6-ef8e3f79f2d4 for executor 'exit 1' of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.684350 955 process.cpp:3228] Attempting to spawn already spawned process version@172.17.0.2:50139
I0816 04:19:19.684523 955 exec.cpp:162] Version: 1.4.0
I0816 04:19:19.684852 964 exec.cpp:212] Executor started at: executor(159)@172.17.0.2:50139 with pid 950
I0816 04:19:19.685060 964 slave.cpp:3881] Got registration for executor 'exit 1' of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 from executor(159)@172.17.0.2:50139
I0816 04:19:19.685466 953 exec.cpp:237] Executor registered on agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0
I0816 04:19:19.685513 953 exec.cpp:249] Executor::registered took 24645ns
I0816 04:19:19.685866 964 slave.cpp:2603] Sending queued task '0c0ceae2-1ba9-442c-8833-44cb172bc3b4' to executor 'exit 1' of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 at executor(159)@172.17.0.2:50139
I0816 04:19:19.686239 966 exec.cpp:331] Executor asked to run task '0c0ceae2-1ba9-442c-8833-44cb172bc3b4'
I0816 04:19:19.686327 966 exec.cpp:340] Executor::launchTask took 64358ns
I0816 04:19:19.686436 966 exec.cpp:571] Executor sending status update TASK_RUNNING (UUID: b28d8f49-cf8f-44dd-a33d-a9cf72e583ba) for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.686735 956 slave.cpp:4345] Handling status update TASK_RUNNING (UUID: b28d8f49-cf8f-44dd-a33d-a9cf72e583ba) for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 from executor(159)@172.17.0.2:50139
I0816 04:19:19.687348 962 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: b28d8f49-cf8f-44dd-a33d-a9cf72e583ba) for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.687391 962 status_update_manager.cpp:500] Creating StatusUpdate stream for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.687842 962 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: b28d8f49-cf8f-44dd-a33d-a9cf72e583ba) for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 to the agent
I0816 04:19:19.688122 951 slave.cpp:4797] Forwarding the update TASK_RUNNING (UUID: b28d8f49-cf8f-44dd-a33d-a9cf72e583ba) for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 to master@172.17.0.2:50139
I0816 04:19:19.688371 951 slave.cpp:4691] Status update manager successfully handled status update TASK_RUNNING (UUID: b28d8f49-cf8f-44dd-a33d-a9cf72e583ba) for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.688421 951 slave.cpp:4707] Sending acknowledgement for status update TASK_RUNNING (UUID: b28d8f49-cf8f-44dd-a33d-a9cf72e583ba) for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 to executor(159)@172.17.0.2:50139
I0816 04:19:19.688501 957 master.cpp:6846] Status update TASK_RUNNING (UUID: b28d8f49-cf8f-44dd-a33d-a9cf72e583ba) for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 from agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0 at slave(435)@172.17.0.2:50139 (76e982f577d7)
I0816 04:19:19.688555 957 master.cpp:6908] Forwarding status update TASK_RUNNING (UUID: b28d8f49-cf8f-44dd-a33d-a9cf72e583ba) for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.688622 951 exec.cpp:388] Executor received status update acknowledgement b28d8f49-cf8f-44dd-a33d-a9cf72e583ba for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.688755 957 master.cpp:8933] Updating the state of task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0816 04:19:19.688984 951 sched.cpp:1041] Scheduler::statusUpdate took 91879ns
I0816 04:19:19.689312 952 master.cpp:5477] Processing ACKNOWLEDGE call b28d8f49-cf8f-44dd-a33d-a9cf72e583ba for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 (default) at scheduler-32198ec3-6b8f-4b1f-bf38-eaa0bd6b8ce1@172.17.0.2:50139 on agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0
I0816 04:19:19.689424 950 sched.cpp:2021] Asked to stop the driver
I0816 04:19:19.689532 966 sched.cpp:1203] Stopping framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.689656 954 status_update_manager.cpp:395] Received status update acknowledgement (UUID: b28d8f49-cf8f-44dd-a33d-a9cf72e583ba) for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.689759 960 master.cpp:8348] Processing TEARDOWN call for framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 (default) at scheduler-32198ec3-6b8f-4b1f-bf38-eaa0bd6b8ce1@172.17.0.2:50139
I0816 04:19:19.689792 960 master.cpp:8360] Removing framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 (default) at scheduler-32198ec3-6b8f-4b1f-bf38-eaa0bd6b8ce1@172.17.0.2:50139
I0816 04:19:19.689824 960 master.cpp:3264] Deactivating framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 (default) at scheduler-32198ec3-6b8f-4b1f-bf38-eaa0bd6b8ce1@172.17.0.2:50139
I0816 04:19:19.689975 956 hierarchical.cpp:412] Deactivated framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.689995 957 slave.cpp:3609] Status update manager successfully handled status update acknowledgement (UUID: b28d8f49-cf8f-44dd-a33d-a9cf72e583ba) for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.690018 960 master.cpp:8933] Updating the state of task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0816 04:19:19.690119 957 slave.cpp:3159] Asked to shut down framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 by master@172.17.0.2:50139
I0816 04:19:19.690152 957 slave.cpp:3184] Shutting down framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.690376 960 master.cpp:9027] Removing task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 with resources [{"allocation_info":{"role":"*"},"name":"cpus","revocable":{},"scalar":{"value":1.0},"type":"SCALAR"}] of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 on agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0 at slave(435)@172.17.0.2:50139 (76e982f577d7)
I0816 04:19:19.690655 957 slave.cpp:5651] Shutting down executor 'exit 1' of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 at executor(159)@172.17.0.2:50139
I0816 04:19:19.690547 958 hierarchical.cpp:1152] Recovered cpus(allocated: *){REV}:1 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; cpus{REV}:2, allocated: cpus(allocated: *){REV}:1) on agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0 from framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.690752 952 exec.cpp:435] Executor asked to shutdown
I0816 04:19:19.690937 952 exec.cpp:450] Executor::shutdown took 25036ns
I0816 04:19:19.690938 960 master.cpp:9056] Removing executor 'exit 1' with resources [{"allocation_info":{"role":"*"},"name":"cpus","revocable":{},"scalar":{"value":1.0},"type":"SCALAR"}] of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 on agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0 at slave(435)@172.17.0.2:50139 (76e982f577d7)
I0816 04:19:19.691123 959 slave.cpp:4929] Got exited event for executor(159)@172.17.0.2:50139
I0816 04:19:19.691424 965 hierarchical.cpp:1152] Recovered cpus(allocated: *){REV}:1 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; cpus{REV}:2, allocated: {}) on agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0 from framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.691866 966 slave.cpp:5329] Executor 'exit 1' of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 exited with status 0
I0816 04:19:19.691956 966 slave.cpp:5429] Cleaning up executor 'exit 1' of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 at executor(159)@172.17.0.2:50139
W0816 04:19:19.692106 960 master.cpp:6963] Ignoring unknown exited executor 'exit 1' of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000 on agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0 at slave(435)@172.17.0.2:50139 (76e982f577d7)
I0816 04:19:19.692137 962 hierarchical.cpp:355] Removed framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.692317 959 gc.cpp:59] Scheduling '/tmp/OversubscriptionTest_RevocableOffer_ggin3b/slaves/b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0/frameworks/b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000/executors/exit 1/runs/1cdcda9a-be1d-4967-a5c6-ef8e3f79f2d4' for gc 6.99999198868148days in the future
I0816 04:19:19.692450 966 slave.cpp:5525] Cleaning up framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.692512 959 gc.cpp:59] Scheduling '/tmp/OversubscriptionTest_RevocableOffer_ggin3b/slaves/b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0/frameworks/b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000/executors/exit 1' for gc 6.99999198641185days in the future
I0816 04:19:19.692571 965 status_update_manager.cpp:285] Closing status update streams for framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.692616 965 status_update_manager.cpp:531] Cleaning up status update stream for task 0c0ceae2-1ba9-442c-8833-44cb172bc3b4 of framework b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000
I0816 04:19:19.692749 963 gc.cpp:59] Scheduling '/tmp/OversubscriptionTest_RevocableOffer_ggin3b/slaves/b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0/frameworks/b9389db6-a91f-4e95-a2e4-b7da91f07ef0-0000' for gc 6.99999198368days in the future
I0816 04:19:19.692804 966 slave.cpp:843] Agent terminating
I0816 04:19:19.693135 955 master.cpp:1318] Agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0 at slave(435)@172.17.0.2:50139 (76e982f577d7) disconnected
I0816 04:19:19.693168 955 master.cpp:3301] Disconnecting agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0 at slave(435)@172.17.0.2:50139 (76e982f577d7)
I0816 04:19:19.693244 955 master.cpp:3320] Deactivating agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0 at slave(435)@172.17.0.2:50139 (76e982f577d7)
I0816 04:19:19.693339 959 hierarchical.cpp:690] Agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0 deactivated
I0816 04:19:19.696369 950 master.cpp:1160] Master terminating
I0816 04:19:19.697295 964 hierarchical.cpp:626] Removed agent b9389db6-a91f-4e95-a2e4-b7da91f07ef0-S0
[ OK ] OversubscriptionTest.RevocableOffer (67 ms)
[ RUN ] OversubscriptionTest.RescindRevocableOfferWithIncreasedRevocable
I0816 04:19:19.703892 950 cluster.cpp:162] Creating default 'local' authorizer
I0816 04:19:19.707715 961 master.cpp:442] Master 1eb93afb-4bd0-4e6b-a3cd-2aecff453421 (76e982f577d7) started on 172.17.0.2:50139
I0816 04:19:19.707739 961 master.cpp:444] 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/Z25de1/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/Z25de1/master" --zk_session_timeout="10secs"
I0816 04:19:19.708078 961 master.cpp:494] Master only allowing authenticated frameworks to register
I0816 04:19:19.708122 961 master.cpp:508] Master only allowing authenticated agents to register
I0816 04:19:19.708142 961 master.cpp:521] Master only allowing authenticated HTTP frameworks to register
I0816 04:19:19.708151 961 credentials.hpp:37] Loading credentials for authentication from '/tmp/Z25de1/credentials'
I0816 04:19:19.708446 961 master.cpp:566] Using default 'crammd5' authenticator
I0816 04:19:19.708607 961 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0816 04:19:19.708784 961 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0816 04:19:19.708920 961 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0816 04:19:19.709072 961 master.cpp:646] Authorization enabled
I0816 04:19:19.709249 962 whitelist_watcher.cpp:77] No whitelist given
I0816 04:19:19.709264 959 hierarchical.cpp:171] Initialized hierarchical allocator process
I0816 04:19:19.712507 958 master.cpp:2163] Elected as the leading master!
I0816 04:19:19.712532 958 master.cpp:1702] Recovering from registrar
I0816 04:19:19.712671 952 registrar.cpp:347] Recovering registrar
I0816 04:19:19.713259 952 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns
I0816 04:19:19.713371 952 registrar.cpp:495] Applied 1 operations in 28263ns; attempting to update the registry
I0816 04:19:19.713917 952 registrar.cpp:552] Successfully updated the registry in 0ns
I0816 04:19:19.714035 952 registrar.cpp:424] Successfully recovered registrar
I0816 04:19:19.714372 963 master.cpp:1801] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0816 04:19:19.714429 966 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
I0816 04:19:19.718966 950 process.cpp:3228] Attempting to spawn already spawned process files@172.17.0.2:50139
I0816 04:19:19.720003 950 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0816 04:19:19.720500 950 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0816 04:19:19.720623 950 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0816 04:19:19.720657 950 provisioner.cpp:255] Using default backend 'copy'
I0816 04:19:19.722662 950 cluster.cpp:448] Creating default 'local' authorizer
I0816 04:19:19.724622 964 slave.cpp:250] Mesos agent started on (436)@172.17.0.2:50139
I0816 04:19:19.725150 950 process.cpp:3228] Attempting to spawn already spawned process version@172.17.0.2:50139
I0816 04:19:19.724642 964 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/OversubscriptionTest_RescindRevocableOfferWithIncreasedRevocable_ntPe4q/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/OversubscriptionTest_RescindRevocableOfferWithIncreasedRevocable_ntPe4q/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --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/OversubscriptionTest_RescindRevocableOfferWithIncreasedRevocable_ntPe4q/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/OversubscriptionTest_RescindRevocableOfferWithIncreasedRevocable_ntPe4q/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/OversubscriptionTest_RescindRevocableOfferWithIncreasedRevocable_ntPe4q/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/OversubscriptionTest_RescindRevocableOfferWithIncreasedRevocable_ntPe4q/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/OversubscriptionTest_RescindRevocableOfferWithIncreasedRevocable_ntPe4q" --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/OversubscriptionTest_RescindRevocableOfferWithIncreasedRevocable_XiOd9d"
I0816 04:19:19.725263 964 credentials.hpp:86] Loading credential for authentication from '/tmp/OversubscriptionTest_RescindRevocableOfferWithIncreasedRevocable_ntPe4q/credential'
I0816 04:19:19.725423 964 slave.cpp:283] Agent using credential for: test-principal
I0816 04:19:19.725531 964 credentials.hpp:37] Loading credentials for authentication from '/tmp/OversubscriptionTest_RescindRevocableOfferWithIncreasedRevocable_ntPe4q/http_credentials'
I0816 04:19:19.725855 964 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0816 04:19:19.726032 950 sched.cpp:232] Version: 1.4.0
I0816 04:19:19.726032 964 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0816 04:19:19.726466 964 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0816 04:19:19.726586 956 sched.cpp:336] New master detected at master@172.17.0.2:50139
I0816 04:19:19.726686 964 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0816 04:19:19.726799 957 hierarchical.cpp:1925] No allocations performed
I0816 04:19:19.726840 957 hierarchical.cpp:1468] Performed allocation for 0 agents in 127552ns
I0816 04:19:19.726956 964 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0816 04:19:19.727082 964 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0816 04:19:19.728137 956 sched.cpp:407] Authenticating with master master@172.17.0.2:50139
I0816 04:19:19.728155 956 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0816 04:19:19.728442 963 authenticatee.cpp:121] Creating new client SASL connection
I0816 04:19:19.728814 959 master.cpp:7837] Authenticating scheduler-dcfa4df2-329a-4c1c-8bb8-c24f025a4d72@172.17.0.2:50139
I0816 04:19:19.728937 962 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(910)@172.17.0.2:50139
I0816 04:19:19.729271 954 authenticator.cpp:98] Creating new server SASL connection
I0816 04:19:19.729092 964 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0816 04:19:19.729353 964 slave.cpp:573] Agent attributes: [ ]
I0816 04:19:19.729368 964 slave.cpp:582] Agent hostname: 76e982f577d7
I0816 04:19:19.729519 954 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0816 04:19:19.729542 954 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0816 04:19:19.729557 957 status_update_manager.cpp:177] Pausing sending status updates
I0816 04:19:19.729643 954 authenticator.cpp:204] Received SASL authentication start
I0816 04:19:19.729701 954 authenticator.cpp:326] Authentication requires more steps
I0816 04:19:19.729813 965 authenticatee.cpp:259] Received SASL authentication step
I0816 04:19:19.729926 953 authenticator.cpp:232] Received SASL authentication step
I0816 04:19:19.729951 953 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '76e982f577d7' server FQDN: '76e982f577d7' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0816 04:19:19.729964 953 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0816 04:19:19.730003 953 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0816 04:19:19.730029 953 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '76e982f577d7' server FQDN: '76e982f577d7' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0816 04:19:19.730065 953 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0816 04:19:19.730098 953 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0816 04:19:19.730119 953 authenticator.cpp:318] Authentication success
I0816 04:19:19.730247 966 authenticatee.cpp:299] Authentication success
I0816 04:19:19.730286 955 master.cpp:7867] Successfully authenticated principal 'test-principal' at scheduler-dcfa4df2-329a-4c1c-8bb8-c24f025a4d72@172.17.0.2:50139
I0816 04:19:19.730402 953 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(910)@172.17.0.2:50139
I0816 04:19:19.730672 951 sched.cpp:513] Successfully authenticated with master master@172.17.0.2:50139
I0816 04:19:19.730690 951 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.2:50139
I0816 04:19:19.730813 951 sched.cpp:869] Will retry registration in 1.143485695secs if necessary
I0816 04:19:19.730957 957 master.cpp:2894] Received SUBSCRIBE call for framework 'default' at scheduler-dcfa4df2-329a-4c1c-8bb8-c24f025a4d72@172.17.0.2:50139
I0816 04:19:19.731040 957 master.cpp:2228] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0816 04:19:19.731488 958 master.cpp:2974] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT, REVOCABLE_RESOURCES ]
I0816 04:19:19.731757 960 state.cpp:64] Recovering state from '/tmp/OversubscriptionTest_RescindRevocableOfferWithIncreasedRevocable_XiOd9d/meta'
I0816 04:19:19.732161 959 status_update_manager.cpp:203] Recovering status update manager
I0816 04:19:19.732264 958 sched.cpp:759] Framework registered with 1eb93afb-4bd0-4e6b-a3cd-2aecff453421-0000
I0816 04:19:19.732280 966 hierarchical.cpp:303] Added framework 1eb93afb-4bd0-4e6b-a3cd-2aecff453421-0000
I0816 04:19:19.732339 958 sched.cpp:773] Scheduler::registered took 25794ns
I0816 04:19:19.732383 965 containerizer.cpp:609] Recovering containerizer
I0816 04:19:19.732465 966 hierarchical.cpp:1925] No allocations performed
I0816 04:19:19.732498 966 hierarchical.cpp:2015] No inverse offers to send out!
I0816 04:19:19.732529 966 hierarchical.cpp:1468] Performed allocation for 0 agents in 93279ns
I0816 04:19:19.734057 958 provisioner.cpp:416] Provisioner recovery complete
I0816 04:19:19.734390 955 slave.cpp:6210] Finished recovery
I0816 04:19:19.734868 955 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0816 04:19:19.735097 956 status_update_manager.cpp:177] Pausing sending status updates
I0816 04:19:19.735103 964 slave.cpp:971] New master detected at master@172.17.0.2:50139
I0816 04:19:19.735245 964 slave.cpp:1006] Detecting new master
I0816 04:19:19.735409 964 slave.cpp:1033] Authenticating with master master@172.17.0.2:50139
I0816 04:19:19.735482 964 slave.cpp:1044] Using default CRAM-MD5 authenticatee
I0816 04:19:19.735729 965 authenticatee.cpp:121] Creating new client SASL connection
I0816 04:19:19.735966 952 master.cpp:7837] Authenticating slave(436)@172.17.0.2:50139
I0816 04:19:19.736083 959 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(911)@172.17.0.2:50139
I0816 04:19:19.736330 953 authenticator.cpp:98] Creating new server SASL connection
I0816 04:19:19.736569 961 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0816 04:19:19.736588 961 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0816 04:19:19.736708 961 authenticator.cpp:204] Received SASL authentication start
I0816 04:19:19.736763 961 authenticator.cpp:326] Authentication requires more steps
I0816 04:19:19.736868 951 authenticatee.cpp:259] Received SASL authentication step
I0816 04:19:19.736976 951 authenticator.cpp:232] Received SASL authentication step
I0816 04:19:19.737004 951 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '76e982f577d7' server FQDN: '76e982f577d7' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0816 04:19:19.737017 951 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0816 04:19:19.737053 951 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0816 04:19:19.737074 951 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '76e982f577d7' server FQDN: '76e982f577d7' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0816 04:19:19.737085 951 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0816 04:19:19.737094 951 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0816 04:19:19.737112 951 authenticator.cpp:318] Authentication success
I0816 04:19:19.737197 958 authenticatee.cpp:299] Authentication success
I0816 04:19:19.737254 954 master.cpp:7867] Successfully authenticated principal 'test-principal' at slave(436)@172.17.0.2:50139
I0816 04:19:19.737313 960 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(911)@172.17.0.2:50139
I0816 04:19:19.737473 955 slave.cpp:1128] Successfully authenticated with master master@172.17.0.2:50139
I0816 04:19:19.737699 955 slave.cpp:1572] Will retry registration in 11.586594ms if necessary
*** Aborted at 1502857159 (unix time) try "date -d @1502857159" if you are using GNU date ***
I0816 04:19:19.737866 964 master.cpp:5712] Received register agent message from slave(436)@172.17.0.2:50139 (76e982f577d7)
I0816 04:19:19.738010 964 master.cpp:3803] Authorizing agent with principal 'test-principal'
I0816 04:19:19.738394 952 master.cpp:5772] Authorized registration of agent at slave(436)@172.17.0.2:50139 (76e982f577d7)
I0816 04:19:19.738510 952 master.cpp:5865] Registering agent at slave(436)@172.17.0.2:50139 (76e982f577d7) with id 1eb93afb-4bd0-4e6b-a3cd-2aecff453421-S0
I0816 04:19:19.738941 959 registrar.cpp:495] Applied 1 operations in 51178ns; attempting to update the registry
I0816 04:19:19.739536 959 registrar.cpp:552] Successfully updated the registry in 0ns
I0816 04:19:19.739717 956 master.cpp:5912] Admitted agent 1eb93afb-4bd0-4e6b-a3cd-2aecff453421-S0 at slave(436)@172.17.0.2:50139 (76e982f577d7)
I0816 04:19:19.740214 960 slave.cpp:4887] Received ping from slave-observer(433)@172.17.0.2:50139
I0816 04:19:19.740572 963 hierarchical.cpp:593] Added agent 1eb93afb-4bd0-4e6b-a3cd-2aecff453421-S0 (76e982f577d7) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0816 04:19:19.740828 964 slave.cpp:1174] Registered with master master@172.17.0.2:50139; given agent ID 1eb93afb-4bd0-4e6b-a3cd-2aecff453421-S0
I0816 04:19:19.740937 965 status_update_manager.cpp:184] Resuming sending status updates
I0816 04:19:19.740756 956 master.cpp:5943] Registered agent 1eb93afb-4bd0-4e6b-a3cd-2aecff453421-S0 at slave(436)@172.17.0.2:50139 (76e982f577d7) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0816 04:19:19.741209 964 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/OversubscriptionTest_RescindRevocableOfferWithIncreasedRevocable_XiOd9d/meta/slaves/1eb93afb-4bd0-4e6b-a3cd-2aecff453421-S0/slave.info'
I0816 04:19:19.741518 963 hierarchical.cpp:2015] No inverse offers to send out!
I0816 04:19:19.741583 963 hierarchical.cpp:1468] Performed allocation for 1 agents in 867181ns
I0816 04:19:19.741876 952 master.cpp:7667] Sending 1 offers to framework 1eb93afb-4bd0-4e6b-a3cd-2aecff453421-0000 (default) at scheduler-dcfa4df2-329a-4c1c-8bb8-c24f025a4d72@172.17.0.2:50139
PC: @ 0x7fe9749bb042 process::EventQueue::Consumer::empty()
*** SIGSEGV (@0x8) received by PID 950 (TID 0x7fe96995f700) from PID 8; stack trace: ***
I0816 04:19:19.742300 961 sched.cpp:933] Scheduler::resourceOffers took 71891ns
@ 0x7fe96ff25370 (unknown)
@ 0x7fe9749bb042 process::EventQueue::Consumer::empty()
@ 0x7fe9749a3faa process::ProcessManager::resume()
@ 0x7fe9749a06a0 _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
@ 0x7fe9749b2152 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x7fe9749b20a9 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
@ 0x7fe9749b2042 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
@ 0x7fe96fcc2230 (unknown)
@ 0x7fe96ff1ddc5 start_thread
@ 0x7fe96f42b76d __clone
make[3]: *** [CMakeFiles/check] Segmentation fault
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1502854469-15630
Untagged: mesos-1502854469-15630:latest
Deleted: sha256:bed838c355b537540f729ee4f2999995e6b9d9c502ba567e567dc677bed157c9
Deleted: sha256:2eeb2187560bfb09914400cea86d5c8b0d54078600dfcacadd303f9bd083d973
Deleted: sha256:539d0e354d440767c4ac975db2448cf7f4314f595408cfa6a24623c526db3cee
Deleted: sha256:d8949e45d631b57664fac2567ae3c095b150158e133cefdc498f9ed62c4fae92
Deleted: sha256:f6a981fa55624eb80d4a8c436cde8b38a01477975b337b4a9e6499c30a3db9fd
Deleted: sha256:692b94141ec84e0bf7a3e6c6fc7126d13380fc9000a015cb8c874fd4d98c5b70
Deleted: sha256:48d8f897cf0042417f4aff7b83756baf02083280339a3d8415c7cd941f6ea328
Deleted: sha256:65beae9b37fcd56a11f933e1f9877c65ee06ccaf5bd4b76e901650e52c28ce89
Deleted: sha256:3c187deabc2db30ad0d68f366ca72dcbc6403afdd67c3f4934d0ca7bdf394dbd
Deleted: sha256:9d9baed8e894ec81d1f86de2ed9a332a4fe0af6070bf43f5ea08a901e64945c6
Deleted: sha256:ce414401fc460b65c14c54dddb4e0aa61850e391b0251e94a9480d888e7e7532
Deleted: sha256:c21a2baf6d966f3c5300dfa0601e6d841a250cb33da3b03508ec0be3a765cb39
Deleted: sha256:f0702418490b8bb3f69e185f95e4c35188e807453ab2435200463a88c40c2077
Deleted: sha256:94f722a9d49730d2ebd424e0cff39edf44ddfc9b0ba5fd874451372ab3e28f60
Deleted: sha256:5f811bec9e30443795e06f141d39e542a3244d909133966d83c849d37fec9caf
Deleted: sha256:0763d833301f4bb9f217e59c06bda903bbfeb40aff7c607f3f6c22e1f614dafe
Deleted: sha256:9b06838a4712838be44c4a5bb1272f184063ae5f4226d94377ac6382e7d230d2
Deleted: sha256:ffd359197a06c042be8a692c17afec1f8f2fe8a6ce7ee5d61ee4af8ccda1e690
Deleted: sha256:c5ec868478e75480bba2873f685d9ec348b7d7e07e9adc92164e8b0c8f3f7929
Deleted: sha256:8f628160cefab2c5ec582fdea2baa504aeafbbd785031c1beda060e6bb08ca5f
Deleted: sha256:35245c23aa0e9ea2e559359fb1110aff793dd37f4ac8b3235541fdbef9aacb73
Deleted: sha256:ccdde433157b9f601f5953feced3073727e6e98f81a6fe1bc29e76738eb1543f
Deleted: sha256:593bc1c0a78e2f4fd1bf32b820d9fa229a8fae3bfc221370a5fdeeb76a370dd7
Deleted: sha256:48a7840c73726337fc5c7ce48fd8bb862aa99ef8f1157e801c6505ecf003edbf
Deleted: sha256:91dcbc875305ece604af6828a7e579e2e35e216c0992d332f92b314c43aa7b96
Build step 'Execute shell' marked build as failure