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/11/20 01:15:04 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --disable-libtool-wrappers,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4473
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4473/display/redirect?page=changes>
Changes:
[bmahler] Added a Future constructor for Try<Future<T>>.
------------------------------------------
[...truncated 29.06 MB...]
3: I1120 01:14:39.012625 15987 process.cpp:3932] Handling HTTP event for process 'slave(803)' with path: '/slave(803)/api/v1'
3: I1120 01:14:39.013412 15991 http.cpp:1185] HTTP POST for /slave(803)/api/v1 from 172.17.0.7:49016
3: I1120 01:14:39.013738 15991 http.cpp:1185] HTTP POST for /slave(803)/api/v1 from 172.17.0.7:49018
3: I1120 01:14:39.014122 15991 http.cpp:2589] Processing WAIT_NESTED_CONTAINER call for container '01f75792-8059-4b7b-b751-f47c4609b38b.8584331c-95f0-4893-b587-0a4f0ff99f6f'
3: I1120 01:14:39.014456 15991 http.cpp:2589] Processing WAIT_NESTED_CONTAINER call for container '01f75792-8059-4b7b-b751-f47c4609b38b.d1e38821-7ee5-40d9-b0b8-293e64078c44'
3: I1120 01:14:39.038260 15998 process.cpp:3932] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1120 01:14:39.039029 15998 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.7:49006
3: I1120 01:14:39.039520 15998 master.cpp:5791] Processing ACKNOWLEDGE call 46ea2a3a-2906-476b-be27-e2c90e630964 for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (default) on agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0
3: I1120 01:14:39.039994 16003 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 46ea2a3a-2906-476b-be27-e2c90e630964) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.040112 15984 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.7:49006
3: I1120 01:14:39.040293 16001 slave.cpp:3801] Status update manager successfully handled status update acknowledgement (UUID: 46ea2a3a-2906-476b-be27-e2c90e630964) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.040479 15984 master.cpp:5791] Processing ACKNOWLEDGE call f6c1b212-d510-4b24-af11-73db774d9124 for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (default) on agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0
3: I1120 01:14:39.040792 15994 status_update_manager.cpp:395] Received status update acknowledgement (UUID: f6c1b212-d510-4b24-af11-73db774d9124) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.041036 15989 slave.cpp:3801] Status update manager successfully handled status update acknowledgement (UUID: f6c1b212-d510-4b24-af11-73db774d9124) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.049749 16002 process.cpp:3932] Handling HTTP event for process 'slave(803)' with path: '/slave(803)/api/v1/executor'
3: I1120 01:14:39.050374 16002 http.cpp:1185] HTTP POST for /slave(803)/api/v1/executor from 172.17.0.7:49012
3: I1120 01:14:39.050611 16002 slave.cpp:4517] Handling status update TASK_RUNNING (UUID: f0a37c9a-cc51-421e-bc1d-129ad5abdaef) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.051304 15999 http.cpp:1185] HTTP POST for /slave(803)/api/v1/executor from 172.17.0.7:49012
3: I1120 01:14:39.051514 15999 slave.cpp:4517] Handling status update TASK_RUNNING (UUID: 6a619f90-255b-4ef5-8fe2-a9b2caa8f774) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.052181 15982 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: f0a37c9a-cc51-421e-bc1d-129ad5abdaef) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.052330 15982 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: f0a37c9a-cc51-421e-bc1d-129ad5abdaef) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 to the agent
3: I1120 01:14:39.052685 15982 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 6a619f90-255b-4ef5-8fe2-a9b2caa8f774) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.052726 15995 slave.cpp:4998] Forwarding the update TASK_RUNNING (UUID: f0a37c9a-cc51-421e-bc1d-129ad5abdaef) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 to master@172.17.0.7:46848
3: I1120 01:14:39.052834 15982 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 6a619f90-255b-4ef5-8fe2-a9b2caa8f774) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 to the agent
3: I1120 01:14:39.052976 15995 slave.cpp:4892] Status update manager successfully handled status update TASK_RUNNING (UUID: f0a37c9a-cc51-421e-bc1d-129ad5abdaef) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.053220 15997 master.cpp:7247] Status update TASK_RUNNING (UUID: f0a37c9a-cc51-421e-bc1d-129ad5abdaef) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 from agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 at slave(803)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.053268 15995 slave.cpp:4998] Forwarding the update TASK_RUNNING (UUID: 6a619f90-255b-4ef5-8fe2-a9b2caa8f774) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 to master@172.17.0.7:46848
3: I1120 01:14:39.053294 15997 master.cpp:7309] Forwarding status update TASK_RUNNING (UUID: f0a37c9a-cc51-421e-bc1d-129ad5abdaef) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.053452 15995 slave.cpp:4892] Status update manager successfully handled status update TASK_RUNNING (UUID: 6a619f90-255b-4ef5-8fe2-a9b2caa8f774) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.054149 15997 master.cpp:9502] Updating the state of task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
3: I1120 01:14:39.054453 15997 master.cpp:7247] Status update TASK_RUNNING (UUID: 6a619f90-255b-4ef5-8fe2-a9b2caa8f774) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 from agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 at slave(803)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.054512 15997 master.cpp:7309] Forwarding status update TASK_RUNNING (UUID: 6a619f90-255b-4ef5-8fe2-a9b2caa8f774) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.054535 24470 default_executor.cpp:191] Received ACKNOWLEDGED event
3: I1120 01:14:39.055094 24472 default_executor.cpp:191] Received ACKNOWLEDGED event
3: I1120 01:14:39.055379 15997 master.cpp:9502] Updating the state of task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
3: I1120 01:14:39.056203 15993 scheduler.cpp:741] Enqueuing event UPDATE received from http://172.17.0.7:46848/master/api/v1/scheduler
3: I1120 01:14:39.056941 15984 scheduler.cpp:741] Enqueuing event UPDATE received from http://172.17.0.7:46848/master/api/v1/scheduler
3: I1120 01:14:39.057900 15988 scheduler.cpp:249] Sending ACKNOWLEDGE call to http://172.17.0.7:46848/master/api/v1/scheduler
3: I1120 01:14:39.058282 15988 scheduler.cpp:249] Sending ACKNOWLEDGE call to http://172.17.0.7:46848/master/api/v1/scheduler
3: I1120 01:14:39.059566 15993 process.cpp:3932] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1120 01:14:39.098163 16004 process.cpp:3932] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1120 01:14:39.098928 16004 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.7:49006
3: I1120 01:14:39.099395 16004 master.cpp:5791] Processing ACKNOWLEDGE call f0a37c9a-cc51-421e-bc1d-129ad5abdaef for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (default) on agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0
3: I1120 01:14:39.099831 15985 status_update_manager.cpp:395] Received status update acknowledgement (UUID: f0a37c9a-cc51-421e-bc1d-129ad5abdaef) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.100072 15982 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.7:49006
3: I1120 01:14:39.100167 15995 slave.cpp:3801] Status update manager successfully handled status update acknowledgement (UUID: f0a37c9a-cc51-421e-bc1d-129ad5abdaef) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.100390 15982 master.cpp:5791] Processing ACKNOWLEDGE call 6a619f90-255b-4ef5-8fe2-a9b2caa8f774 for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (default) on agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0
3: I1120 01:14:39.100649 15982 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 6a619f90-255b-4ef5-8fe2-a9b2caa8f774) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.100885 15988 slave.cpp:3801] Status update manager successfully handled status update acknowledgement (UUID: 6a619f90-255b-4ef5-8fe2-a9b2caa8f774) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.128783 16001 containerizer.cpp:2705] Container 01f75792-8059-4b7b-b751-f47c4609b38b.8584331c-95f0-4893-b587-0a4f0ff99f6f has exited
3: I1120 01:14:39.128826 16001 containerizer.cpp:2254] Destroying container 01f75792-8059-4b7b-b751-f47c4609b38b.8584331c-95f0-4893-b587-0a4f0ff99f6f in RUNNING state
3: I1120 01:14:39.128841 16001 containerizer.cpp:2818] Transitioning the state of container 01f75792-8059-4b7b-b751-f47c4609b38b.8584331c-95f0-4893-b587-0a4f0ff99f6f from RUNNING to DESTROYING
3: I1120 01:14:39.129168 16001 containerizer.cpp:2705] Container 01f75792-8059-4b7b-b751-f47c4609b38b.d1e38821-7ee5-40d9-b0b8-293e64078c44 has exited
3: I1120 01:14:39.129191 16001 containerizer.cpp:2254] Destroying container 01f75792-8059-4b7b-b751-f47c4609b38b.d1e38821-7ee5-40d9-b0b8-293e64078c44 in RUNNING state
3: I1120 01:14:39.129204 16001 containerizer.cpp:2818] Transitioning the state of container 01f75792-8059-4b7b-b751-f47c4609b38b.d1e38821-7ee5-40d9-b0b8-293e64078c44 from RUNNING to DESTROYING
3: I1120 01:14:39.129441 16001 launcher.cpp:156] Asked to destroy container 01f75792-8059-4b7b-b751-f47c4609b38b.8584331c-95f0-4893-b587-0a4f0ff99f6f
3: I1120 01:14:39.131182 16001 launcher.cpp:156] Asked to destroy container 01f75792-8059-4b7b-b751-f47c4609b38b.d1e38821-7ee5-40d9-b0b8-293e64078c44
3: I1120 01:14:39.133862 15984 provisioner.cpp:490] Ignoring destroy request for unknown container 01f75792-8059-4b7b-b751-f47c4609b38b.8584331c-95f0-4893-b587-0a4f0ff99f6f
3: I1120 01:14:39.134045 15998 containerizer.cpp:2543] Checkpointing termination state to nested container's runtime directory '/tmp/ContentType_SchedulerTest_TaskGroupRunning_1_is1iMe/containers/01f75792-8059-4b7b-b751-f47c4609b38b/containers/8584331c-95f0-4893-b587-0a4f0ff99f6f/termination'
3: I1120 01:14:39.135404 16003 provisioner.cpp:490] Ignoring destroy request for unknown container 01f75792-8059-4b7b-b751-f47c4609b38b.d1e38821-7ee5-40d9-b0b8-293e64078c44
3: I1120 01:14:39.135566 15994 containerizer.cpp:2543] Checkpointing termination state to nested container's runtime directory '/tmp/ContentType_SchedulerTest_TaskGroupRunning_1_is1iMe/containers/01f75792-8059-4b7b-b751-f47c4609b38b/containers/d1e38821-7ee5-40d9-b0b8-293e64078c44/termination'
3: I1120 01:14:39.139070 15985 process.cpp:3932] Handling HTTP event for process 'slave(803)' with path: '/slave(803)/api/v1/executor'
3: I1120 01:14:39.150482 24479 default_executor.cpp:888] Child container 01f75792-8059-4b7b-b751-f47c4609b38b.8584331c-95f0-4893-b587-0a4f0ff99f6f of task '1' completed in state TASK_FINISHED: Command exited with status 0
3: I1120 01:14:39.150810 24479 default_executor.cpp:888] Child container 01f75792-8059-4b7b-b751-f47c4609b38b.d1e38821-7ee5-40d9-b0b8-293e64078c44 of task '2' completed in state TASK_FINISHED: Command exited with status 0
3: I1120 01:14:39.150825 24479 default_executor.cpp:1017] Terminating after 1secs
3: I1120 01:14:39.178200 16000 process.cpp:3932] Handling HTTP event for process 'slave(803)' with path: '/slave(803)/api/v1/executor'
3: I1120 01:14:39.179289 16000 http.cpp:1185] HTTP POST for /slave(803)/api/v1/executor from 172.17.0.7:49012
3: I1120 01:14:39.179642 16000 slave.cpp:4517] Handling status update TASK_FINISHED (UUID: 638c648e-7c1f-4305-9d36-e1021db7ccf2) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.180991 16000 http.cpp:1185] HTTP POST for /slave(803)/api/v1/executor from 172.17.0.7:49012
3: I1120 01:14:39.181195 16000 slave.cpp:4517] Handling status update TASK_FINISHED (UUID: f971785c-1b40-49f4-8d6f-52586cca0957) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.182356 15995 status_update_manager.cpp:323] Received status update TASK_FINISHED (UUID: 638c648e-7c1f-4305-9d36-e1021db7ccf2) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.182561 15995 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: 638c648e-7c1f-4305-9d36-e1021db7ccf2) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 to the agent
3: I1120 01:14:39.182780 15982 slave.cpp:4998] Forwarding the update TASK_FINISHED (UUID: 638c648e-7c1f-4305-9d36-e1021db7ccf2) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 to master@172.17.0.7:46848
3: I1120 01:14:39.183064 15982 slave.cpp:4892] Status update manager successfully handled status update TASK_FINISHED (UUID: 638c648e-7c1f-4305-9d36-e1021db7ccf2) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.183285 15988 master.cpp:7247] Status update TASK_FINISHED (UUID: 638c648e-7c1f-4305-9d36-e1021db7ccf2) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 from agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 at slave(803)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.183351 15988 master.cpp:7309] Forwarding status update TASK_FINISHED (UUID: 638c648e-7c1f-4305-9d36-e1021db7ccf2) for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.183480 15986 status_update_manager.cpp:323] Received status update TASK_FINISHED (UUID: f971785c-1b40-49f4-8d6f-52586cca0957) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.183640 15986 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: f971785c-1b40-49f4-8d6f-52586cca0957) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 to the agent
3: I1120 01:14:39.183861 16003 slave.cpp:4998] Forwarding the update TASK_FINISHED (UUID: f971785c-1b40-49f4-8d6f-52586cca0957) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 to master@172.17.0.7:46848
3: I1120 01:14:39.184072 16003 slave.cpp:4892] Status update manager successfully handled status update TASK_FINISHED (UUID: f971785c-1b40-49f4-8d6f-52586cca0957) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.184234 15988 master.cpp:9502] Updating the state of task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
3: I1120 01:14:39.184811 15988 master.cpp:7247] Status update TASK_FINISHED (UUID: f971785c-1b40-49f4-8d6f-52586cca0957) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 from agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 at slave(803)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.184875 15988 master.cpp:7309] Forwarding status update TASK_FINISHED (UUID: f971785c-1b40-49f4-8d6f-52586cca0957) for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.185093 15998 hierarchical.cpp:1132] Recovered cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):32 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: cpus(allocated: *):0.2; mem(allocated: *):64; disk(allocated: *):64) on agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 from framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.185564 15988 master.cpp:9502] Updating the state of task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
3: I1120 01:14:39.185775 16002 scheduler.cpp:741] Enqueuing event UPDATE received from http://172.17.0.7:46848/master/api/v1/scheduler
3: I1120 01:14:39.186244 15985 hierarchical.cpp:1132] Recovered cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):32 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):32) on agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 from framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.186781 15996 scheduler.cpp:741] Enqueuing event UPDATE received from http://172.17.0.7:46848/master/api/v1/scheduler
3: I1120 01:14:39.188446 16005 master.cpp:1423] Framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (default) disconnected
3: I1120 01:14:39.188475 16005 master.cpp:3331] Deactivating framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (default)
3: I1120 01:14:39.188556 16005 master.cpp:3308] Disconnecting framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (default)
3: I1120 01:14:39.188587 16005 master.cpp:1438] Giving framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (default) 0ns to failover
3: I1120 01:14:39.188616 15985 hierarchical.cpp:419] Deactivated framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.190241 15988 master.cpp:7947] Framework failover timeout, removing framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (default)
3: I1120 01:14:39.190276 15988 master.cpp:8804] Removing framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (default)
3: I1120 01:14:39.190440 15982 slave.cpp:3267] Asked to shut down framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 by master@172.17.0.7:46848
3: I1120 01:14:39.190439 15988 master.cpp:9502] Updating the state of task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (latest state: TASK_FINISHED, status update state: TASK_KILLED)
3: I1120 01:14:39.190490 15982 slave.cpp:3292] Shutting down framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.190546 15982 slave.cpp:5874] Shutting down executor 'E' of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (via HTTP)
3: I1120 01:14:39.190498 15988 master.cpp:9596] Removing task 2 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":32.0},"type":"SCALAR"}] of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 on agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 at slave(803)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.191123 15988 master.cpp:9502] Updating the state of task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (latest state: TASK_FINISHED, status update state: TASK_KILLED)
3: I1120 01:14:39.191159 15988 master.cpp:9596] Removing task 1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":32.0},"type":"SCALAR"}] of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 on agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 at slave(803)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.191795 15988 master.cpp:9625] Removing executor 'E' with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":32.0},"type":"SCALAR"}] of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 on agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 at slave(803)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.192757 15996 hierarchical.cpp:1132] Recovered cpus(allocated: *):0.1; mem(allocated: *):32; disk(allocated: *):32 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 from framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.193069 15996 hierarchical.cpp:358] Removed framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.193753 15994 containerizer.cpp:2254] Destroying container 01f75792-8059-4b7b-b751-f47c4609b38b in RUNNING state
3: I1120 01:14:39.193778 15994 containerizer.cpp:2818] Transitioning the state of container 01f75792-8059-4b7b-b751-f47c4609b38b from RUNNING to DESTROYING
3: I1120 01:14:39.194190 15994 launcher.cpp:156] Asked to destroy container 01f75792-8059-4b7b-b751-f47c4609b38b
3: I1120 01:14:39.230080 15988 containerizer.cpp:2705] Container 01f75792-8059-4b7b-b751-f47c4609b38b has exited
3: I1120 01:14:39.232380 15982 provisioner.cpp:490] Ignoring destroy request for unknown container 01f75792-8059-4b7b-b751-f47c4609b38b
3: I1120 01:14:39.233961 15996 slave.cpp:5539] Executor 'E' of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 terminated with signal Killed
3: I1120 01:14:39.234117 15996 slave.cpp:5643] Cleaning up executor 'E' of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 (via HTTP)
3: I1120 01:14:39.234400 15988 gc.cpp:90] Scheduling '/tmp/ContentType_SchedulerTest_TaskGroupRunning_1_B9IOD5/slaves/6d207ac8-1813-4783-96c9-d785e5940c1a-S0/frameworks/6d207ac8-1813-4783-96c9-d785e5940c1a-0000/executors/E/runs/01f75792-8059-4b7b-b751-f47c4609b38b' for gc 6.99999728804444days in the future
3: W1120 01:14:39.234465 15991 master.cpp:7453] Ignoring unknown exited executor 'E' of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000 on agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 at slave(803)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.234701 15996 slave.cpp:5750] Cleaning up framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.234694 16001 gc.cpp:90] Scheduling '/tmp/ContentType_SchedulerTest_TaskGroupRunning_1_B9IOD5/slaves/6d207ac8-1813-4783-96c9-d785e5940c1a-S0/frameworks/6d207ac8-1813-4783-96c9-d785e5940c1a-0000/executors/E' for gc 6.99999728459556days in the future
3: I1120 01:14:39.234809 15993 status_update_manager.cpp:285] Closing status update streams for framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.234869 15993 status_update_manager.cpp:531] Cleaning up status update stream for task 2 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.234887 16002 gc.cpp:90] Scheduling '/tmp/ContentType_SchedulerTest_TaskGroupRunning_1_B9IOD5/slaves/6d207ac8-1813-4783-96c9-d785e5940c1a-S0/frameworks/6d207ac8-1813-4783-96c9-d785e5940c1a-0000' for gc 6.99999728222222days in the future
3: I1120 01:14:39.234941 15996 slave.cpp:883] Agent terminating
3: I1120 01:14:39.235163 16005 master.cpp:1309] Agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 at slave(803)@172.17.0.7:46848 (5c2fd91c1d19) disconnected
3: I1120 01:14:39.235210 16005 master.cpp:3368] Disconnecting agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 at slave(803)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.235283 15993 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 6d207ac8-1813-4783-96c9-d785e5940c1a-0000
3: I1120 01:14:39.235303 16005 master.cpp:3387] Deactivating agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 at slave(803)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.235414 15982 hierarchical.cpp:697] Agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0 deactivated
3: I1120 01:14:39.242255 15981 master.cpp:1151] Master terminating
3: I1120 01:14:39.243101 15983 hierarchical.cpp:633] Removed agent 6d207ac8-1813-4783-96c9-d785e5940c1a-S0
3: [ OK ] ContentType/SchedulerTest.TaskGroupRunning/1 (607 ms)
3: [ RUN ] ContentType/SchedulerTest.ReconcileTask/0
3: I1120 01:14:39.253093 15981 cluster.cpp:162] Creating default 'local' authorizer
3: I1120 01:14:39.256054 15992 master.cpp:448] Master f5f6eda5-c18e-4d6f-8f79-b479133c2d11 (5c2fd91c1d19) started on 172.17.0.7:46848
3: I1120 01:14:39.256076 15992 master.cpp:450] 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/XaKCEY/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/XaKCEY/master" --zk_session_timeout="10secs"
3: I1120 01:14:39.256395 15992 master.cpp:499] Master only allowing authenticated frameworks to register
3: I1120 01:14:39.256403 15992 master.cpp:505] Master only allowing authenticated agents to register
3: I1120 01:14:39.256407 15992 master.cpp:511] Master only allowing authenticated HTTP frameworks to register
3: I1120 01:14:39.256413 15992 credentials.hpp:37] Loading credentials for authentication from '/tmp/XaKCEY/credentials'
3: I1120 01:14:39.256752 15992 master.cpp:555] Using default 'crammd5' authenticator
3: I1120 01:14:39.256922 15992 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
3: I1120 01:14:39.257107 15992 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
3: I1120 01:14:39.257264 15992 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
3: I1120 01:14:39.257407 15992 master.cpp:634] Authorization enabled
3: I1120 01:14:39.257580 16000 hierarchical.cpp:173] Initialized hierarchical allocator process
3: I1120 01:14:39.257614 16002 whitelist_watcher.cpp:77] No whitelist given
3: I1120 01:14:39.260541 15997 master.cpp:2213] Elected as the leading master!
3: I1120 01:14:39.260571 15997 master.cpp:1693] Recovering from registrar
3: I1120 01:14:39.260709 15996 registrar.cpp:347] Recovering registrar
3: I1120 01:14:39.261302 15996 registrar.cpp:391] Successfully fetched the registry (0B) in 554240ns
3: I1120 01:14:39.261420 15996 registrar.cpp:495] Applied 1 operations in 37175ns; attempting to update the registry
3: I1120 01:14:39.262004 15996 registrar.cpp:552] Successfully updated the registry in 529152ns
3: I1120 01:14:39.262132 15996 registrar.cpp:424] Successfully recovered registrar
3: I1120 01:14:39.262502 15986 master.cpp:1806] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1120 01:14:39.262514 15994 hierarchical.cpp:211] Skipping recovery of hierarchical allocator: nothing to recover
3: W1120 01:14:39.267102 15981 process.cpp:3185] Attempted to spawn already running process files@172.17.0.7:46848
3: I1120 01:14:39.267398 15981 cluster.cpp:448] Creating default 'local' authorizer
3: I1120 01:14:39.269489 15999 slave.cpp:262] Mesos agent started on (804)@172.17.0.7:46848
3: I1120 01:14:39.269510 15999 slave.cpp:263] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_SchedulerTest_ReconcileTask_0_3yXmRj/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/ContentType_SchedulerTest_ReconcileTask_0_3yXmRj/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/ContentType_SchedulerTest_ReconcileTask_0_3yXmRj/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_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_SchedulerTest_ReconcileTask_0_3yXmRj/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/ContentType_SchedulerTest_ReconcileTask_0_3yXmRj/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/ContentType_SchedulerTest_ReconcileTask_0_3yXmRj" --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/ContentType_SchedulerTest_ReconcileTask_0_AgkZf9" --zk_session_timeout="10secs"
3: I1120 01:14:39.269851 15999 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_SchedulerTest_ReconcileTask_0_3yXmRj/credential'
3: I1120 01:14:39.269997 15999 slave.cpp:295] Agent using credential for: test-principal
3: I1120 01:14:39.270015 15999 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_SchedulerTest_ReconcileTask_0_3yXmRj/http_credentials'
3: I1120 01:14:39.270182 15981 scheduler.cpp:190] Version: 1.5.0
3: I1120 01:14:39.270222 15999 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1120 01:14:39.270354 15999 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
3: I1120 01:14:39.270462 15991 scheduler.cpp:313] Using default 'basic' HTTP authenticatee
3: I1120 01:14:39.270812 16001 scheduler.cpp:496] New master detected at master@172.17.0.7:46848
3: I1120 01:14:39.270838 16001 scheduler.cpp:505] Waiting for 0ns before initiating a re-(connection) attempt with the master
3: I1120 01:14:39.271786 15999 slave.cpp:593] 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"}]
3: I1120 01:14:39.272016 15999 slave.cpp:601] Agent attributes: [ ]
3: I1120 01:14:39.272027 15999 slave.cpp:610] Agent hostname: 5c2fd91c1d19
3: I1120 01:14:39.272168 15992 status_update_manager.cpp:177] Pausing sending status updates
3: I1120 01:14:39.273722 15982 state.cpp:64] Recovering state from '/tmp/ContentType_SchedulerTest_ReconcileTask_0_AgkZf9/meta'
3: I1120 01:14:39.273993 15982 status_update_manager.cpp:203] Recovering status update manager
3: I1120 01:14:39.274215 15995 scheduler.cpp:387] Connected with the master at http://172.17.0.7:46848/master/api/v1/scheduler
3: I1120 01:14:39.274348 15988 slave.cpp:6441] Finished recovery
3: I1120 01:14:39.274997 15999 status_update_manager.cpp:177] Pausing sending status updates
3: I1120 01:14:39.275045 15988 slave.cpp:1007] New master detected at master@172.17.0.7:46848
3: I1120 01:14:39.275156 15988 slave.cpp:1042] Detecting new master
3: I1120 01:14:39.275326 15987 scheduler.cpp:249] Sending SUBSCRIBE call to http://172.17.0.7:46848/master/api/v1/scheduler
3: I1120 01:14:39.276154 15994 slave.cpp:1069] Authenticating with master master@172.17.0.7:46848
3: I1120 01:14:39.276216 15994 slave.cpp:1078] Using default CRAM-MD5 authenticatee
3: I1120 01:14:39.276450 16004 authenticatee.cpp:121] Creating new client SASL connection
3: I1120 01:14:39.276711 15986 master.cpp:8285] Authenticating slave(804)@172.17.0.7:46848
3: I1120 01:14:39.276818 15984 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1459)@172.17.0.7:46848
3: I1120 01:14:39.276893 15986 process.cpp:3932] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1120 01:14:39.277050 15995 authenticator.cpp:98] Creating new server SASL connection
3: I1120 01:14:39.277273 15992 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1120 01:14:39.277295 15992 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1120 01:14:39.277412 16000 authenticator.cpp:204] Received SASL authentication start
3: I1120 01:14:39.277465 16000 authenticator.cpp:326] Authentication requires more steps
3: I1120 01:14:39.277571 15997 authenticatee.cpp:259] Received SASL authentication step
3: I1120 01:14:39.277707 15985 authenticator.cpp:232] Received SASL authentication step
3: I1120 01:14:39.277741 15985 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5c2fd91c1d19' server FQDN: '5c2fd91c1d19' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1120 01:14:39.277753 15985 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1120 01:14:39.277787 15985 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1120 01:14:39.277804 15985 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5c2fd91c1d19' server FQDN: '5c2fd91c1d19' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1120 01:14:39.277814 15985 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1120 01:14:39.277820 15985 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1120 01:14:39.277832 15985 authenticator.cpp:318] Authentication success
3: I1120 01:14:39.277899 15983 authenticatee.cpp:299] Authentication success
3: I1120 01:14:39.277973 16005 master.cpp:8315] Successfully authenticated principal 'test-principal' at slave(804)@172.17.0.7:46848
3: I1120 01:14:39.278026 15989 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1459)@172.17.0.7:46848
3: I1120 01:14:39.278132 15988 slave.cpp:1161] Successfully authenticated with master master@172.17.0.7:46848
3: I1120 01:14:39.278338 16004 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.7:49022
3: I1120 01:14:39.278357 15988 slave.cpp:1682] Will retry registration in 19.999837ms if necessary
3: I1120 01:14:39.278553 16004 master.cpp:2613] Received subscription request for HTTP framework 'default'
3: I1120 01:14:39.278657 16004 master.cpp:2278] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
3: I1120 01:14:39.279132 16004 master.cpp:6032] Received register agent message from slave(804)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.279250 16004 master.cpp:3870] Authorizing agent with principal 'test-principal'
3: I1120 01:14:39.279381 16004 master.cpp:2748] Subscribing framework 'default' with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1120 01:14:39.280035 16004 master.cpp:6092] Authorized registration of agent at slave(804)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.280093 15995 hierarchical.cpp:306] Added framework f5f6eda5-c18e-4d6f-8f79-b479133c2d11-0000
3: I1120 01:14:39.280148 16004 master.cpp:6185] Registering agent at slave(804)@172.17.0.7:46848 (5c2fd91c1d19) with id f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0
3: I1120 01:14:39.280284 15995 hierarchical.cpp:1457] Performed allocation for 0 agents in 72502ns
3: I1120 01:14:39.280570 15991 registrar.cpp:495] Applied 1 operations in 56482ns; attempting to update the registry
3: I1120 01:14:39.280668 16003 scheduler.cpp:741] Enqueuing event SUBSCRIBED received from http://172.17.0.7:46848/master/api/v1/scheduler
3: I1120 01:14:39.281062 16003 scheduler.cpp:741] Enqueuing event HEARTBEAT received from http://172.17.0.7:46848/master/api/v1/scheduler
3: I1120 01:14:39.281128 15991 registrar.cpp:552] Successfully updated the registry in 491264ns
3: I1120 01:14:39.281363 16002 master.cpp:6232] Admitted agent f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0 at slave(804)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.282016 16004 slave.cpp:1207] Registered with master master@172.17.0.7:46848; given agent ID f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0
3: I1120 01:14:39.282091 15988 status_update_manager.cpp:184] Resuming sending status updates
3: I1120 01:14:39.281934 16002 master.cpp:6263] Registered agent f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0 at slave(804)@172.17.0.7:46848 (5c2fd91c1d19) 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"}]
3: I1120 01:14:39.282310 15982 hierarchical.cpp:600] Added agent f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0 (5c2fd91c1d19) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
3: I1120 01:14:39.282330 16004 slave.cpp:1227] Checkpointing SlaveInfo to '/tmp/ContentType_SchedulerTest_ReconcileTask_0_AgkZf9/meta/slaves/f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0/slave.info'
3: I1120 01:14:39.282711 16004 slave.cpp:1295] Forwarding total oversubscribed resources {}
3: I1120 01:14:39.282883 16005 master.cpp:7064] Received update of agent f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0 at slave(804)@172.17.0.7:46848 (5c2fd91c1d19) with total oversubscribed resources {}
3: I1120 01:14:39.283056 16005 master.cpp:7082] Ignoring update on agent f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0 at slave(804)@172.17.0.7:46848 (5c2fd91c1d19) as it reports no changes
3: I1120 01:14:39.283588 15982 hierarchical.cpp:1457] Performed allocation for 1 agents in 1.11516ms
3: I1120 01:14:39.284035 15989 master.cpp:8115] Sending 1 offers to framework f5f6eda5-c18e-4d6f-8f79-b479133c2d11-0000 (default)
3: I1120 01:14:39.285467 15992 scheduler.cpp:741] Enqueuing event OFFERS received from http://172.17.0.7:46848/master/api/v1/scheduler
3: I1120 01:14:39.287211 15996 scheduler.cpp:249] Sending ACCEPT call to http://172.17.0.7:46848/master/api/v1/scheduler
3: I1120 01:14:39.288595 16002 process.cpp:3932] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1120 01:14:39.289746 15986 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.7:49020
3: I1120 01:14:39.290676 15986 master.cpp:10024] Removing offer f5f6eda5-c18e-4d6f-8f79-b479133c2d11-O0
3: I1120 01:14:39.290822 15986 master.cpp:4228] Processing ACCEPT call for offers: [ f5f6eda5-c18e-4d6f-8f79-b479133c2d11-O0 ] on agent f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0 at slave(804)@172.17.0.7:46848 (5c2fd91c1d19) for framework f5f6eda5-c18e-4d6f-8f79-b479133c2d11-0000 (default)
3: I1120 01:14:39.290935 15986 master.cpp:3597] Authorizing framework principal 'test-principal' to launch task 69c8bdd9-5897-4da2-a20b-72653f1ef574
3: W1120 01:14:39.292707 15986 validation.cpp:1391] Executor 'default' for task '69c8bdd9-5897-4da2-a20b-72653f1ef574' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
3: W1120 01:14:39.292734 15986 validation.cpp:1403] Executor 'default' for task '69c8bdd9-5897-4da2-a20b-72653f1ef574' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
3: I1120 01:14:39.293331 15986 master.cpp:10770] Adding task 69c8bdd9-5897-4da2-a20b-72653f1ef574 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 f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0 at slave(804)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.293969 15986 master.cpp:4976] Launching task 69c8bdd9-5897-4da2-a20b-72653f1ef574 of framework f5f6eda5-c18e-4d6f-8f79-b479133c2d11-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 f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0 at slave(804)@172.17.0.7:46848 (5c2fd91c1d19)
3: I1120 01:14:39.294584 15983 slave.cpp:1803] Got assigned task '69c8bdd9-5897-4da2-a20b-72653f1ef574' for framework f5f6eda5-c18e-4d6f-8f79-b479133c2d11-0000
3: I1120 01:14:39.295167 15983 slave.cpp:2071] Authorizing task '69c8bdd9-5897-4da2-a20b-72653f1ef574' for framework f5f6eda5-c18e-4d6f-8f79-b479133c2d11-0000
3: I1120 01:14:39.295224 15983 slave.cpp:7262] Authorizing framework principal 'test-principal' to launch task 69c8bdd9-5897-4da2-a20b-72653f1ef574
3: I1120 01:14:39.295907 15996 slave.cpp:2239] Launching task '69c8bdd9-5897-4da2-a20b-72653f1ef574' for framework f5f6eda5-c18e-4d6f-8f79-b479133c2d11-0000
3: I1120 01:14:39.296460 15996 paths.cpp:621] Trying to chown '/tmp/ContentType_SchedulerTest_ReconcileTask_0_AgkZf9/slaves/f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0/frameworks/f5f6eda5-c18e-4d6f-8f79-b479133c2d11-0000/executors/default/runs/2b0109f4-437e-4dcc-bfc2-d25df2b4f1f6' to user 'mesos'
3: I1120 01:14:39.296711 15996 slave.cpp:7736] Launching executor 'default' of framework f5f6eda5-c18e-4d6f-8f79-b479133c2d11-0000 with resources [] in work directory '/tmp/ContentType_SchedulerTest_ReconcileTask_0_AgkZf9/slaves/f5f6eda5-c18e-4d6f-8f79-b479133c2d11-S0/frameworks/f5f6eda5-c18e-4d6f-8f79-b479133c2d11-0000/executors/default/runs/2b0109f4-437e-4dcc-bfc2-d25df2b4f1f6'
3: I1120 01:14:39.297264 15996 slave.cpp:2930] Launching container 2b0109f4-437e-4dcc-bfc2-d25df2b4f1f6 for executor 'default' of framework f5f6eda5-c18e-4d6f-8f79-b479133c2d11-0000
3: I1120 01:14:39.297628 15996 slave.cpp:2467] Queued task '69c8bdd9-5897-4da2-a20b-72653f1ef574' for executor 'default' of framework f5f6eda5-c18e-4d6f-8f79-b479133c2d11-0000
write /dev/stdout: resource temporarily unavailable
+ docker rmi mesos-1511138420-18878
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose --disable-libtool-wrappers,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4474
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4474/display/redirect?page=changes>