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 2016/10/17 11:22:55 UTC
Build failed in Jenkins: mesos-reviewbot #15698
See <https://builds.apache.org/job/mesos-reviewbot/15698/changes>
Changes:
[mpark] Removed `flags::Flags` helper template.
[mpark] Deleted potentially implicitly generated functions.
[mpark] Consistently used virtual inheritance for Flags classes in stout.
[mpark] Consistently used virtual inheritance for Flags classes in libprocess.
[mpark] Consistently used virtual inheritance for Flags classes in mesos.
------------------------------------------
[...truncated 29551 lines...]
I1017 11:22:54.793346 31895 hierarchical.cpp:485] Added agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 (87aeed42460c) with cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000] (allocated: {})
I1017 11:22:54.794003 31894 replica.cpp:537] Replica received write request for position 6 from __req_res__(11)@172.17.0.2:56764
I1017 11:22:54.795302 31894 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 1.204909ms
I1017 11:22:54.795382 31894 replica.cpp:708] Persisted action TRUNCATE at position 6
I1017 11:22:54.796818 31892 replica.cpp:691] Replica received learned notice for position 6 from @0.0.0.0:0
I1017 11:22:54.798250 31892 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 1.356792ms
I1017 11:22:54.798347 31895 hierarchical.cpp:1789] No inverse offers to send out!
I1017 11:22:54.798465 31892 leveldb.cpp:399] Deleting ~2 keys from leveldb took 96110ns
I1017 11:22:54.798571 31895 hierarchical.cpp:1309] Performed allocation for agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 in 4.958438ms
I1017 11:22:54.798527 31892 replica.cpp:708] Persisted action TRUNCATE at position 6
I1017 11:22:54.799492 31894 slave.cpp:4133] Received ping from slave-observer(2)@172.17.0.2:56764
I1017 11:22:54.799875 31894 slave.cpp:1115] Registered with master master@172.17.0.2:56764; given agent ID 41b95ab0-a184-44f3-b40e-c14c03513db2-S1
I1017 11:22:54.799998 31894 fetcher.cpp:86] Clearing fetcher cache
I1017 11:22:54.800356 31893 status_update_manager.cpp:184] Resuming sending status updates
I1017 11:22:54.799492 31890 master.cpp:5168] Registered agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 at slave(3)@172.17.0.2:56764 (87aeed42460c) with cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000]
I1017 11:22:54.800596 31894 slave.cpp:1138] Checkpointing SlaveInfo to '/tmp/mesos-ymblRb/2/meta/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S1/slave.info'
I1017 11:22:54.800765 31890 process.cpp:3377] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1017 11:22:54.801319 31894 slave.cpp:1175] Forwarding total oversubscribed resources {}
I1017 11:22:54.803045 31890 master.cpp:6492] Sending 1 offers to framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java))
I1017 11:22:54.804239 31890 master.cpp:5565] Received update of agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 at slave(3)@172.17.0.2:56764 (87aeed42460c) with total oversubscribed resources {}
I1017 11:22:54.805016 31892 hierarchical.cpp:555] Agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 (87aeed42460c) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000], allocated: cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000])
I1017 11:22:54.805618 31892 hierarchical.cpp:1694] No allocations performed
I1017 11:22:54.805769 31892 hierarchical.cpp:1789] No inverse offers to send out!
I1017 11:22:54.806013 31892 hierarchical.cpp:1309] Performed allocation for agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 in 938146ns
I1017 11:22:54.806516 31894 http.cpp:382] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:53840
I1017 11:22:54.809557 31894 master.cpp:3538] Processing ACCEPT call for offers: [ 41b95ab0-a184-44f3-b40e-c14c03513db2-O0 ] on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 at slave(2)@172.17.0.2:56764 (87aeed42460c) for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java))
I1017 11:22:54.810145 31894 master.cpp:3143] Authorizing framework principal 'test-principal' to launch task 0
I1017 11:22:54.811089 31894 master.cpp:3143] Authorizing framework principal 'test-principal' to launch task 1
I1017 11:22:54.811986 31895 scheduler.cpp:671] Enqueuing event OFFERS received from http://172.17.0.2:56764/master/api/v1/scheduler
Received an OFFERS event
Received offer 41b95ab0-a184-44f3-b40e-c14c03513db2-O1 with cpus: 2.0 and mem: 10240.0
Launching task 2 using offer 41b95ab0-a184-44f3-b40e-c14c03513db2-O1
Launching task 3 using offer 41b95ab0-a184-44f3-b40e-c14c03513db2-O1
W1017 11:22:54.822757 31894 validation.cpp:920] Executor 'default' for task '0' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W1017 11:22:54.822844 31894 validation.cpp:932] Executor 'default' for task '0' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I1017 11:22:54.823233 31895 scheduler.cpp:235] Sending ACCEPT call to http://172.17.0.2:56764/master/api/v1/scheduler
I1017 11:22:54.824831 31894 master.cpp:8245] Adding task 0 with resources cpus(*):1; mem(*):128 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 (87aeed42460c)
I1017 11:22:54.825485 31894 master.cpp:4176] Launching task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java)) with resources cpus(*):1; mem(*):128 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 at slave(2)@172.17.0.2:56764 (87aeed42460c)
I1017 11:22:54.826839 31889 slave.cpp:1539] Got assigned task '0' for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
W1017 11:22:54.828415 31894 validation.cpp:920] Executor 'default' for task '1' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W1017 11:22:54.828485 31894 validation.cpp:932] Executor 'default' for task '1' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I1017 11:22:54.828914 31889 slave.cpp:1701] Launching task '0' for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.829721 31894 master.cpp:8245] Adding task 1 with resources cpus(*):1; mem(*):128 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 (87aeed42460c)
I1017 11:22:54.830406 31894 master.cpp:4176] Launching task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java)) with resources cpus(*):1; mem(*):128 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 at slave(2)@172.17.0.2:56764 (87aeed42460c)
I1017 11:22:54.830579 31889 paths.cpp:536] Trying to chown '/tmp/mesos-ymblRb/1/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S0/frameworks/41b95ab0-a184-44f3-b40e-c14c03513db2-0000/executors/default/runs/66b13ae7-1867-461f-9a6b-2f501ffa7aa4' to user 'mesos'
I1017 11:22:54.836290 31894 process.cpp:3377] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1017 11:22:54.837872 31890 hierarchical.cpp:1018] Recovered ports(*):[31000-32000]; mem(*):9984; disk(*):196368 (total: cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000], allocated: cpus(*):2; mem(*):256) on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 from framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.838141 31890 hierarchical.cpp:1055] Framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 filtered agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 for 1secs
I1017 11:22:54.842345 31889 slave.cpp:6179] Launching executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 with resources {} in work directory '/tmp/mesos-ymblRb/1/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S0/frameworks/41b95ab0-a184-44f3-b40e-c14c03513db2-0000/executors/default/runs/66b13ae7-1867-461f-9a6b-2f501ffa7aa4'
I1017 11:22:54.842797 31894 http.cpp:382] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:53840
I1017 11:22:54.844660 31893 containerizer.cpp:938] Starting container 66b13ae7-1867-461f-9a6b-2f501ffa7aa4 for executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.844998 31889 slave.cpp:1987] Queued task '0' for executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.845383 31889 slave.cpp:1539] Got assigned task '1' for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.845367 31894 master.cpp:3538] Processing ACCEPT call for offers: [ 41b95ab0-a184-44f3-b40e-c14c03513db2-O1 ] on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 at slave(3)@172.17.0.2:56764 (87aeed42460c) for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java))
I1017 11:22:54.845547 31894 master.cpp:3143] Authorizing framework principal 'test-principal' to launch task 2
I1017 11:22:54.846048 31894 master.cpp:3143] Authorizing framework principal 'test-principal' to launch task 3
I1017 11:22:54.846686 31889 slave.cpp:868] Successfully attached file '/tmp/mesos-ymblRb/1/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S0/frameworks/41b95ab0-a184-44f3-b40e-c14c03513db2-0000/executors/default/runs/66b13ae7-1867-461f-9a6b-2f501ffa7aa4'
I1017 11:22:54.846827 31889 slave.cpp:1701] Launching task '1' for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.847107 31889 slave.cpp:1987] Queued task '1' for executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
W1017 11:22:54.851779 31892 validation.cpp:920] Executor 'default' for task '2' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W1017 11:22:54.851958 31892 validation.cpp:932] Executor 'default' for task '2' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I1017 11:22:54.853451 31892 master.cpp:8245] Adding task 2 with resources cpus(*):1; mem(*):128 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 (87aeed42460c)
I1017 11:22:54.854017 31892 master.cpp:4176] Launching task 2 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java)) with resources cpus(*):1; mem(*):128 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 at slave(3)@172.17.0.2:56764 (87aeed42460c)
I1017 11:22:54.855248 31888 slave.cpp:1539] Got assigned task '2' for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.857270 31888 slave.cpp:1701] Launching task '2' for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
W1017 11:22:54.858279 31892 validation.cpp:920] Executor 'default' for task '3' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W1017 11:22:54.858449 31892 validation.cpp:932] Executor 'default' for task '3' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I1017 11:22:54.859581 31892 master.cpp:8245] Adding task 3 with resources cpus(*):1; mem(*):128 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 (87aeed42460c)
I1017 11:22:54.860307 31892 master.cpp:4176] Launching task 3 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java)) with resources cpus(*):1; mem(*):128 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 at slave(3)@172.17.0.2:56764 (87aeed42460c)
I1017 11:22:54.861841 31888 paths.cpp:536] Trying to chown '/tmp/mesos-ymblRb/2/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S1/frameworks/41b95ab0-a184-44f3-b40e-c14c03513db2-0000/executors/default/runs/73c1abc8-e921-4c08-9e44-d067541ed52f' to user 'mesos'
I1017 11:22:54.867749 31890 hierarchical.cpp:1018] Recovered ports(*):[31000-32000]; mem(*):9984; disk(*):196368 (total: cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000], allocated: cpus(*):2; mem(*):256) on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 from framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.868121 31890 hierarchical.cpp:1055] Framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 filtered agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 for 1secs
I1017 11:22:54.871476 31891 containerizer.cpp:1452] Launching 'mesos-containerizer' with flags '--command="{"shell":true,"value":"\/mesos\/mesos-1.1.0\/_build\/src\/examples\/java\/test-executor"}" --environment="{"LIBPROCESS_PORT":"0","MESOS_AGENT_ENDPOINT":"172.17.0.2:56764","MESOS_CHECKPOINT":"0","MESOS_DIRECTORY":"\/tmp\/mesos-ymblRb\/1\/slaves\/41b95ab0-a184-44f3-b40e-c14c03513db2-S0\/frameworks\/41b95ab0-a184-44f3-b40e-c14c03513db2-0000\/executors\/default\/runs\/66b13ae7-1867-461f-9a6b-2f501ffa7aa4","MESOS_EXECUTOR_ID":"default","MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD":"5secs","MESOS_FRAMEWORK_ID":"41b95ab0-a184-44f3-b40e-c14c03513db2-0000","MESOS_HTTP_COMMAND_EXECUTOR":"0","MESOS_SANDBOX":"\/tmp\/mesos-ymblRb\/1\/slaves\/41b95ab0-a184-44f3-b40e-c14c03513db2-S0\/frameworks\/41b95ab0-a184-44f3-b40e-c14c03513db2-0000\/executors\/default\/runs\/66b13ae7-1867-461f-9a6b-2f501ffa7aa4","MESOS_SLAVE_ID":"41b95ab0-a184-44f3-b40e-c14c03513db2-S0","MESOS_SLAVE_PID":"slave(2)@172.17.0.2:56764","PATH":"\/usr\/local\/sbin:\/usr\/local\/bin:\/usr\/sbin:\/usr\/bin:\/sbin:\/bin"}" --help="false" --pipe_read="25" --pipe_write="26" --pre_exec_commands="[]" --runtime_directory="/tmp/mesos-lSpnTU/containers/66b13ae7-1867-461f-9a6b-2f501ffa7aa4" --unshare_namespace_mnt="false" --user="mesos" --working_directory="/tmp/mesos-ymblRb/1/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S0/frameworks/41b95ab0-a184-44f3-b40e-c14c03513db2-0000/executors/default/runs/66b13ae7-1867-461f-9a6b-2f501ffa7aa4"'
I1017 11:22:54.876246 31888 slave.cpp:6179] Launching executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 with resources {} in work directory '/tmp/mesos-ymblRb/2/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S1/frameworks/41b95ab0-a184-44f3-b40e-c14c03513db2-0000/executors/default/runs/73c1abc8-e921-4c08-9e44-d067541ed52f'
I1017 11:22:54.879222 31888 slave.cpp:1987] Queued task '2' for executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.879814 31893 containerizer.cpp:938] Starting container 73c1abc8-e921-4c08-9e44-d067541ed52f for executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.883451 31888 slave.cpp:1539] Got assigned task '3' for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.883958 31891 launcher.cpp:127] Forked child with pid '31903' for container '66b13ae7-1867-461f-9a6b-2f501ffa7aa4'
I1017 11:22:54.885382 31888 slave.cpp:868] Successfully attached file '/tmp/mesos-ymblRb/2/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S1/frameworks/41b95ab0-a184-44f3-b40e-c14c03513db2-0000/executors/default/runs/73c1abc8-e921-4c08-9e44-d067541ed52f'
I1017 11:22:54.885643 31888 slave.cpp:1701] Launching task '3' for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.886044 31888 slave.cpp:1987] Queued task '3' for executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.888942 31895 containerizer.cpp:1452] Launching 'mesos-containerizer' with flags '--command="{"shell":true,"value":"\/mesos\/mesos-1.1.0\/_build\/src\/examples\/java\/test-executor"}" --environment="{"LIBPROCESS_PORT":"0","MESOS_AGENT_ENDPOINT":"172.17.0.2:56764","MESOS_CHECKPOINT":"0","MESOS_DIRECTORY":"\/tmp\/mesos-ymblRb\/2\/slaves\/41b95ab0-a184-44f3-b40e-c14c03513db2-S1\/frameworks\/41b95ab0-a184-44f3-b40e-c14c03513db2-0000\/executors\/default\/runs\/73c1abc8-e921-4c08-9e44-d067541ed52f","MESOS_EXECUTOR_ID":"default","MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD":"5secs","MESOS_FRAMEWORK_ID":"41b95ab0-a184-44f3-b40e-c14c03513db2-0000","MESOS_HTTP_COMMAND_EXECUTOR":"0","MESOS_SANDBOX":"\/tmp\/mesos-ymblRb\/2\/slaves\/41b95ab0-a184-44f3-b40e-c14c03513db2-S1\/frameworks\/41b95ab0-a184-44f3-b40e-c14c03513db2-0000\/executors\/default\/runs\/73c1abc8-e921-4c08-9e44-d067541ed52f","MESOS_SLAVE_ID":"41b95ab0-a184-44f3-b40e-c14c03513db2-S1","MESOS_SLAVE_PID":"slave(3)@172.17.0.2:56764","PATH":"\/usr\/local\/sbin:\/usr\/local\/bin:\/usr\/sbin:\/usr\/bin:\/sbin:\/bin"}" --help="false" --pipe_read="27" --pipe_write="28" --pre_exec_commands="[]" --runtime_directory="/tmp/mesos-lSpnTU/containers/73c1abc8-e921-4c08-9e44-d067541ed52f" --unshare_namespace_mnt="false" --user="mesos" --working_directory="/tmp/mesos-ymblRb/2/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S1/frameworks/41b95ab0-a184-44f3-b40e-c14c03513db2-0000/executors/default/runs/73c1abc8-e921-4c08-9e44-d067541ed52f"'
I1017 11:22:54.898535 31895 launcher.cpp:127] Forked child with pid '31907' for container '73c1abc8-e921-4c08-9e44-d067541ed52f'
I1017 11:22:54.901131 31891 slave.cpp:1475] Will retry registration in 1.211700814secs if necessary
I1017 11:22:54.902549 31888 master.cpp:5097] Registering agent at slave(1)@172.17.0.2:56764 (87aeed42460c) with id 41b95ab0-a184-44f3-b40e-c14c03513db2-S2
I1017 11:22:54.904192 31888 registrar.cpp:461] Applied 1 operations in 231040ns; attempting to update the registry
I1017 11:22:54.907119 31891 log.cpp:577] Attempting to append 669 bytes to the log
I1017 11:22:54.908109 31891 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 7
I1017 11:22:54.911465 31888 replica.cpp:537] Replica received write request for position 7 from __req_res__(12)@172.17.0.2:56764
I1017 11:22:54.914011 31888 leveldb.cpp:341] Persisting action (688 bytes) to leveldb took 2.405072ms
I1017 11:22:54.914139 31888 replica.cpp:708] Persisted action APPEND at position 7
I1017 11:22:54.915879 31889 replica.cpp:691] Replica received learned notice for position 7 from @0.0.0.0:0
I1017 11:22:54.927592 31889 leveldb.cpp:341] Persisting action (690 bytes) to leveldb took 11.572759ms
I1017 11:22:54.927717 31889 replica.cpp:708] Persisted action APPEND at position 7
I1017 11:22:54.932579 31893 registrar.cpp:506] Successfully updated the registry in 27.873024ms
I1017 11:22:54.933490 31891 log.cpp:596] Attempting to truncate the log to 7
I1017 11:22:54.933897 31888 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 8
I1017 11:22:54.935444 31888 slave.cpp:4133] Received ping from slave-observer(3)@172.17.0.2:56764
I1017 11:22:54.936195 31889 master.cpp:5168] Registered agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2 at slave(1)@172.17.0.2:56764 (87aeed42460c) with cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000]
I1017 11:22:54.936852 31889 slave.cpp:1115] Registered with master master@172.17.0.2:56764; given agent ID 41b95ab0-a184-44f3-b40e-c14c03513db2-S2
I1017 11:22:54.936910 31889 fetcher.cpp:86] Clearing fetcher cache
I1017 11:22:54.937052 31891 replica.cpp:537] Replica received write request for position 8 from __req_res__(13)@172.17.0.2:56764
I1017 11:22:54.937623 31890 status_update_manager.cpp:184] Resuming sending status updates
I1017 11:22:54.937494 31888 hierarchical.cpp:485] Added agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2 (87aeed42460c) with cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000] (allocated: {})
I1017 11:22:54.938305 31889 slave.cpp:1138] Checkpointing SlaveInfo to '/tmp/mesos-ymblRb/0/meta/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S2/slave.info'
I1017 11:22:54.939239 31891 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 1.551378ms
I1017 11:22:54.939414 31891 replica.cpp:708] Persisted action TRUNCATE at position 8
I1017 11:22:54.940035 31889 slave.cpp:1175] Forwarding total oversubscribed resources {}
I1017 11:22:54.941498 31890 replica.cpp:691] Replica received learned notice for position 8 from @0.0.0.0:0
I1017 11:22:54.942394 31892 master.cpp:5565] Received update of agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2 at slave(1)@172.17.0.2:56764 (87aeed42460c) with total oversubscribed resources {}
I1017 11:22:54.943773 31890 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 2.185105ms
I1017 11:22:54.944111 31890 leveldb.cpp:399] Deleting ~2 keys from leveldb took 267750ns
I1017 11:22:54.944170 31890 replica.cpp:708] Persisted action TRUNCATE at position 8
I1017 11:22:54.945343 31888 hierarchical.cpp:1789] No inverse offers to send out!
I1017 11:22:54.946516 31895 master.cpp:6492] Sending 1 offers to framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java))
I1017 11:22:54.947731 31888 hierarchical.cpp:1309] Performed allocation for agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2 in 9.874215ms
I1017 11:22:54.948240 31888 hierarchical.cpp:555] Agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2 (87aeed42460c) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000], allocated: cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000])
I1017 11:22:54.948990 31888 hierarchical.cpp:1694] No allocations performed
I1017 11:22:54.949144 31888 hierarchical.cpp:1789] No inverse offers to send out!
I1017 11:22:54.949466 31888 hierarchical.cpp:1309] Performed allocation for agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2 in 1.187234ms
I1017 11:22:54.955023 31895 scheduler.cpp:671] Enqueuing event OFFERS received from http://172.17.0.2:56764/master/api/v1/scheduler
Received an OFFERS event
Received offer 41b95ab0-a184-44f3-b40e-c14c03513db2-O2 with cpus: 2.0 and mem: 10240.0
Launching task 4 using offer 41b95ab0-a184-44f3-b40e-c14c03513db2-O2
I1017 11:22:54.961791 31891 scheduler.cpp:235] Sending ACCEPT call to http://172.17.0.2:56764/master/api/v1/scheduler
I1017 11:22:54.965224 31894 process.cpp:3377] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1017 11:22:54.968246 31894 http.cpp:382] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:53840
I1017 11:22:54.970443 31894 master.cpp:3538] Processing ACCEPT call for offers: [ 41b95ab0-a184-44f3-b40e-c14c03513db2-O2 ] on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2 at slave(1)@172.17.0.2:56764 (87aeed42460c) for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java))
I1017 11:22:54.970654 31894 master.cpp:3143] Authorizing framework principal 'test-principal' to launch task 4
W1017 11:22:54.977298 31890 validation.cpp:920] 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.
W1017 11:22:54.977352 31890 validation.cpp:932] 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.
I1017 11:22:54.978442 31890 master.cpp:8245] Adding task 4 with resources cpus(*):1; mem(*):128 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2 (87aeed42460c)
I1017 11:22:54.978729 31890 master.cpp:4176] Launching task 4 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java)) with resources cpus(*):1; mem(*):128 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2 at slave(1)@172.17.0.2:56764 (87aeed42460c)
I1017 11:22:54.980193 31895 slave.cpp:1539] Got assigned task '4' for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.981475 31895 slave.cpp:1701] Launching task '4' for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.984705 31890 hierarchical.cpp:1018] Recovered cpus(*):1; mem(*):10112; disk(*):196368; ports(*):[31000-32000] (total: cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000], allocated: cpus(*):1; mem(*):128) on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2 from framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.984912 31890 hierarchical.cpp:1055] Framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 filtered agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2 for 1secs
I1017 11:22:54.985682 31895 paths.cpp:536] Trying to chown '/tmp/mesos-ymblRb/0/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S2/frameworks/41b95ab0-a184-44f3-b40e-c14c03513db2-0000/executors/default/runs/866af27a-45be-4641-8e35-91b22cf90ebb' to user 'mesos'
I1017 11:22:54.995354 31895 slave.cpp:6179] Launching executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 with resources {} in work directory '/tmp/mesos-ymblRb/0/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S2/frameworks/41b95ab0-a184-44f3-b40e-c14c03513db2-0000/executors/default/runs/866af27a-45be-4641-8e35-91b22cf90ebb'
I1017 11:22:54.996706 31888 containerizer.cpp:938] Starting container 866af27a-45be-4641-8e35-91b22cf90ebb for executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.997146 31895 slave.cpp:1987] Queued task '4' for executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:54.997282 31895 slave.cpp:868] Successfully attached file '/tmp/mesos-ymblRb/0/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S2/frameworks/41b95ab0-a184-44f3-b40e-c14c03513db2-0000/executors/default/runs/866af27a-45be-4641-8e35-91b22cf90ebb'
I1017 11:22:55.008129 31891 containerizer.cpp:1452] Launching 'mesos-containerizer' with flags '--command="{"shell":true,"value":"\/mesos\/mesos-1.1.0\/_build\/src\/examples\/java\/test-executor"}" --environment="{"LIBPROCESS_PORT":"0","MESOS_AGENT_ENDPOINT":"172.17.0.2:56764","MESOS_CHECKPOINT":"0","MESOS_DIRECTORY":"\/tmp\/mesos-ymblRb\/0\/slaves\/41b95ab0-a184-44f3-b40e-c14c03513db2-S2\/frameworks\/41b95ab0-a184-44f3-b40e-c14c03513db2-0000\/executors\/default\/runs\/866af27a-45be-4641-8e35-91b22cf90ebb","MESOS_EXECUTOR_ID":"default","MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD":"5secs","MESOS_FRAMEWORK_ID":"41b95ab0-a184-44f3-b40e-c14c03513db2-0000","MESOS_HTTP_COMMAND_EXECUTOR":"0","MESOS_SANDBOX":"\/tmp\/mesos-ymblRb\/0\/slaves\/41b95ab0-a184-44f3-b40e-c14c03513db2-S2\/frameworks\/41b95ab0-a184-44f3-b40e-c14c03513db2-0000\/executors\/default\/runs\/866af27a-45be-4641-8e35-91b22cf90ebb","MESOS_SLAVE_ID":"41b95ab0-a184-44f3-b40e-c14c03513db2-S2","MESOS_SLAVE_PID":"slave(1)@172.17.0.2:56764","PATH":"\/usr\/local\/sbin:\/usr\/local\/bin:\/usr\/sbin:\/usr\/bin:\/sbin:\/bin"}" --help="false" --pipe_read="25" --pipe_write="26" --pre_exec_commands="[]" --runtime_directory="/tmp/mesos-lSpnTU/containers/866af27a-45be-4641-8e35-91b22cf90ebb" --unshare_namespace_mnt="false" --user="mesos" --working_directory="/tmp/mesos-ymblRb/0/slaves/41b95ab0-a184-44f3-b40e-c14c03513db2-S2/frameworks/41b95ab0-a184-44f3-b40e-c14c03513db2-0000/executors/default/runs/866af27a-45be-4641-8e35-91b22cf90ebb"'
I1017 11:22:55.013314 31891 launcher.cpp:127] Forked child with pid '31933' for container '866af27a-45be-4641-8e35-91b22cf90ebb'
I1017 11:22:55.055445 31895 hierarchical.cpp:1880] Filtered offer with ports(*):[31000-32000]; mem(*):9984; disk(*):196368 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.057694 31895 hierarchical.cpp:1880] Filtered offer with ports(*):[31000-32000]; mem(*):9984; disk(*):196368 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1 for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.059267 31895 hierarchical.cpp:1880] Filtered offer with cpus(*):1; mem(*):10112; disk(*):196368; ports(*):[31000-32000] on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2 for framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.059418 31895 hierarchical.cpp:1694] No allocations performed
I1017 11:22:55.060153 31895 hierarchical.cpp:1789] No inverse offers to send out!
I1017 11:22:55.060657 31895 hierarchical.cpp:1286] Performed allocation for 3 agents in 6.630694ms
I1017 11:22:55.567358 31952 exec.cpp:162] Version: 1.1.0
I1017 11:22:55.586319 31951 exec.cpp:162] Version: 1.1.0
I1017 11:22:55.603006 31890 slave.cpp:3231] Got registration for executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 from executor(1)@172.17.0.2:33276
I1017 11:22:55.609966 31997 exec.cpp:237] Executor registered on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0
I1017 11:22:55.611106 31892 slave.cpp:2191] Sending queued task '0' to executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 at executor(1)@172.17.0.2:33276
I1017 11:22:55.611835 31892 slave.cpp:2191] Sending queued task '1' to executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 at executor(1)@172.17.0.2:33276
I1017 11:22:55.626695 31889 slave.cpp:3231] Got registration for executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 from executor(1)@172.17.0.2:39932
I1017 11:22:55.632424 32004 exec.cpp:237] Executor registered on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S1
I1017 11:22:55.633376 31894 slave.cpp:2191] Sending queued task '2' to executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 at executor(1)@172.17.0.2:39932
I1017 11:22:55.634428 31894 slave.cpp:2191] Sending queued task '3' to executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 at executor(1)@172.17.0.2:39932
I1017 11:22:55.654579 31969 exec.cpp:162] Version: 1.1.0
I1017 11:22:55.686756 31888 slave.cpp:3231] Got registration for executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 from executor(1)@172.17.0.2:56778
I1017 11:22:55.692618 32013 exec.cpp:237] Executor registered on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S2
I1017 11:22:55.698734 31893 slave.cpp:2191] Sending queued task '4' to executor 'default' of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 at executor(1)@172.17.0.2:56778
Registered executor on 87aeed42460c
Running task 0
I1017 11:22:55.847774 31892 slave.cpp:3634] Handling status update TASK_RUNNING (UUID: 5013c38f-b741-4063-8306-dc72256171ee) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 from executor(1)@172.17.0.2:33276
Running task 1
I1017 11:22:55.853554 31895 slave.cpp:3634] Handling status update TASK_FINISHED (UUID: eb1bdedb-3815-4235-8f87-1f526a6d1d31) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 from executor(1)@172.17.0.2:33276
I1017 11:22:55.859163 31890 slave.cpp:3634] Handling status update TASK_RUNNING (UUID: 4b07c3d1-5325-47b8-a25f-138b266410f0) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 from executor(1)@172.17.0.2:33276
I1017 11:22:55.861860 31893 slave.cpp:3634] Handling status update TASK_FINISHED (UUID: acf72d55-7ca4-44a8-9753-d7496409f898) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 from executor(1)@172.17.0.2:33276
I1017 11:22:55.868650 31893 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 5013c38f-b741-4063-8306-dc72256171ee) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.869098 31893 status_update_manager.cpp:500] Creating StatusUpdate stream for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.870815 31893 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 5013c38f-b741-4063-8306-dc72256171ee) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 to the agent
I1017 11:22:55.872369 31889 slave.cpp:4051] Forwarding the update TASK_RUNNING (UUID: 5013c38f-b741-4063-8306-dc72256171ee) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 to master@172.17.0.2:56764
I1017 11:22:55.872565 31888 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 4b07c3d1-5325-47b8-a25f-138b266410f0) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.873080 31888 status_update_manager.cpp:500] Creating StatusUpdate stream for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.874096 31889 slave.cpp:3945] Status update manager successfully handled status update TASK_RUNNING (UUID: 5013c38f-b741-4063-8306-dc72256171ee) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.874236 31889 slave.cpp:3961] Sending acknowledgement for status update TASK_RUNNING (UUID: 5013c38f-b741-4063-8306-dc72256171ee) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 to executor(1)@172.17.0.2:33276
I1017 11:22:55.874491 31888 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 4b07c3d1-5325-47b8-a25f-138b266410f0) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 to the agent
I1017 11:22:55.874876 31893 master.cpp:5701] Status update TASK_RUNNING (UUID: 5013c38f-b741-4063-8306-dc72256171ee) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 from agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 at slave(2)@172.17.0.2:56764 (87aeed42460c)
I1017 11:22:55.875087 31893 master.cpp:5763] Forwarding status update TASK_RUNNING (UUID: 5013c38f-b741-4063-8306-dc72256171ee) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.875938 31888 status_update_manager.cpp:323] Received status update TASK_FINISHED (UUID: eb1bdedb-3815-4235-8f87-1f526a6d1d31) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.876597 31889 slave.cpp:4051] Forwarding the update TASK_RUNNING (UUID: 4b07c3d1-5325-47b8-a25f-138b266410f0) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 to master@172.17.0.2:56764
I1017 11:22:55.876958 31889 slave.cpp:3945] Status update manager successfully handled status update TASK_RUNNING (UUID: 4b07c3d1-5325-47b8-a25f-138b266410f0) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.877655 31889 slave.cpp:3961] Sending acknowledgement for status update TASK_RUNNING (UUID: 4b07c3d1-5325-47b8-a25f-138b266410f0) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 to executor(1)@172.17.0.2:33276
I1017 11:22:55.878191 31891 slave.cpp:3945] Status update manager successfully handled status update TASK_FINISHED (UUID: eb1bdedb-3815-4235-8f87-1f526a6d1d31) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.878340 31891 slave.cpp:3961] Sending acknowledgement for status update TASK_FINISHED (UUID: eb1bdedb-3815-4235-8f87-1f526a6d1d31) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 to executor(1)@172.17.0.2:33276
I1017 11:22:55.878275 31893 master.cpp:7623] Updating the state of task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (latest state: TASK_FINISHED, status update state: TASK_RUNNING)
I1017 11:22:55.879478 31893 master.cpp:5701] Status update TASK_RUNNING (UUID: 4b07c3d1-5325-47b8-a25f-138b266410f0) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 from agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 at slave(2)@172.17.0.2:56764 (87aeed42460c)
I1017 11:22:55.880223 31893 master.cpp:5763] Forwarding status update TASK_RUNNING (UUID: 4b07c3d1-5325-47b8-a25f-138b266410f0) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.880571 31894 hierarchical.cpp:1018] Recovered cpus(*):1; mem(*):128 (total: cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000], allocated: cpus(*):1; mem(*):128) on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 from framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.881181 31894 status_update_manager.cpp:323] Received status update TASK_FINISHED (UUID: acf72d55-7ca4-44a8-9753-d7496409f898) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.881877 31893 master.cpp:7623] Updating the state of task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (latest state: TASK_FINISHED, status update state: TASK_RUNNING)
I1017 11:22:55.882087 31888 slave.cpp:3945] Status update manager successfully handled status update TASK_FINISHED (UUID: acf72d55-7ca4-44a8-9753-d7496409f898) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.882275 31888 slave.cpp:3961] Sending acknowledgement for status update TASK_FINISHED (UUID: acf72d55-7ca4-44a8-9753-d7496409f898) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 to executor(1)@172.17.0.2:33276
I1017 11:22:55.883762 31891 hierarchical.cpp:1018] Recovered cpus(*):1; mem(*):128 (total: cpus(*):2; mem(*):10240; disk(*):196368; ports(*):[31000-32000], allocated: {}) on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 from framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.886674 31893 scheduler.cpp:671] Enqueuing event UPDATE received from http://172.17.0.2:56764/master/api/v1/scheduler
I1017 11:22:55.891899 31893 scheduler.cpp:671] Enqueuing event UPDATE received from http://172.17.0.2:56764/master/api/v1/scheduler
Registered executor on 87aeed42460c
Received an UPDATE event
Status update: task 0 is in state TASK_RUNNING
I1017 11:22:55.907950 31889 scheduler.cpp:235] Sending ACKNOWLEDGE call to http://172.17.0.2:56764/master/api/v1/scheduler
Received an UPDATE event
Status update: task 1 is in state TASK_RUNNINGI1017 11:22:55.911082 31892 process.cpp:3377] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1017 11:22:55.912214 31894 scheduler.cpp:235] Sending ACKNOWLEDGE call to http://172.17.0.2:56764/master/api/v1/scheduler
I1017 11:22:55.913252 31893 http.cpp:382] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:53840
I1017 11:22:55.913739 31893 master.cpp:4813] Processing ACKNOWLEDGE call 5013c38f-b741-4063-8306-dc72256171ee for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java)) on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0
I1017 11:22:55.914721 31889 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 5013c38f-b741-4063-8306-dc72256171ee) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.915688 31889 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: eb1bdedb-3815-4235-8f87-1f526a6d1d31) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 to the agent
I1017 11:22:55.916520 31890 slave.cpp:4051] Forwarding the update TASK_FINISHED (UUID: eb1bdedb-3815-4235-8f87-1f526a6d1d31) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 to master@172.17.0.2:56764
I1017 11:22:55.917243 31893 master.cpp:5701] Status update TASK_FINISHED (UUID: eb1bdedb-3815-4235-8f87-1f526a6d1d31) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 from agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 at slave(2)@172.17.0.2:56764 (87aeed42460c)
I1017 11:22:55.917420 31890 slave.cpp:2958] Status update manager successfully handled status update acknowledgement (UUID: 5013c38f-b741-4063-8306-dc72256171ee) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.917450 31893 master.cpp:5763] Forwarding status update TASK_FINISHED (UUID: eb1bdedb-3815-4235-8f87-1f526a6d1d31) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.920714 31893 master.cpp:7623] Updating the state of task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I1017 11:22:55.920861 31893 process.cpp:3377] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1017 11:22:55.924160 31893 http.cpp:382] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:53840
I1017 11:22:55.924667 31893 master.cpp:4813] Processing ACKNOWLEDGE call 4b07c3d1-5325-47b8-a25f-138b266410f0 for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java)) on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0
I1017 11:22:55.926766 31888 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 4b07c3d1-5325-47b8-a25f-138b266410f0) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.927822 31888 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: acf72d55-7ca4-44a8-9753-d7496409f898) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 to the agent
I1017 11:22:55.928205 31892 scheduler.cpp:671] Enqueuing event UPDATE received from http://172.17.0.2:56764/master/api/v1/scheduler
I1017 11:22:55.930191 31893 slave.cpp:4051] Forwarding the update TASK_FINISHED (UUID: acf72d55-7ca4-44a8-9753-d7496409f898) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 to master@172.17.0.2:56764
I1017 11:22:55.930764 31893 slave.cpp:2958] Status update manager successfully handled status update acknowledgement (UUID: 4b07c3d1-5325-47b8-a25f-138b266410f0) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
Received an UPDATE event
Status update: task 0 is in state TASK_FINISHEDI1017 11:22:55.931613 31893 master.cpp:5701] Status update TASK_FINISHED (UUID: acf72d55-7ca4-44a8-9753-d7496409f898) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 from agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 at slave(2)@172.17.0.2:56764 (87aeed42460c)
I1017 11:22:55.932014 31893 master.cpp:5763] Forwarding status update TASK_FINISHED (UUID: acf72d55-7ca4-44a8-9753-d7496409f898) for task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
Finished tasks: 1
I1017 11:22:55.933926 31893 master.cpp:7623] Updating the state of task 1 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I1017 11:22:55.934870 31890 scheduler.cpp:235] Sending ACKNOWLEDGE call to http://172.17.0.2:56764/master/api/v1/scheduler
I1017 11:22:55.940258 31890 scheduler.cpp:671] Enqueuing event UPDATE received from http://172.17.0.2:56764/master/api/v1/scheduler
Received an UPDATE event
Status update: task 1 is in state TASK_FINISHED
Finished tasks: 2
I1017 11:22:55.943271 31890 scheduler.cpp:235] Sending ACKNOWLEDGE call to http://172.17.0.2:56764/master/api/v1/scheduler
I1017 11:22:55.946889 31894 process.cpp:3377] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1017 11:22:55.948762 31888 http.cpp:382] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:53840
I1017 11:22:55.949559 31888 master.cpp:4813] Processing ACKNOWLEDGE call eb1bdedb-3815-4235-8f87-1f526a6d1d31 for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 (V1 Test Framework (Java)) on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0
I1017 11:22:55.949709 31888 master.cpp:7719] Removing task 0 with resources cpus(*):1; mem(*):128 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000 on agent 41b95ab0-a184-44f3-b40e-c14c03513db2-S0 at slave(2)@172.17.0.2:56764 (87aeed42460c)
I1017 11:22:55.952198 31888 status_update_manager.cpp:395] Received status update acknowledgement (UUID: eb1bdedb-3815-4235-8f87-1f526a6d1d31) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.953253 31888 status_update_manager.cpp:531] Cleaning up status update stream for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.954340 31888 slave.cpp:2958] Status update manager successfully handled status update acknowledgement (UUID: eb1bdedb-3815-4235-8f87-1f526a6d1d31) for task 0 of framework 41b95ab0-a184-44f3-b40e-c14c03513db2-0000
I1017 11:22:55.954418 31888 slave.cpp:6551] Completing task 0
}I1017 11:22:55.959359 31893 Error deleting container: Error response from daemon: Conflict, You cannot remove a running container. Stop the container before attempting removal or use -f
Unrecognized input header
+ docker rmi mesos-1476700684-2920
Failed to remove image (mesos-1476700684-2920): Error response from daemon: conflict: unable to remove repository reference "mesos-1476700684-2920" (must force) - container 87aeed42460c is using its referenced image cf315fea597e
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : mesos-reviewbot #15699
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/mesos-reviewbot/15699/>