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/07/16 12:20:04 UTC

Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3918

See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3918/display/redirect>

------------------------------------------
[...truncated 9.82 MB...]
I0716 08:05:25.042853  1055 master.cpp:8958] Removing task 1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":128.0},"type":"SCALAR"}] of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S0 at slave(2)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.043578  1056 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 275d2605-ecc4-4996-90b4-6bd3eff2586d) for task 1 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.043752  1056 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.044373  1068 slave.cpp:3613] Status update manager successfully handled status update acknowledgement (UUID: 275d2605-ecc4-4996-90b4-6bd3eff2586d) for task 1 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.044430  1068 slave.cpp:7590] Completing task 1
I0716 08:05:25.059339  1060 leveldb.cpp:341] Persisting action (688 bytes) to leveldb took 24.995867ms
I0716 08:05:25.059371  1060 replica.cpp:711] Persisted action APPEND at position 7
I0716 08:05:25.059998  1060 replica.cpp:694] Replica received learned notice for position 7 from @0.0.0.0:0
I0716 08:05:25.093080  1060 leveldb.cpp:341] Persisting action (690 bytes) to leveldb took 32.98745ms
I0716 08:05:25.093158  1060 replica.cpp:711] Persisted action APPEND at position 7
I0716 08:05:25.094801  1066 registrar.cpp:550] Successfully updated the registry in 64.232192ms
I0716 08:05:25.095098  1069 log.cpp:579] Attempting to truncate the log to 7
I0716 08:05:25.095094  1057 master.cpp:5877] Admitted agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 at slave(1)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.095218  1063 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 8
I0716 08:05:25.095876  1069 slave.cpp:4905] Received ping from slave-observer(3)@172.17.0.4:48627
I0716 08:05:25.096051  1069 slave.cpp:1174] Registered with master master@172.17.0.4:48627; given agent ID 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2
I0716 08:05:25.096133  1065 replica.cpp:540] Replica received write request for position 8 from __req_res__(13)@172.17.0.4:48627
I0716 08:05:25.096218  1068 status_update_manager.cpp:184] Resuming sending status updates
I0716 08:05:25.095942  1057 master.cpp:5908] Registered agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 at slave(1)@172.17.0.4:48627 (7b5eea8b2f31) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":10240.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":3701220.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0716 08:05:25.096477  1069 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/mesos-fiPBpS/agents/0/work/meta/slaves/2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2/slave.info'
I0716 08:05:25.096456  1062 hierarchical.cpp:593] Added agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 (7b5eea8b2f31) with cpus:2; mem:10240; disk:3701220; ports:[31000-32000] (allocated: {})
I0716 08:05:25.096920  1069 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0716 08:05:25.097081  1069 master.cpp:6624] Received update of agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 at slave(1)@172.17.0.4:48627 (7b5eea8b2f31) with total oversubscribed resources {}
I0716 08:05:25.098006  1062 hierarchical.cpp:2015] No inverse offers to send out!
I0716 08:05:25.098071  1062 hierarchical.cpp:1468] Performed allocation for 1 agents in 1.378451ms
I0716 08:05:25.098248  1062 hierarchical.cpp:660] Agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 (7b5eea8b2f31) updated with total resources cpus:2; mem:10240; disk:3701220; ports:[31000-32000]
I0716 08:05:25.098639  1068 master.cpp:7603] Sending 1 offers to framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (Event Call Scheduler using libprocess (C++))
I0716 08:05:25.100872  1068 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.4:48627/master/api/v1/scheduler

