See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/1028/>
------------------------------------------ [...truncated 12288 lines...] I0608 12:55:55.958431 13030 sched.cpp:287] Received 2 offers I0608 12:55:55.958710 13031 sched.cpp:427] Stopping framework '201306081255-143311683-42731-13007-0000' I0608 12:55:55.958751 13007 master.cpp:385] Master terminating I0608 12:55:55.958869 13032 slave.cpp:493] Slave asked to shut down by [email protected]:42731 I0608 12:55:55.958874 13007 master.cpp:207] Shutting down master I0608 12:55:55.958902 13029 slave.cpp:493] Slave asked to shut down by [email protected]:42731 I0608 12:55:55.959075 13007 master.hpp:303] Removing task 0 with resources cpus=2; mem=512 on slave 201306081255-143311683-42731-13007-0 I0608 12:55:55.958935 13032 slave.cpp:448] Slave terminating I0608 12:55:55.959095 13029 slave.cpp:1110] Asked to shut down framework 201306081255-143311683-42731-13007-0000 by [email protected]:42731 I0608 12:55:55.959120 13026 hierarchical_allocator_process.hpp:412] Deactivated framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.959259 13007 master.hpp:323] Removing offer 201306081255-143311683-42731-13007-5 with resources cpus=1; mem=512; ports=[31000-32000]; disk=19718 on slave 201306081255-143311683-42731-13007-0 I0608 12:55:55.959564 13026 hierarchical_allocator_process.hpp:616] Recovered cpus=2; mem=512 (total allocatable: cpus=2; mem=512; ports=[]; disk=0) on slave 201306081255-143311683-42731-13007-0 from framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.959621 13007 master.hpp:323] Removing offer 201306081255-143311683-42731-13007-4 with resources cpus=4; mem=2048; ports=[31000-32000]; disk=19718 on slave 201306081255-143311683-42731-13007-1 I0608 12:55:55.959732 13026 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=512; ports=[31000-32000]; disk=19718 (total allocatable: cpus=3; mem=1024; ports=[31000-32000]; disk=19718) on slave 201306081255-143311683-42731-13007-0 from framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.959884 13026 hierarchical_allocator_process.hpp:616] Recovered cpus=4; mem=2048; ports=[31000-32000]; disk=19718 (total allocatable: cpus=4; mem=2048; ports=[31000-32000]; disk=19718) on slave 201306081255-143311683-42731-13007-1 from framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.960003 13026 hierarchical_allocator_process.hpp:367] Removed framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.960067 13026 hierarchical_allocator_process.hpp:477] Removed slave 201306081255-143311683-42731-13007-1 I0608 12:55:55.960134 13026 hierarchical_allocator_process.hpp:477] Removed slave 201306081255-143311683-42731-13007-0 I0608 12:55:55.959347 13029 slave.cpp:1135] Shutting down framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.960232 13029 slave.cpp:2312] Shutting down executor 'default' of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.960330 13033 exec.cpp:323] Executor asked to shutdown I0608 12:55:55.960335 13029 slave.cpp:448] Slave terminating I0608 12:55:55.960464 13029 slave.cpp:1110] Asked to shut down framework 201306081255-143311683-42731-13007-0000 by @0.0.0.0:0 W0608 12:55:55.960522 13029 slave.cpp:1131] Ignoring shutdown framework 201306081255-143311683-42731-13007-0000 because it is terminating [ OK ] AllocatorTest/0.SlaveAdded (171 ms) [ RUN ] AllocatorTest/0.TaskFinished I0608 12:55:55.961526 13033 master.cpp:228] Master started on 67.195.138.8:42731 I0608 12:55:55.961581 13033 master.cpp:243] Master ID: 201306081255-143311683-42731-13007 I0608 12:55:55.961861 13033 master.cpp:526] Elected as master! W0608 12:55:55.961961 13033 master.cpp:83] No whitelist given. Advertising offers for all slaves I0608 12:55:55.962067 13033 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:42731 I0608 12:55:55.962126 13033 slave.cpp:216] Slave started on 95)@67.195.138.8:42731 I0608 12:55:55.962165 13033 slave.cpp:217] Slave resources: cpus=3; mem=1024; ports=[31000-32000]; disk=19718 I0608 12:55:55.962553 13033 slave.cpp:537] New master detected at [email protected]:42731 I0608 12:55:55.962591 13033 slave.cpp:552] Postponing registration until recovery is complete I0608 12:55:55.962704 13028 status_update_manager.cpp:155] New master detected at [email protected]:42731 I0608 12:55:55.962795 13032 sched.cpp:177] New master at [email protected]:42731 I0608 12:55:55.962748 13033 slave.cpp:398] Finished recovery I0608 12:55:55.963021 13026 master.cpp:569] Registering framework 201306081255-143311683-42731-13007-0000 at scheduler(86)@67.195.138.8:42731 I0608 12:55:55.963136 13026 master.cpp:891] Attempting to register slave on minerva.apache.org at slave(95)@67.195.138.8:42731 I0608 12:55:55.963160 13031 sched.cpp:222] Framework registered with 201306081255-143311683-42731-13007-0000 I0608 12:55:55.963155 13033 hierarchical_allocator_process.hpp:327] Added framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.963181 13026 master.cpp:1851] Adding slave 201306081255-143311683-42731-13007-0 at minerva.apache.org with cpus=3; mem=1024; ports=[31000-32000]; disk=19718 I0608 12:55:55.963345 13033 hierarchical_allocator_process.hpp:705] No resources available to allocate! I0608 12:55:55.963511 13033 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 166.428us I0608 12:55:55.963544 13027 slave.cpp:597] Registered with master [email protected]:42731; given slave ID 201306081255-143311683-42731-13007-0 I0608 12:55:55.963747 13027 hierarchical_allocator_process.hpp:449] Added slave 201306081255-143311683-42731-13007-0 (minerva.apache.org) with cpus=3; mem=1024; ports=[31000-32000]; disk=19718 (and cpus=3; mem=1024; ports=[31000-32000]; disk=19718 available) I0608 12:55:55.963806 13027 hierarchical_allocator_process.hpp:727] Offering cpus=3; mem=1024; ports=[31000-32000]; disk=19718 on slave 201306081255-143311683-42731-13007-0 to framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.963956 13027 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306081255-143311683-42731-13007-0 in 153.498us I0608 12:55:55.963995 13029 master.hpp:313] Adding offer 201306081255-143311683-42731-13007-0 with resources cpus=3; mem=1024; ports=[31000-32000]; disk=19718 on slave 201306081255-143311683-42731-13007-0 I0608 12:55:55.964076 13029 master.cpp:1239] Sending 1 offers to framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.964175 13029 sched.cpp:287] Received 1 offers I0608 12:55:55.964419 13030 master.cpp:1472] Processing reply for offer 201306081255-143311683-42731-13007-0 on slave 201306081255-143311683-42731-13007-0 (minerva.apache.org) for framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.964529 13030 master.hpp:291] Adding task 0 with resources cpus=1; mem=256 on slave 201306081255-143311683-42731-13007-0 I0608 12:55:55.964576 13030 master.cpp:1591] Launching task 0 of framework 201306081255-143311683-42731-13007-0000 with resources cpus=1; mem=256 on slave 201306081255-143311683-42731-13007-0 (minerva.apache.org) I0608 12:55:55.964687 13029 slave.cpp:737] Got assigned task 0 for framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.964694 13030 master.hpp:291] Adding task 1 with resources cpus=1; mem=256 on slave 201306081255-143311683-42731-13007-0 I0608 12:55:55.964822 13030 master.cpp:1591] Launching task 1 of framework 201306081255-143311683-42731-13007-0000 with resources cpus=1; mem=256 on slave 201306081255-143311683-42731-13007-0 (minerva.apache.org) I0608 12:55:55.964943 13029 slave.cpp:737] Got assigned task 1 for framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.964968 13030 master.hpp:323] Removing offer 201306081255-143311683-42731-13007-0 with resources cpus=3; mem=1024; ports=[31000-32000]; disk=19718 on slave 201306081255-143311683-42731-13007-0 I0608 12:55:55.965003 13033 hierarchical_allocator_process.hpp:526] Framework 201306081255-143311683-42731-13007-0000 left cpus=1; mem=512; ports=[31000-32000]; disk=19718 unused on slave 201306081255-143311683-42731-13007-0 I0608 12:55:55.965188 13029 slave.cpp:835] Launching task 0 for framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.965231 13033 hierarchical_allocator_process.hpp:569] Framework 201306081255-143311683-42731-13007-0000 filtered slave 201306081255-143311683-42731-13007-0 for 5secs I0608 12:55:55.966225 13029 paths.hpp:303] Created executor directory '/tmp/AllocatorTest_0_TaskFinished_CO0VcN/slaves/201306081255-143311683-42731-13007-0/frameworks/201306081255-143311683-42731-13007-0000/executors/default/runs/b6989213-ed9e-4f32-9a0c-9eba25a76690' I0608 12:55:55.966397 13029 slave.cpp:946] Queuing task '0' for executor default of framework '201306081255-143311683-42731-13007-0000 I0608 12:55:55.966449 13029 slave.cpp:835] Launching task 1 for framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.966496 13029 slave.cpp:946] Queuing task '1' for executor default of framework '201306081255-143311683-42731-13007-0000 I0608 12:55:55.966503 13033 exec.cpp:170] Executor started at: executor(34)@67.195.138.8:42731 with pid 13007 I0608 12:55:55.966609 13029 slave.cpp:519] Successfully attached file '/tmp/AllocatorTest_0_TaskFinished_CO0VcN/slaves/201306081255-143311683-42731-13007-0/frameworks/201306081255-143311683-42731-13007-0000/executors/default/runs/b6989213-ed9e-4f32-9a0c-9eba25a76690' I0608 12:55:55.966850 13029 slave.cpp:1393] Got registration for executor 'default' of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.966989 13029 slave.cpp:1508] Flushing queued task 1 for executor 'default' of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.967016 13028 exec.cpp:194] Executor registered on slave 201306081255-143311683-42731-13007-0 I0608 12:55:55.967067 13029 slave.cpp:1508] Flushing queued task 0 for executor 'default' of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.967133 13028 exec.cpp:258] Executor asked to run task '1' I0608 12:55:55.967303 13028 exec.cpp:258] Executor asked to run task '0' I0608 12:55:55.968122 13028 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 91421c65-b215-47ef-88ce-832d301a6896) for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.968233 13030 slave.cpp:1740] Handling status update TASK_RUNNING (UUID: 91421c65-b215-47ef-88ce-832d301a6896) for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.968369 13033 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 91421c65-b215-47ef-88ce-832d301a6896) for task 1 of framework 201306081255-143311683-42731-13007-0000 with checkpoint=false I0608 12:55:55.968423 13033 status_update_manager.cpp:450] Creating StatusUpdate stream for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.968539 13033 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 91421c65-b215-47ef-88ce-832d301a6896) for task 1 of framework 201306081255-143311683-42731-13007-0000 to [email protected]:42731 I0608 12:55:55.968648 13032 master.cpp:1022] Status update from slave(95)@67.195.138.8:42731: task 1 of framework 201306081255-143311683-42731-13007-0000 is now in state TASK_RUNNING I0608 12:55:55.968660 13027 slave.cpp:1796] Status update manager successfully handled status update TASK_RUNNING (UUID: 91421c65-b215-47ef-88ce-832d301a6896) for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.968761 13027 slave.cpp:1802] Sending acknowledgement for status update TASK_RUNNING (UUID: 91421c65-b215-47ef-88ce-832d301a6896) for task 1 of framework 201306081255-143311683-42731-13007-0000 to executor(34)@67.195.138.8:42731 I0608 12:55:55.968786 13031 sched.cpp:332] Received status update TASK_RUNNING (UUID: 91421c65-b215-47ef-88ce-832d301a6896) for task 1 of framework 201306081255-143311683-42731-13007-0000 from slave(95)@67.195.138.8:42731 I0608 12:55:55.968971 13031 sched.cpp:365] Sending ACK for status update TASK_RUNNING (UUID: 91421c65-b215-47ef-88ce-832d301a6896) for task 1 of framework 201306081255-143311683-42731-13007-0000 to slave(95)@67.195.138.8:42731 I0608 12:55:55.969075 13028 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: a7457854-08c9-4102-b905-a7978e4bf3cd) for task 0 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.969112 13032 status_update_manager.cpp:360] Received status update acknowledgement 91421c65-b215-47ef-88ce-832d301a6896 for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.969270 13029 slave.cpp:1740] Handling status update TASK_RUNNING (UUID: a7457854-08c9-4102-b905-a7978e4bf3cd) for task 0 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.969378 13029 slave.cpp:1341] Status update manager successfully handled status update acknowledgement 91421c65-b215-47ef-88ce-832d301a6896 for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.969423 13029 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: a7457854-08c9-4102-b905-a7978e4bf3cd) for task 0 of framework 201306081255-143311683-42731-13007-0000 with checkpoint=false I0608 12:55:55.969527 13029 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.969641 13029 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: a7457854-08c9-4102-b905-a7978e4bf3cd) for task 0 of framework 201306081255-143311683-42731-13007-0000 to [email protected]:42731 I0608 12:55:55.969749 13032 master.cpp:1022] Status update from slave(95)@67.195.138.8:42731: task 0 of framework 201306081255-143311683-42731-13007-0000 is now in state TASK_RUNNING I0608 12:55:55.969838 13031 sched.cpp:332] Received status update TASK_RUNNING (UUID: a7457854-08c9-4102-b905-a7978e4bf3cd) for task 0 of framework 201306081255-143311683-42731-13007-0000 from slave(95)@67.195.138.8:42731 I0608 12:55:55.969902 13031 sched.cpp:365] Sending ACK for status update TASK_RUNNING (UUID: a7457854-08c9-4102-b905-a7978e4bf3cd) for task 0 of framework 201306081255-143311683-42731-13007-0000 to slave(95)@67.195.138.8:42731 I0608 12:55:55.969997 13028 exec.cpp:404] Executor sending status update TASK_FINISHED (UUID: 91a3fef9-0fe8-4767-aecb-afed05d7254b) for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.970063 13028 exec.cpp:290] Executor received status update acknowledgement 91421c65-b215-47ef-88ce-832d301a6896 for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.970085 13026 slave.cpp:1740] Handling status update TASK_FINISHED (UUID: 91a3fef9-0fe8-4767-aecb-afed05d7254b) for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.970150 13029 status_update_manager.cpp:360] Received status update acknowledgement a7457854-08c9-4102-b905-a7978e4bf3cd for task 0 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.970288 13026 slave.cpp:1796] Status update manager successfully handled status update TASK_RUNNING (UUID: a7457854-08c9-4102-b905-a7978e4bf3cd) for task 0 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.970348 13026 slave.cpp:1802] Sending acknowledgement for status update TASK_RUNNING (UUID: a7457854-08c9-4102-b905-a7978e4bf3cd) for task 0 of framework 201306081255-143311683-42731-13007-0000 to executor(34)@67.195.138.8:42731 I0608 12:55:55.970362 13029 status_update_manager.cpp:290] Received status update TASK_FINISHED (UUID: 91a3fef9-0fe8-4767-aecb-afed05d7254b) for task 1 of framework 201306081255-143311683-42731-13007-0000 with checkpoint=false I0608 12:55:55.970468 13026 slave.cpp:1341] Status update manager successfully handled status update acknowledgement a7457854-08c9-4102-b905-a7978e4bf3cd for task 0 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.970504 13033 exec.cpp:290] Executor received status update acknowledgement a7457854-08c9-4102-b905-a7978e4bf3cd for task 0 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.970561 13029 status_update_manager.cpp:336] Forwarding status update TASK_FINISHED (UUID: 91a3fef9-0fe8-4767-aecb-afed05d7254b) for task 1 of framework 201306081255-143311683-42731-13007-0000 to [email protected]:42731 I0608 12:55:55.970834 13031 master.cpp:1022] Status update from slave(95)@67.195.138.8:42731: task 1 of framework 201306081255-143311683-42731-13007-0000 is now in state TASK_FINISHED I0608 12:55:55.970841 13030 slave.cpp:1796] Status update manager successfully handled status update TASK_FINISHED (UUID: 91a3fef9-0fe8-4767-aecb-afed05d7254b) for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.970957 13031 master.hpp:303] Removing task 1 with resources cpus=1; mem=256 on slave 201306081255-143311683-42731-13007-0 I0608 12:55:55.970963 13029 sched.cpp:332] Received status update TASK_FINISHED (UUID: 91a3fef9-0fe8-4767-aecb-afed05d7254b) for task 1 of framework 201306081255-143311683-42731-13007-0000 from slave(95)@67.195.138.8:42731 I0608 12:55:55.971185 13029 sched.cpp:365] Sending ACK for status update TASK_FINISHED (UUID: 91a3fef9-0fe8-4767-aecb-afed05d7254b) for task 1 of framework 201306081255-143311683-42731-13007-0000 to slave(95)@67.195.138.8:42731 I0608 12:55:55.971230 13031 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=256 (total allocatable: cpus=2; mem=768; ports=[31000-32000]; disk=19718) on slave 201306081255-143311683-42731-13007-0 from framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.970974 13030 slave.cpp:1802] Sending acknowledgement for status update TASK_FINISHED (UUID: 91a3fef9-0fe8-4767-aecb-afed05d7254b) for task 1 of framework 201306081255-143311683-42731-13007-0000 to executor(34)@67.195.138.8:42731 I0608 12:55:55.971452 13032 exec.cpp:290] Executor received status update acknowledgement 91a3fef9-0fe8-4767-aecb-afed05d7254b for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.971524 13030 status_update_manager.cpp:360] Received status update acknowledgement 91a3fef9-0fe8-4767-aecb-afed05d7254b for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.971604 13030 status_update_manager.cpp:481] Cleaning up status update stream for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:55.971721 13032 slave.cpp:1341] Status update manager successfully handled status update acknowledgement 91a3fef9-0fe8-4767-aecb-afed05d7254b for task 1 of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.012442 13030 hierarchical_allocator_process.hpp:727] Offering cpus=2; mem=768; ports=[31000-32000]; disk=19718 on slave 201306081255-143311683-42731-13007-0 to framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.012604 13030 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 178.581us I0608 12:55:56.012660 13032 master.hpp:313] Adding offer 201306081255-143311683-42731-13007-1 with resources cpus=2; mem=768; ports=[31000-32000]; disk=19718 on slave 201306081255-143311683-42731-13007-0 I0608 12:55:56.012768 13032 master.cpp:1239] Sending 1 offers to framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.012852 13026 sched.cpp:287] Received 1 offers I0608 12:55:56.013152 13032 sched.cpp:427] Stopping framework '201306081255-143311683-42731-13007-0000' I0608 12:55:56.013174 13007 master.cpp:385] Master terminating I0608 12:55:56.013300 13026 slave.cpp:493] Slave asked to shut down by [email protected]:42731 I0608 12:55:56.013308 13007 master.cpp:207] Shutting down master I0608 12:55:56.013363 13026 slave.cpp:1110] Asked to shut down framework 201306081255-143311683-42731-13007-0000 by [email protected]:42731 I0608 12:55:56.013573 13026 slave.cpp:1135] Shutting down framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.013528 13007 master.hpp:303] Removing task 0 with resources cpus=1; mem=256 on slave 201306081255-143311683-42731-13007-0 I0608 12:55:56.013521 13031 hierarchical_allocator_process.hpp:412] Deactivated framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.013875 13007 master.hpp:323] Removing offer 201306081255-143311683-42731-13007-1 with resources cpus=2; mem=768; ports=[31000-32000]; disk=19718 on slave 201306081255-143311683-42731-13007-0 I0608 12:55:56.013878 13030 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=256 (total allocatable: cpus=1; mem=256; ports=[]; disk=0) on slave 201306081255-143311683-42731-13007-0 from framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.014056 13030 hierarchical_allocator_process.hpp:616] Recovered cpus=2; mem=768; ports=[31000-32000]; disk=19718 (total allocatable: cpus=3; mem=1024; ports=[31000-32000]; disk=19718) on slave 201306081255-143311683-42731-13007-0 from framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.013640 13026 slave.cpp:2312] Shutting down executor 'default' of framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.014174 13030 hierarchical_allocator_process.hpp:367] Removed framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.014227 13031 exec.cpp:323] Executor asked to shutdown I0608 12:55:56.014233 13026 slave.cpp:448] Slave terminating I0608 12:55:56.014442 13026 slave.cpp:1110] Asked to shut down framework 201306081255-143311683-42731-13007-0000 by @0.0.0.0:0 W0608 12:55:56.014543 13026 slave.cpp:1131] Ignoring shutdown framework 201306081255-143311683-42731-13007-0000 because it is terminating I0608 12:55:56.014297 13030 hierarchical_allocator_process.hpp:477] Removed slave 201306081255-143311683-42731-13007-0 [ OK ] AllocatorTest/0.TaskFinished (54 ms) [ RUN ] AllocatorTest/0.WhitelistSlave I0608 12:55:56.015689 13033 master.cpp:228] Master started on 67.195.138.8:42731 I0608 12:55:56.015734 13033 master.cpp:243] Master ID: 201306081255-143311683-42731-13007 I0608 12:55:56.016046 13030 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:42731 I0608 12:55:56.016114 13033 master.cpp:526] Elected as master! I0608 12:55:56.016119 13030 hierarchical_allocator_process.hpp:491] Updated slave white list: { dummy-slave } I0608 12:55:56.016528 13028 slave.cpp:216] Slave started on 96)@67.195.138.8:42731 I0608 12:55:56.016573 13028 slave.cpp:217] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=19718 I0608 12:55:56.016891 13027 sched.cpp:177] New master at [email protected]:42731 I0608 12:55:56.016950 13033 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0608 12:55:56.016999 13033 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 56.019us I0608 12:55:56.017052 13027 master.cpp:569] Registering framework 201306081255-143311683-42731-13007-0000 at scheduler(87)@67.195.138.8:42731 I0608 12:55:56.017211 13027 master.cpp:556] Framework 201306081255-143311683-42731-13007-0000 (scheduler(87)@67.195.138.8:42731) already registered, resending acknowledgement I0608 12:55:56.017246 13028 slave.cpp:537] New master detected at [email protected]:42731 I0608 12:55:56.017364 13031 hierarchical_allocator_process.hpp:327] Added framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.017375 13028 slave.cpp:552] Postponing registration until recovery is complete I0608 12:55:56.017384 13033 status_update_manager.cpp:155] New master detected at [email protected]:42731 I0608 12:55:56.017400 13031 hierarchical_allocator_process.hpp:705] No resources available to allocate! I0608 12:55:56.017277 13027 sched.cpp:222] Framework registered with 201306081255-143311683-42731-13007-0000 I0608 12:55:56.017464 13028 slave.cpp:398] Finished recovery I0608 12:55:56.017583 13031 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 183.014us I0608 12:55:56.017657 13027 sched.cpp:217] Ignoring framework registered message because the driver is already connected! I0608 12:55:56.017832 13030 master.cpp:891] Attempting to register slave on minerva.apache.org at slave(96)@67.195.138.8:42731 I0608 12:55:56.017948 13030 master.cpp:1851] Adding slave 201306081255-143311683-42731-13007-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=19718 I0608 12:55:56.018049 13026 slave.cpp:597] Registered with master [email protected]:42731; given slave ID 201306081255-143311683-42731-13007-0 I0608 12:55:56.018098 13030 master.cpp:880] Slave 201306081255-143311683-42731-13007-0 (minerva.apache.org) already registered, resending acknowledgement I0608 12:55:56.018173 13026 hierarchical_allocator_process.hpp:449] Added slave 201306081255-143311683-42731-13007-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=19718 (and cpus=2; mem=1024; ports=[31000-32000]; disk=19718 available) I0608 12:55:56.027210 13030 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 16.306us I0608 12:55:56.037271 13032 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 11.145us I0608 12:55:56.047327 13031 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 15.241us I0608 12:55:56.057569 13028 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 13.764us I0608 12:55:56.057664 13028 hierarchical_allocator_process.hpp:491] Updated slave white list: { dummy-slave, minerva.apache.org } I0608 12:55:56.067471 13033 hierarchical_allocator_process.hpp:727] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=19718 on slave 201306081255-143311683-42731-13007-0 to framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.067642 13033 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 214.852us I0608 12:55:56.067692 13030 master.hpp:313] Adding offer 201306081255-143311683-42731-13007-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=19718 on slave 201306081255-143311683-42731-13007-0 I0608 12:55:56.067782 13030 master.cpp:1239] Sending 1 offers to framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.067885 13033 sched.cpp:287] Received 1 offers I0608 12:55:56.077539 13033 sched.cpp:427] Stopping framework '201306081255-143311683-42731-13007-0000' I0608 12:55:56.077581 13027 master.cpp:385] Master terminating I0608 12:55:56.077692 13027 slave.cpp:493] Slave asked to shut down by [email protected]:42731 I0608 12:55:56.077708 13007 master.cpp:207] Shutting down master I0608 12:55:56.077741 13027 slave.cpp:448] Slave terminating I0608 12:55:56.077930 13033 hierarchical_allocator_process.hpp:412] Deactivated framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.077976 13007 master.hpp:323] Removing offer 201306081255-143311683-42731-13007-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=19718 on slave 201306081255-143311683-42731-13007-0 I0608 12:55:56.078133 13031 hierarchical_allocator_process.hpp:616] Recovered cpus=2; mem=1024; ports=[31000-32000]; disk=19718 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=19718) on slave 201306081255-143311683-42731-13007-0 from framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.078241 13031 hierarchical_allocator_process.hpp:367] Removed framework 201306081255-143311683-42731-13007-0000 I0608 12:55:56.078313 13031 hierarchical_allocator_process.hpp:477] Removed slave 201306081255-143311683-42731-13007-0 [ OK ] AllocatorTest/0.WhitelistSlave (63 ms) [----------] 9 tests from AllocatorTest/0 (451 ms total) [----------] 1 test from LoggingTest [ RUN ] LoggingTest.Toggle I0608 12:55:56.078817 13028 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0608 12:55:56.079349 13034 process.cpp:878] Socket closed while receiving I0608 12:55:56.079861 13027 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0608 12:55:56.080348 13034 process.cpp:878] Socket closed while receiving I0608 12:55:56.080857 13032 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0608 12:55:56.081447 13034 process.cpp:878] Socket closed while receiving I0608 12:55:56.081974 13028 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0608 12:55:56.082504 13034 process.cpp:878] Socket closed while receiving I0608 12:55:56.082983 13029 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0608 12:55:56.083513 13034 process.cpp:878] Socket closed while receiving I0608 12:55:56.084105 13030 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0608 12:55:56.084576 13034 process.cpp:878] Socket closed while receiving [ OK ] LoggingTest.Toggle (6 ms) [----------] 1 test from LoggingTest (6 ms total) [----------] 5 tests from CgroupsCpusetTest [ RUN ] CgroupsCpusetTest.OneCPUOneCpuset [ OK ] CgroupsCpusetTest.OneCPUOneCpuset (0 ms) [ RUN ] CgroupsCpusetTest.OneCPUManyCpusets [ OK ] CgroupsCpusetTest.OneCPUManyCpusets (0 ms) [ RUN ] CgroupsCpusetTest.ManyCPUOneCpuset [ OK ] CgroupsCpusetTest.ManyCPUOneCpuset (0 ms) [ RUN ] CgroupsCpusetTest.ManyCPUManyCpusets [ OK ] CgroupsCpusetTest.ManyCPUManyCpusets (0 ms) [ RUN ] CgroupsCpusetTest.IntegerAllocations [ OK ] CgroupsCpusetTest.IntegerAllocations (0 ms) [----------] 5 tests from CgroupsCpusetTest (1 ms total) [----------] 3 tests from FsTest [ RUN ] FsTest.MountTableRead [ OK ] FsTest.MountTableRead (0 ms) [ RUN ] FsTest.MountTableHasOption [ OK ] FsTest.MountTableHasOption (0 ms) [ RUN ] FsTest.FileSystemTableRead [ OK ] FsTest.FileSystemTableRead (0 ms) [----------] 3 tests from FsTest (0 ms total) [----------] Global test environment tear-down [==========] 165 tests from 33 test cases ran. (19122 ms total) [ PASSED ] 164 tests. [ FAILED ] 1 test, listed below: [ FAILED ] FaultToleranceTest.ReconcileIncompleteTasks 1 FAILED TEST FAIL: mesos-tests ================== 1 of 1 test failed ================== make[3]: *** [check-TESTS] Error 1 make[3]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src'> make[2]: *** [check-am] Error 2 make[2]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src'> make[1]: *** [check] Error 2 make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src'> make: *** [check-recursive] Error 1 I0608 12:55:59.218099 15762 exec.cpp:83] Committing suicide by killing the process group Build step 'Execute shell' marked build as failure