Received an OFFERS event
Received offer 2773c70a-f7ef-4738-b522-8fec4d3cc35e-O2 with cpus(allocated: *):2; mem(allocated: *):10240; disk(allocated: *):3701220; ports(allocated: *):[31000-32000]
Launching task 4 using offer 2773c70a-f7ef-4738-b522-8fec4d3cc35e-O2
I0716 08:05:25.103077  1056 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.4:48627/master/api/v1/scheduler
I0716 08:05:25.104734  1057 process.cpp:3820] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0716 08:05:25.118634  1065 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 22.454055ms
I0716 08:05:25.118672  1065 replica.cpp:711] Persisted action TRUNCATE at position 8
I0716 08:05:25.119359  1059 replica.cpp:694] Replica received learned notice for position 8 from @0.0.0.0:0
I0716 08:05:25.143450  1058 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:41432
I0716 08:05:25.143796  1059 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 24.378228ms
I0716 08:05:25.143908  1059 leveldb.cpp:399] Deleting ~2 keys from leveldb took 63662ns
I0716 08:05:25.143954  1059 replica.cpp:711] Persisted action TRUNCATE at position 8
I0716 08:05:25.144768  1058 master.cpp:4123] Processing ACCEPT call for offers: [ 2773c70a-f7ef-4738-b522-8fec4d3cc35e-O2 ] on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 at slave(1)@172.17.0.4:48627 (7b5eea8b2f31) for framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (Event Call Scheduler using libprocess (C++))
I0716 08:05:25.144868  1058 master.cpp:3500] Authorizing framework principal 'test-principal' to launch task 4
W0716 08:05:25.146947  1058 validation.cpp:1294] Executor 'default' for task '4' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0716 08:05:25.146975  1058 validation.cpp:1306] Executor 'default' for task '4' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0716 08:05:25.147408  1058 master.cpp:9654] Adding task 4 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":128.0},"type":"SCALAR"}] on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 at slave(1)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.147938  1058 master.cpp:4786] Launching task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (Event Call Scheduler using libprocess (C++)) with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":128.0},"type":"SCALAR"}] on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 at slave(1)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.148641  1068 slave.cpp:1697] Got assigned task '4' for framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.149375  1068 slave.cpp:1978] Authorizing task '4' for framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.149430  1068 slave.cpp:6729] Authorizing framework principal 'test-principal' to launch task 4
I0716 08:05:25.150398  1056 slave.cpp:2165] Launching task '4' for framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.150823  1069 hierarchical.cpp:887] Updated allocation of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 from cpus(allocated: *):2; mem(allocated: *):10240; disk(allocated: *):3701220; ports(allocated: *):[31000-32000] to cpus(allocated: *):2; mem(allocated: *):10240; disk(allocated: *):3701220; ports(allocated: *):[31000-32000]
I0716 08:05:25.152055  1069 hierarchical.cpp:1152] Recovered cpus(allocated: *):1; mem(allocated: *):10112; disk(allocated: *):3701220; ports(allocated: *):[31000-32000] (total: cpus:2; mem:10240; disk:3701220; ports:[31000-32000], allocated: cpus(allocated: *):1; mem(allocated: *):128) on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 from framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.152135  1069 hierarchical.cpp:1189] Framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 filtered agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 for 5secs
I0716 08:05:25.153082  1056 paths.cpp:578] Trying to chown '/tmp/mesos-fiPBpS/agents/0/work/slaves/2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2/frameworks/2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000/executors/default/runs/bb33156f-7d90-48ac-8a8c-45d870ed1f3b' to user 'mesos'
I0716 08:05:25.153309  1056 slave.cpp:7189] Launching executor 'default' of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 with resources [] in work directory '/tmp/mesos-fiPBpS/agents/0/work/slaves/2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2/frameworks/2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000/executors/default/runs/bb33156f-7d90-48ac-8a8c-45d870ed1f3b'
I0716 08:05:25.153733  1056 slave.cpp:2860] Launching container bb33156f-7d90-48ac-8a8c-45d870ed1f3b for executor 'default' of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.153949  1069 containerizer.cpp:1056] Starting container bb33156f-7d90-48ac-8a8c-45d870ed1f3b
I0716 08:05:25.154098  1056 slave.cpp:2394] Queued task '4' for executor 'default' of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.154207  1056 slave.cpp:924] Successfully attached file '/tmp/mesos-fiPBpS/agents/0/work/slaves/2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2/frameworks/2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000/executors/default/runs/bb33156f-7d90-48ac-8a8c-45d870ed1f3b'
I0716 08:05:25.154238  1056 slave.cpp:924] Successfully attached file '/tmp/mesos-fiPBpS/agents/0/work/slaves/2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2/frameworks/2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000/executors/default/runs/bb33156f-7d90-48ac-8a8c-45d870ed1f3b'
I0716 08:05:25.158340  1057 containerizer.cpp:1630] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"\/mesos\/build\/src\/test-http-executor"},"environment":{"variables":[{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.4:48627"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/mesos-fiPBpS\/agents\/0\/work\/slaves\/2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2\/frameworks\/2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000\/executors\/default\/runs\/bb33156f-7d90-48ac-8a8c-45d870ed1f3b"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"default"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(1)@172.17.0.4:48627"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/mesos-fiPBpS\/agents\/0\/work\/slaves\/2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2\/frameworks\/2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000\/executors\/default\/runs\/bb33156f-7d90-48ac-8a8c-45d870ed1f3b"}]},"task_environment":{},"user":"mesos","working_directory":"\/tmp\/mesos-fiPBpS\/agents\/0\/work\/slaves\/2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2\/frameworks\/2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000\/executors\/default\/runs\/bb33156f-7d90-48ac-8a8c-45d870ed1f3b"}" --pipe_read="18" --pipe_write="19" --runtime_directory="/tmp/mesos-fiPBpS/agents/0/run/containers/bb33156f-7d90-48ac-8a8c-45d870ed1f3b" --unshare_namespace_mnt="false"'
I0716 08:05:25.160130  1057 launcher.cpp:140] Forked child with pid '1094' for container 'bb33156f-7d90-48ac-8a8c-45d870ed1f3b'
I0716 08:05:25.162349  1058 fetcher.cpp:349] Starting to fetch URIs for container: bb33156f-7d90-48ac-8a8c-45d870ed1f3b, directory: /tmp/mesos-fiPBpS/agents/0/work/slaves/2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2/frameworks/2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000/executors/default/runs/bb33156f-7d90-48ac-8a8c-45d870ed1f3b
I0716 08:05:25.183069  1099 executor.cpp:192] Version: 1.4.0
I0716 08:05:25.192245  1070 process.cpp:3820] Handling HTTP event for process 'slave(3)' with path: '/slave(3)/api/v1/executor'
I0716 08:05:25.194270  1067 http.cpp:1133] HTTP POST for /slave(3)/api/v1/executor from 172.17.0.4:41436
I0716 08:05:25.194581  1067 slave.cpp:3677] Received Subscribe request for HTTP executor 'default' of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.197602  1068 slave.cpp:2607] Sending queued task '2' to executor 'default' of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (via HTTP)
I0716 08:05:25.198242  1068 slave.cpp:2607] Sending queued task '3' to executor 'default' of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (via HTTP)
Received a SUBSCRIBED event
Starting task 2
Finishing task 2
Starting task 3
I0716 08:05:25.202996  1068 process.cpp:3820] Handling HTTP event for process 'slave(3)' with path: '/slave(3)/api/v1/executor'
I0716 08:05:25.204104  1068 process.cpp:3820] Handling HTTP event for process 'slave(3)' with path: '/slave(3)/api/v1/executor'
Finishing task 3
I0716 08:05:25.205591  1068 http.cpp:1133] HTTP POST for /slave(3)/api/v1/executor from 172.17.0.4:41437
I0716 08:05:25.205927  1068 slave.cpp:4363] Handling status update TASK_RUNNING (UUID: be5bb255-bef0-4434-a220-e1f2ea1eb525) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.208039  1068 http.cpp:1133] HTTP POST for /slave(3)/api/v1/executor from 172.17.0.4:41437
I0716 08:05:25.208250  1068 slave.cpp:4363] Handling status update TASK_FINISHED (UUID: 5cb69df6-d631-43ab-80e3-2ebb7be267d3) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.208807  1068 process.cpp:3820] Handling HTTP event for process 'slave(3)' with path: '/slave(3)/api/v1/executor'
I0716 08:05:25.209373  1068 process.cpp:3820] Handling HTTP event for process 'slave(3)' with path: '/slave(3)/api/v1/executor'
I0716 08:05:25.210170  1066 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: be5bb255-bef0-4434-a220-e1f2ea1eb525) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.210229  1066 status_update_manager.cpp:500] Creating StatusUpdate stream for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.211251  1066 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: be5bb255-bef0-4434-a220-e1f2ea1eb525) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 to the agent
I0716 08:05:25.211666  1068 http.cpp:1133] HTTP POST for /slave(3)/api/v1/executor from 172.17.0.4:41437
I0716 08:05:25.211877  1068 slave.cpp:4363] Handling status update TASK_RUNNING (UUID: ed78c872-cf63-4148-b017-03228e0d2253) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.213295  1068 slave.cpp:4815] Forwarding the update TASK_RUNNING (UUID: be5bb255-bef0-4434-a220-e1f2ea1eb525) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 to master@172.17.0.4:48627
I0716 08:05:25.213909  1068 http.cpp:1133] HTTP POST for /slave(3)/api/v1/executor from 172.17.0.4:41437
I0716 08:05:25.214061  1068 slave.cpp:4363] Handling status update TASK_FINISHED (UUID: b92f3e2f-d0a6-401f-85e0-31fe42108e3e) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.214071  1064 master.cpp:6782] Status update TASK_RUNNING (UUID: be5bb255-bef0-4434-a220-e1f2ea1eb525) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 from agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1 at slave(3)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.214140  1064 master.cpp:6844] Forwarding status update TASK_RUNNING (UUID: be5bb255-bef0-4434-a220-e1f2ea1eb525) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.214612  1064 master.cpp:8864] Updating the state of task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (latest state: TASK_FINISHED, status update state: TASK_RUNNING)
I0716 08:05:25.214607  1068 slave.cpp:4709] Status update manager successfully handled status update TASK_RUNNING (UUID: be5bb255-bef0-4434-a220-e1f2ea1eb525) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.215101  1062 status_update_manager.cpp:323] Received status update TASK_FINISHED (UUID: 5cb69df6-d631-43ab-80e3-2ebb7be267d3) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.215448  1062 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: ed78c872-cf63-4148-b017-03228e0d2253) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.215457  1068 slave.cpp:4709] Status update manager successfully handled status update TASK_FINISHED (UUID: 5cb69df6-d631-43ab-80e3-2ebb7be267d3) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.215497  1062 status_update_manager.cpp:500] Creating StatusUpdate stream for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.215526  1070 hierarchical.cpp:1152] Recovered cpus(allocated: *):1; mem(allocated: *):128 (total: cpus:2; mem:10240; disk:3701220; ports:[31000-32000], allocated: cpus(allocated: *):1; mem(allocated: *):128) on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1 from framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.216181  1062 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: ed78c872-cf63-4148-b017-03228e0d2253) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 to the agent
I0716 08:05:25.216197  1068 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:48627/master/api/v1/scheduler
I0716 08:05:25.216421  1058 slave.cpp:4815] Forwarding the update TASK_RUNNING (UUID: ed78c872-cf63-4148-b017-03228e0d2253) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 to master@172.17.0.4:48627
I0716 08:05:25.216603  1058 slave.cpp:4709] Status update manager successfully handled status update TASK_RUNNING (UUID: ed78c872-cf63-4148-b017-03228e0d2253) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.216784  1062 master.cpp:6782] Status update TASK_RUNNING (UUID: ed78c872-cf63-4148-b017-03228e0d2253) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 from agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1 at slave(3)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.216845  1062 master.cpp:6844] Forwarding status update TASK_RUNNING (UUID: ed78c872-cf63-4148-b017-03228e0d2253) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.217206  1062 master.cpp:8864] Updating the state of task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)

Received an UPDATE event
Task 2 is in state TASK_RUNNING
Received an ACKNOWLEDGED event
I0716 08:05:25.217687  1068 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:48627/master/api/v1/scheduler
Received an ACKNOWLEDGED event
Received an ACKNOWLEDGED event
I0716 08:05:25.219812  1060 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:48627/master/api/v1/scheduler
I0716 08:05:25.219846  1070 process.cpp:3820] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'

Received an UPDATE event
Task 3 is in state TASK_RUNNING
I0716 08:05:25.220729  1060 status_update_manager.cpp:323] Received status update TASK_FINISHED (UUID: b92f3e2f-d0a6-401f-85e0-31fe42108e3e) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.220942  1057 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:48627/master/api/v1/scheduler
I0716 08:05:25.220945  1065 slave.cpp:4709] Status update manager successfully handled status update TASK_FINISHED (UUID: b92f3e2f-d0a6-401f-85e0-31fe42108e3e) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
Received an ACKNOWLEDGED event
I0716 08:05:25.224292  1067 hierarchical.cpp:2173] Filtered offer with cpus:1; mem:10112; disk:3701220; ports:[31000-32000] on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 for role * of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.224519  1067 hierarchical.cpp:2015] No inverse offers to send out!
I0716 08:05:25.224565  1067 hierarchical.cpp:1468] Performed allocation for 3 agents in 2.185884ms
I0716 08:05:25.225397  1065 master.cpp:7603] Sending 2 offers to framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (Event Call Scheduler using libprocess (C++))
I0716 08:05:25.228189  1056 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.4:48627/master/api/v1/scheduler

Received an OFFERS event
Received offer 2773c70a-f7ef-4738-b522-8fec4d3cc35e-O3 with cpus(allocated: *):2; mem(allocated: *):10240; disk(allocated: *):3701220; ports(allocated: *):[31000-32000]
Received offer 2773c70a-f7ef-4738-b522-8fec4d3cc35e-O4 with cpus(allocated: *):1; mem(allocated: *):10112; disk(allocated: *):3701220; ports(allocated: *):[31000-32000]
I0716 08:05:25.230365  1055 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.4:48627/master/api/v1/scheduler
I0716 08:05:25.230844  1055 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.4:48627/master/api/v1/scheduler
I0716 08:05:25.259104  1068 process.cpp:3820] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0716 08:05:25.259609  1068 process.cpp:3820] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0716 08:05:25.259960  1068 process.cpp:3820] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0716 08:05:25.260345  1068 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:41432
I0716 08:05:25.260574  1068 master.cpp:5442] Processing ACKNOWLEDGE call be5bb255-bef0-4434-a220-e1f2ea1eb525 for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (Event Call Scheduler using libprocess (C++)) on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1
I0716 08:05:25.260901  1070 status_update_manager.cpp:395] Received status update acknowledgement (UUID: be5bb255-bef0-4434-a220-e1f2ea1eb525) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.261137  1070 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: 5cb69df6-d631-43ab-80e3-2ebb7be267d3) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 to the agent
I0716 08:05:25.261409  1066 slave.cpp:4815] Forwarding the update TASK_FINISHED (UUID: 5cb69df6-d631-43ab-80e3-2ebb7be267d3) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 to master@172.17.0.4:48627
I0716 08:05:25.261639  1066 slave.cpp:3613] Status update manager successfully handled status update acknowledgement (UUID: be5bb255-bef0-4434-a220-e1f2ea1eb525) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.261997  1068 master.cpp:6782] Status update TASK_FINISHED (UUID: 5cb69df6-d631-43ab-80e3-2ebb7be267d3) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 from agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1 at slave(3)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.262048  1068 master.cpp:6844] Forwarding status update TASK_FINISHED (UUID: 5cb69df6-d631-43ab-80e3-2ebb7be267d3) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.262471  1068 master.cpp:8864] Updating the state of task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I0716 08:05:25.262867  1068 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:41432
I0716 08:05:25.262984  1068 master.cpp:5442] Processing ACKNOWLEDGE call ed78c872-cf63-4148-b017-03228e0d2253 for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (Event Call Scheduler using libprocess (C++)) on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1
I0716 08:05:25.263483  1057 status_update_manager.cpp:395] Received status update acknowledgement (UUID: ed78c872-cf63-4148-b017-03228e0d2253) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.263664  1068 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:41432
I0716 08:05:25.263717  1057 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: b92f3e2f-d0a6-401f-85e0-31fe42108e3e) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 to the agent
W0716 08:05:25.263916  1068 master.cpp:3846] Implicitly declining offers: [ 2773c70a-f7ef-4738-b522-8fec4d3cc35e-O3 ] in ACCEPT call for framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 as the launch operation specified no tasks
I0716 08:05:25.264015  1066 slave.cpp:4815] Forwarding the update TASK_FINISHED (UUID: b92f3e2f-d0a6-401f-85e0-31fe42108e3e) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 to master@172.17.0.4:48627
I0716 08:05:25.264339  1066 slave.cpp:3613] Status update manager successfully handled status update acknowledgement (UUID: ed78c872-cf63-4148-b017-03228e0d2253) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.264578  1066 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:48627/master/api/v1/scheduler
I0716 08:05:25.264979  1068 master.cpp:4123] Processing ACCEPT call for offers: [ 2773c70a-f7ef-4738-b522-8fec4d3cc35e-O3 ] on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S0 at slave(2)@172.17.0.4:48627 (7b5eea8b2f31) for framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (Event Call Scheduler using libprocess (C++))

I0716 08:05:25.265743  1068 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:41432
Received an UPDATE event
Task 2 is in state TASK_FINISHED
W0716 08:05:25.265895  1068 master.cpp:3846] Implicitly declining offers: [ 2773c70a-f7ef-4738-b522-8fec4d3cc35e-O4 ] in ACCEPT call for framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 as the launch operation specified no tasks
I0716 08:05:25.265983  1069 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:48627/master/api/v1/scheduler
I0716 08:05:25.266536  1068 master.cpp:4123] Processing ACCEPT call for offers: [ 2773c70a-f7ef-4738-b522-8fec4d3cc35e-O4 ] on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1 at slave(3)@172.17.0.4:48627 (7b5eea8b2f31) for framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (Event Call Scheduler using libprocess (C++))
I0716 08:05:25.267186  1068 master.cpp:6782] Status update TASK_FINISHED (UUID: b92f3e2f-d0a6-401f-85e0-31fe42108e3e) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 from agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1 at slave(3)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.267235  1068 master.cpp:6844] Forwarding status update TASK_FINISHED (UUID: b92f3e2f-d0a6-401f-85e0-31fe42108e3e) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.267575  1068 master.cpp:8864] Updating the state of task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I0716 08:05:25.268229  1068 process.cpp:3820] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0716 08:05:25.268214  1064 hierarchical.cpp:1152] Recovered cpus(allocated: *):1; mem(allocated: *):128 (total: cpus:2; mem:10240; disk:3701220; ports:[31000-32000], allocated: cpus(allocated: *):1; mem(allocated: *):10112; disk(allocated: *):3701220; ports(allocated: *):[31000-32000]) on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1 from framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.269206  1064 hierarchical.cpp:1152] Recovered cpus(allocated: *):2; mem(allocated: *):10240; disk(allocated: *):3701220; ports(allocated: *):[31000-32000] (total: cpus:2; mem:10240; disk:3701220; ports:[31000-32000], allocated: {}) on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S0 from framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.269273  1064 hierarchical.cpp:1189] Framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 filtered agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S0 for 5secs
I0716 08:05:25.270216  1060 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:41432
I0716 08:05:25.270433  1060 master.cpp:5442] Processing ACKNOWLEDGE call 5cb69df6-d631-43ab-80e3-2ebb7be267d3 for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (Event Call Scheduler using libprocess (C++)) on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1
I0716 08:05:25.270505  1067 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:48627/master/api/v1/scheduler
I0716 08:05:25.270609  1064 hierarchical.cpp:1152] Recovered cpus(allocated: *):1; mem(allocated: *):10112; disk(allocated: *):3701220; ports(allocated: *):[31000-32000] (total: cpus:2; mem:10240; disk:3701220; ports:[31000-32000], allocated: {}) on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1 from framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.270684  1064 hierarchical.cpp:1189] Framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 filtered agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1 for 5secs
I0716 08:05:25.270521  1060 master.cpp:8958] Removing task 2 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":128.0},"type":"SCALAR"}] of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1 at slave(3)@172.17.0.4:48627 (7b5eea8b2f31)

Received an UPDATE event
Task 3 is in state TASK_FINISHED
I0716 08:05:25.271467  1062 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:48627/master/api/v1/scheduler
I0716 08:05:25.271476  1066 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 5cb69df6-d631-43ab-80e3-2ebb7be267d3) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.271639  1066 status_update_manager.cpp:531] Cleaning up status update stream for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.272125  1066 slave.cpp:3613] Status update manager successfully handled status update acknowledgement (UUID: 5cb69df6-d631-43ab-80e3-2ebb7be267d3) for task 2 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.272174  1066 slave.cpp:7590] Completing task 2
I0716 08:05:25.273382  1065 process.cpp:3820] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0716 08:05:25.312074  1064 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:41432
I0716 08:05:25.312415  1064 master.cpp:5442] Processing ACKNOWLEDGE call b92f3e2f-d0a6-401f-85e0-31fe42108e3e for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (Event Call Scheduler using libprocess (C++)) on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1
I0716 08:05:25.312532  1064 master.cpp:8958] Removing task 3 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":128.0},"type":"SCALAR"}] of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1 at slave(3)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.313601  1058 status_update_manager.cpp:395] Received status update acknowledgement (UUID: b92f3e2f-d0a6-401f-85e0-31fe42108e3e) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.313823  1058 status_update_manager.cpp:531] Cleaning up status update stream for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.314298  1066 slave.cpp:3613] Status update manager successfully handled status update acknowledgement (UUID: b92f3e2f-d0a6-401f-85e0-31fe42108e3e) for task 3 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.314368  1066 slave.cpp:7590] Completing task 3
I0716 08:05:25.331496  1120 executor.cpp:192] Version: 1.4.0
I0716 08:05:25.339486  1062 process.cpp:3820] Handling HTTP event for process 'slave(1)' with path: '/slave(1)/api/v1/executor'
I0716 08:05:25.342108  1055 http.cpp:1133] HTTP POST for /slave(1)/api/v1/executor from 172.17.0.4:41438
I0716 08:05:25.342555  1055 slave.cpp:3677] Received Subscribe request for HTTP executor 'default' of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.345276  1059 slave.cpp:2607] Sending queued task '4' to executor 'default' of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (via HTTP)
Received a SUBSCRIBED event
Starting task 4
Finishing task 4
I0716 08:05:25.354696  1058 process.cpp:3820] Handling HTTP event for process 'slave(1)' with path: '/slave(1)/api/v1/executor'
I0716 08:05:25.355623  1058 process.cpp:3820] Handling HTTP event for process 'slave(1)' with path: '/slave(1)/api/v1/executor'
I0716 08:05:25.356945  1062 http.cpp:1133] HTTP POST for /slave(1)/api/v1/executor from 172.17.0.4:41439
I0716 08:05:25.357192  1062 slave.cpp:4363] Handling status update TASK_RUNNING (UUID: c8d9d23b-8f6c-4f18-9096-af08fb199c04) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.357885  1062 http.cpp:1133] HTTP POST for /slave(1)/api/v1/executor from 172.17.0.4:41439
I0716 08:05:25.358023  1062 slave.cpp:4363] Handling status update TASK_FINISHED (UUID: fe913e16-4bd4-45dd-9d5b-9e08f4627e62) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.359462  1070 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: c8d9d23b-8f6c-4f18-9096-af08fb199c04) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.359499  1070 status_update_manager.cpp:500] Creating StatusUpdate stream for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.360040  1070 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: c8d9d23b-8f6c-4f18-9096-af08fb199c04) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 to the agent
I0716 08:05:25.360471  1059 slave.cpp:4815] Forwarding the update TASK_RUNNING (UUID: c8d9d23b-8f6c-4f18-9096-af08fb199c04) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 to master@172.17.0.4:48627
I0716 08:05:25.360694  1059 slave.cpp:4709] Status update manager successfully handled status update TASK_RUNNING (UUID: c8d9d23b-8f6c-4f18-9096-af08fb199c04) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.360903  1070 master.cpp:6782] Status update TASK_RUNNING (UUID: c8d9d23b-8f6c-4f18-9096-af08fb199c04) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 from agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 at slave(1)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.361290  1070 master.cpp:6844] Forwarding status update TASK_RUNNING (UUID: c8d9d23b-8f6c-4f18-9096-af08fb199c04) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.361708  1070 master.cpp:8864] Updating the state of task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (latest state: TASK_FINISHED, status update state: TASK_RUNNING)
I0716 08:05:25.361800  1069 status_update_manager.cpp:323] Received status update TASK_FINISHED (UUID: fe913e16-4bd4-45dd-9d5b-9e08f4627e62) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.362177  1064 slave.cpp:4709] Status update manager successfully handled status update TASK_FINISHED (UUID: fe913e16-4bd4-45dd-9d5b-9e08f4627e62) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.362958  1068 hierarchical.cpp:1152] Recovered cpus(allocated: *):1; mem(allocated: *):128 (total: cpus:2; mem:10240; disk:3701220; ports:[31000-32000], allocated: {}) on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 from framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.363656  1063 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:48627/master/api/v1/scheduler
Received an ACKNOWLEDGED event
Received an ACKNOWLEDGED event

Received an UPDATE event
Task 4 is in state TASK_RUNNING
I0716 08:05:25.364866  1059 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:48627/master/api/v1/scheduler
I0716 08:05:25.366499  1056 process.cpp:3820] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0716 08:05:25.407438  1055 http.cpp:1133] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:41432
I0716 08:05:25.407683  1055 master.cpp:5442] Processing ACKNOWLEDGE call c8d9d23b-8f6c-4f18-9096-af08fb199c04 for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (Event Call Scheduler using libprocess (C++)) on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2
I0716 08:05:25.408046  1069 status_update_manager.cpp:395] Received status update acknowledgement (UUID: c8d9d23b-8f6c-4f18-9096-af08fb199c04) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.408318  1069 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: fe913e16-4bd4-45dd-9d5b-9e08f4627e62) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 to the agent
I0716 08:05:25.408574  1065 slave.cpp:4815] Forwarding the update TASK_FINISHED (UUID: fe913e16-4bd4-45dd-9d5b-9e08f4627e62) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 to master@172.17.0.4:48627
I0716 08:05:25.408785  1065 slave.cpp:3613] Status update manager successfully handled status update acknowledgement (UUID: c8d9d23b-8f6c-4f18-9096-af08fb199c04) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.408948  1070 master.cpp:6782] Status update TASK_FINISHED (UUID: fe913e16-4bd4-45dd-9d5b-9e08f4627e62) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 from agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 at slave(1)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.409025  1070 master.cpp:6844] Forwarding status update TASK_FINISHED (UUID: fe913e16-4bd4-45dd-9d5b-9e08f4627e62) for task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000
I0716 08:05:25.409431  1070 master.cpp:8864] Updating the state of task 4 of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I0716 08:05:25.410923  1070 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:48627/master/api/v1/scheduler

Received an UPDATE event
Task 4 is in state TASK_FINISHED
I0716 08:05:25.412035  1057 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:48627/master/api/v1/scheduler
I0716 08:05:25.413030  1048 master.cpp:1160] Master terminating
I0716 08:05:25.413322  1048 master.cpp:8958] Removing task 4 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":128.0},"type":"SCALAR"}] of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 at slave(1)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.414258  1048 master.cpp:8987] Removing executor 'default' with resources [] of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2 at slave(1)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.414528  1066 hierarchical.cpp:626] Removed agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S2
I0716 08:05:25.415120  1048 master.cpp:8987] Removing executor 'default' with resources [] of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1 at slave(3)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.415647  1048 master.cpp:8987] Removing executor 'default' with resources [] of framework 2773c70a-f7ef-4738-b522-8fec4d3cc35e-0000 on agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S0 at slave(2)@172.17.0.4:48627 (7b5eea8b2f31)
I0716 08:05:25.418222  1062 hierarchical.cpp:626] Removed agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S1
I0716 08:05:25.418887  1062 hierarchical.cpp:626] Removed agent 2773c70a-f7ef-4738-b522-8fec4d3cc35e-S0
Build timed out (after 300 minutes). Marking the build as failed.
Build was aborted

Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3919

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3919/display/redirect?page=changes>