See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/1282/>
------------------------------------------ [...truncated 51349 lines...] I0628 05:18:43.258708 20753 slave.cpp:484] Slave asked to shut down by [email protected]:46934 I0628 05:18:43.282527 20753 slave.cpp:1111] Asked to shut down framework 201306280518-160088899-46934-20705-0000 by [email protected]:46934 I0628 05:18:43.290480 20753 slave.cpp:1136] Shutting down framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.298451 20753 slave.cpp:2327] Shutting down executor 'default' of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.306463 20753 slave.cpp:1883] [email protected]:46934 exited W0628 05:18:43.314388 20753 slave.cpp:1886] Master disconnected! Waiting for a new master to be elected I0628 05:18:43.322361 20753 slave.cpp:1111] Asked to shut down framework 201306280518-160088899-46934-20705-0000 by [email protected]:46934 W0628 05:18:43.330342 20753 slave.cpp:1132] Ignoring shutdown framework 201306280518-160088899-46934-20705-0000 because it is terminating I0628 05:18:43.306491 20754 exec.cpp:323] Executor asked to shutdown I0628 05:18:43.266744 20750 hierarchical_allocator_process.hpp:412] Deactivated framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.354300 20750 hierarchical_allocator_process.hpp:667] Performed allocation for 2 slaves in 24.865us I0628 05:18:43.362308 20750 hierarchical_allocator_process.hpp:616] Recovered cpus=2; mem=512 (total allocatable: cpus=2; mem=512; ports=[]; disk=0) on slave 201306280518-160088899-46934-20705-0 from framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.370283 20750 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=512; ports=[31000-32000]; disk=835850 (total allocatable: cpus=3; mem=1024; ports=[31000-32000]; disk=835850) on slave 201306280518-160088899-46934-20705-0 from framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.258673 20755 slave.cpp:484] Slave asked to shut down by [email protected]:46934 I0628 05:18:43.386150 20755 slave.cpp:439] Slave terminating I0628 05:18:43.274647 20705 master.hpp:323] Removing offer 201306280518-160088899-46934-20705-5 with resources cpus=1; mem=512; ports=[31000-32000]; disk=835850 on slave 201306280518-160088899-46934-20705-0 I0628 05:18:43.402189 20705 master.hpp:323] Removing offer 201306280518-160088899-46934-20705-4 with resources cpus=4; mem=2048; ports=[31000-32000]; disk=835850 on slave 201306280518-160088899-46934-20705-1 I0628 05:18:43.402338 20755 hierarchical_allocator_process.hpp:616] Recovered cpus=4; mem=2048; ports=[31000-32000]; disk=835850 (total allocatable: cpus=4; mem=2048; ports=[31000-32000]; disk=835850) on slave 201306280518-160088899-46934-20705-1 from framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.410454 20753 slave.cpp:439] Slave terminating I0628 05:18:43.426020 20753 slave.cpp:1111] Asked to shut down framework 201306280518-160088899-46934-20705-0000 by @0.0.0.0:0 W0628 05:18:43.433984 20753 slave.cpp:1132] Ignoring shutdown framework 201306280518-160088899-46934-20705-0000 because it is terminating I0628 05:18:43.418094 20755 hierarchical_allocator_process.hpp:367] Removed framework 201306280518-160088899-46934-20705-0000 [ OK ] AllocatorTest/0.SlaveAdded (1089 ms) [ RUN ] AllocatorTest/0.TaskFinished I0628 05:18:43.450713 20749 master.cpp:228] Master started on 67.195.138.9:46934 I0628 05:18:43.451318 20750 slave.cpp:112] Slave started on 489)@67.195.138.9:46934 I0628 05:18:43.466078 20750 slave.cpp:204] Slave resources: cpus=3; mem=1024; ports=[31000-32000]; disk=835849 I0628 05:18:43.458062 20749 master.cpp:243] Master ID: 201306280518-160088899-46934-20705 W0628 05:18:43.482049 20755 master.cpp:83] No whitelist given. Advertising offers for all slaves I0628 05:18:43.474477 20750 slave.cpp:528] New master detected at [email protected]:46934 I0628 05:18:43.497786 20750 slave.cpp:543] Postponing registration until recovery is complete I0628 05:18:43.505812 20750 slave.cpp:389] Finished recovery I0628 05:18:43.482180 20754 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:46934 I0628 05:18:43.482151 20749 master.cpp:526] Elected as master! I0628 05:18:43.575204 20749 master.cpp:891] Attempting to register slave on vesta.apache.org at slave(489)@67.195.138.9:46934 I0628 05:18:43.587093 20749 master.cpp:1851] Adding slave 201306280518-160088899-46934-20705-0 at vesta.apache.org with cpus=3; mem=1024; ports=[31000-32000]; disk=835849 I0628 05:18:43.599200 20749 slave.cpp:588] Registered with master [email protected]:46934; given slave ID 201306280518-160088899-46934-20705-0 I0628 05:18:43.451900 20756 sched.cpp:177] New master at [email protected]:46934 I0628 05:18:43.623106 20756 master.cpp:569] Registering framework 201306280518-160088899-46934-20705-0000 at scheduler(444)@67.195.138.9:46934 I0628 05:18:43.634999 20756 sched.cpp:222] Framework registered with 201306280518-160088899-46934-20705-0000 I0628 05:18:43.497817 20753 status_update_manager.cpp:155] New master detected at [email protected]:46934 I0628 05:18:43.599323 20750 hierarchical_allocator_process.hpp:449] Added slave 201306280518-160088899-46934-20705-0 (vesta.apache.org) with cpus=3; mem=1024; ports=[31000-32000]; disk=835849 (and cpus=3; mem=1024; ports=[31000-32000]; disk=835849 available) I0628 05:18:43.670845 20750 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0628 05:18:43.682806 20750 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306280518-160088899-46934-20705-0 in 11.964551ms I0628 05:18:43.694797 20750 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0628 05:18:43.706704 20750 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 11.917373ms I0628 05:18:43.718744 20750 hierarchical_allocator_process.hpp:327] Added framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.730687 20750 hierarchical_allocator_process.hpp:727] Offering cpus=3; mem=1024; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 to framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.742741 20750 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 12.090734ms I0628 05:18:43.742826 20749 master.hpp:313] Adding offer 201306280518-160088899-46934-20705-0 with resources cpus=3; mem=1024; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 I0628 05:18:43.766569 20749 master.cpp:1239] Sending 1 offers to framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.768904 20751 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 25.556us I0628 05:18:43.778255 20754 master.cpp:1472] Processing reply for offer 201306280518-160088899-46934-20705-0 on slave 201306280518-160088899-46934-20705-0 (vesta.apache.org) for framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.801808 20754 master.hpp:291] Adding task 0 with resources cpus=1; mem=256 on slave 201306280518-160088899-46934-20705-0 I0628 05:18:43.813668 20754 master.cpp:1591] Launching task 0 of framework 201306280518-160088899-46934-20705-0000 with resources cpus=1; mem=256 on slave 201306280518-160088899-46934-20705-0 (vesta.apache.org) I0628 05:18:43.825733 20754 master.hpp:291] Adding task 1 with resources cpus=1; mem=256 on slave 201306280518-160088899-46934-20705-0 I0628 05:18:43.837563 20754 master.cpp:1591] Launching task 1 of framework 201306280518-160088899-46934-20705-0000 with resources cpus=1; mem=256 on slave 201306280518-160088899-46934-20705-0 (vesta.apache.org) I0628 05:18:43.849617 20754 master.hpp:323] Removing offer 201306280518-160088899-46934-20705-0 with resources cpus=3; mem=1024; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 I0628 05:18:43.840023 20756 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 29.483us I0628 05:18:43.873389 20756 hierarchical_allocator_process.hpp:526] Framework 201306280518-160088899-46934-20705-0000 left cpus=1; mem=512; ports=[31000-32000]; disk=835849 unused on slave 201306280518-160088899-46934-20705-0 I0628 05:18:43.885395 20756 hierarchical_allocator_process.hpp:569] Framework 201306280518-160088899-46934-20705-0000 filtered slave 201306280518-160088899-46934-20705-0 for 5secs I0628 05:18:43.825814 20749 slave.cpp:738] Got assigned task 0 for framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.906404 20749 slave.cpp:738] Got assigned task 1 for framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.914265 20749 slave.cpp:836] Launching task 0 for framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.923118 20749 paths.hpp:303] Created executor directory '/tmp/AllocatorTest_0_TaskFinished_xQlkl1/slaves/201306280518-160088899-46934-20705-0/frameworks/201306280518-160088899-46934-20705-0000/executors/default/runs/717c4cd2-0e4b-48ed-b83a-d79aafe30acc' I0628 05:18:43.930218 20749 slave.cpp:947] Queuing task '0' for executor default of framework '201306280518-160088899-46934-20705-0000 I0628 05:18:43.938065 20749 slave.cpp:836] Launching task 1 for framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.930539 20754 exec.cpp:170] Executor started at: executor(180)@67.195.138.9:46934 with pid 20705 I0628 05:18:43.923609 20755 hierarchical_allocator_process.hpp:797] Filtered cpus=1; mem=512; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 for framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.961956 20755 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 38.396416ms I0628 05:18:43.946013 20749 slave.cpp:947] Queuing task '1' for executor default of framework '201306280518-160088899-46934-20705-0000 I0628 05:18:43.977946 20749 slave.cpp:510] Successfully attached file '/tmp/AllocatorTest_0_TaskFinished_xQlkl1/slaves/201306280518-160088899-46934-20705-0/frameworks/201306280518-160088899-46934-20705-0000/executors/default/runs/717c4cd2-0e4b-48ed-b83a-d79aafe30acc' I0628 05:18:43.985978 20749 slave.cpp:1394] Got registration for executor 'default' of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.993198 20753 monitor.cpp:180] Publishing resource usage for executor 'default' of framework '201306280518-160088899-46934-20705-0000' I0628 05:18:43.993963 20749 slave.cpp:1509] Flushing queued task 1 for executor 'default' of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.009845 20749 slave.cpp:1509] Flushing queued task 0 for executor 'default' of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:43.994037 20751 exec.cpp:194] Executor registered on slave 201306280518-160088899-46934-20705-0 I0628 05:18:44.025810 20751 exec.cpp:258] Executor asked to run task '1' I0628 05:18:44.033856 20751 exec.cpp:258] Executor asked to run task '0' I0628 05:18:44.020161 20753 hierarchical_allocator_process.hpp:797] Filtered cpus=1; mem=512; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 for framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.049705 20753 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 29.592077ms I0628 05:18:44.042532 20751 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 6dcebf95-9fcb-4fde-ae03-a3dc3f7f5653) for task 1 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.065817 20749 slave.cpp:1691] Handling status update TASK_RUNNING (UUID: 6dcebf95-9fcb-4fde-ae03-a3dc3f7f5653) for task 1 of framework 201306280518-160088899-46934-20705-0000 from executor(180)@67.195.138.9:46934 I0628 05:18:44.073724 20749 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 6dcebf95-9fcb-4fde-ae03-a3dc3f7f5653) for task 1 of framework 201306280518-160088899-46934-20705-0000 with checkpoint=false I0628 05:18:44.081578 20749 status_update_manager.cpp:450] Creating StatusUpdate stream for task 1 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.089607 20749 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 6dcebf95-9fcb-4fde-ae03-a3dc3f7f5653) for task 1 of framework 201306280518-160088899-46934-20705-0000 to [email protected]:46934 I0628 05:18:44.097656 20749 slave.cpp:1802] Status update manager successfully handled status update TASK_RUNNING (UUID: 6dcebf95-9fcb-4fde-ae03-a3dc3f7f5653) for task 1 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.105525 20749 slave.cpp:1808] Sending acknowledgement for status update TASK_RUNNING (UUID: 6dcebf95-9fcb-4fde-ae03-a3dc3f7f5653) for task 1 of framework 201306280518-160088899-46934-20705-0000 to executor(180)@67.195.138.9:46934 I0628 05:18:44.097708 20755 master.cpp:1022] Status update from slave(489)@67.195.138.9:46934: task 1 of framework 201306280518-160088899-46934-20705-0000 is now in state TASK_RUNNING I0628 05:18:44.121747 20755 status_update_manager.cpp:360] Received status update acknowledgement 6dcebf95-9fcb-4fde-ae03-a3dc3f7f5653 for task 1 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.107998 20750 hierarchical_allocator_process.hpp:797] Filtered cpus=1; mem=512; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 for framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.153385 20750 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 45.486585ms I0628 05:18:44.145576 20755 slave.cpp:1342] Status update manager successfully handled status update acknowledgement 6dcebf95-9fcb-4fde-ae03-a3dc3f7f5653 for task 1 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.066565 20751 exec.cpp:404] Executor sending status update TASK_FINISHED (UUID: 00778ddf-9e4a-49c2-8b9c-5c290c179714) for task 1 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.177471 20752 slave.cpp:1691] Handling status update TASK_FINISHED (UUID: 00778ddf-9e4a-49c2-8b9c-5c290c179714) for task 1 of framework 201306280518-160088899-46934-20705-0000 from executor(180)@67.195.138.9:46934 I0628 05:18:44.178190 20751 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 4394d10a-b6a2-4ff0-bd30-5bd256d7af5d) for task 0 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.193265 20751 exec.cpp:290] Executor received status update acknowledgement 6dcebf95-9fcb-4fde-ae03-a3dc3f7f5653 for task 1 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.185482 20752 status_update_manager.cpp:290] Received status update TASK_FINISHED (UUID: 00778ddf-9e4a-49c2-8b9c-5c290c179714) for task 1 of framework 201306280518-160088899-46934-20705-0000 with checkpoint=false I0628 05:18:44.209223 20752 status_update_manager.cpp:336] Forwarding status update TASK_FINISHED (UUID: 00778ddf-9e4a-49c2-8b9c-5c290c179714) for task 1 of framework 201306280518-160088899-46934-20705-0000 to [email protected]:46934 I0628 05:18:44.193310 20756 slave.cpp:1691] Handling status update TASK_RUNNING (UUID: 4394d10a-b6a2-4ff0-bd30-5bd256d7af5d) for task 0 of framework 201306280518-160088899-46934-20705-0000 from executor(180)@67.195.138.9:46934 I0628 05:18:44.211616 20753 hierarchical_allocator_process.hpp:797] Filtered cpus=1; mem=512; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 for framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.217370 20749 master.cpp:1022] Status update from slave(489)@67.195.138.9:46934: task 1 of framework 201306280518-160088899-46934-20705-0000 is now in state TASK_FINISHED I0628 05:18:44.241256 20749 master.hpp:303] Removing task 1 with resources cpus=1; mem=256 on slave 201306280518-160088899-46934-20705-0 I0628 05:18:44.225299 20754 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 4394d10a-b6a2-4ff0-bd30-5bd256d7af5d) for task 0 of framework 201306280518-160088899-46934-20705-0000 with checkpoint=false I0628 05:18:44.257086 20754 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.225288 20756 slave.cpp:1802] Status update manager successfully handled status update TASK_FINISHED (UUID: 00778ddf-9e4a-49c2-8b9c-5c290c179714) for task 1 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.233149 20753 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 21.602371ms I0628 05:18:44.265094 20754 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 4394d10a-b6a2-4ff0-bd30-5bd256d7af5d) for task 0 of framework 201306280518-160088899-46934-20705-0000 to [email protected]:46934 I0628 05:18:44.273097 20756 slave.cpp:1808] Sending acknowledgement for status update TASK_FINISHED (UUID: 00778ddf-9e4a-49c2-8b9c-5c290c179714) for task 1 of framework 201306280518-160088899-46934-20705-0000 to executor(180)@67.195.138.9:46934 I0628 05:18:44.297082 20750 exec.cpp:290] Executor received status update acknowledgement 00778ddf-9e4a-49c2-8b9c-5c290c179714 for task 1 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.289131 20752 master.cpp:1022] Status update from slave(489)@67.195.138.9:46934: task 0 of framework 201306280518-160088899-46934-20705-0000 is now in state TASK_RUNNING I0628 05:18:44.297106 20755 status_update_manager.cpp:360] Received status update acknowledgement 00778ddf-9e4a-49c2-8b9c-5c290c179714 for task 1 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.281157 20753 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=256 (total allocatable: cpus=2; mem=768; ports=[31000-32000]; disk=835849) on slave 201306280518-160088899-46934-20705-0 from framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.297134 20756 slave.cpp:1802] Status update manager successfully handled status update TASK_RUNNING (UUID: 4394d10a-b6a2-4ff0-bd30-5bd256d7af5d) for task 0 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.336814 20756 slave.cpp:1808] Sending acknowledgement for status update TASK_RUNNING (UUID: 4394d10a-b6a2-4ff0-bd30-5bd256d7af5d) for task 0 of framework 201306280518-160088899-46934-20705-0000 to executor(180)@67.195.138.9:46934 I0628 05:18:44.331375 20751 hierarchical_allocator_process.hpp:727] Offering cpus=2; mem=768; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 to framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.320926 20755 status_update_manager.cpp:481] Cleaning up status update stream for task 1 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.344918 20749 exec.cpp:290] Executor received status update acknowledgement 4394d10a-b6a2-4ff0-bd30-5bd256d7af5d for task 0 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.353040 20751 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 21.72354ms I0628 05:18:44.353168 20756 master.hpp:313] Adding offer 201306280518-160088899-46934-20705-1 with resources cpus=2; mem=768; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 I0628 05:18:44.360909 20755 status_update_manager.cpp:360] Received status update acknowledgement 4394d10a-b6a2-4ff0-bd30-5bd256d7af5d for task 0 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.360970 20753 slave.cpp:1342] Status update manager successfully handled status update acknowledgement 00778ddf-9e4a-49c2-8b9c-5c290c179714 for task 1 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.384783 20756 master.cpp:1239] Sending 1 offers to framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.400686 20753 slave.cpp:1342] Status update manager successfully handled status update acknowledgement 4394d10a-b6a2-4ff0-bd30-5bd256d7af5d for task 0 of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.409042 20755 sched.cpp:427] Stopping framework '201306280518-160088899-46934-20705-0000' I0628 05:18:44.409075 20705 master.cpp:385] Master terminating I0628 05:18:44.427623 20750 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 36.249us I0628 05:18:44.432580 20705 master.cpp:207] Shutting down master I0628 05:18:44.432620 20749 slave.cpp:484] Slave asked to shut down by [email protected]:46934 I0628 05:18:44.448634 20752 hierarchical_allocator_process.hpp:412] Deactivated framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.448634 20705 master.hpp:303] Removing task 0 with resources cpus=1; mem=256 on slave 201306280518-160088899-46934-20705-0 I0628 05:18:44.456549 20749 slave.cpp:1111] Asked to shut down framework 201306280518-160088899-46934-20705-0000 by [email protected]:46934 I0628 05:18:44.480419 20749 slave.cpp:1136] Shutting down framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.472720 20756 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=256 (total allocatable: cpus=1; mem=256; ports=[]; disk=0) on slave 201306280518-160088899-46934-20705-0 from framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.472673 20705 master.hpp:323] Removing offer 201306280518-160088899-46934-20705-1 with resources cpus=2; mem=768; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 I0628 05:18:44.488394 20749 slave.cpp:2327] Shutting down executor 'default' of framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.512378 20749 slave.cpp:439] Slave terminating I0628 05:18:44.520362 20749 slave.cpp:1111] Asked to shut down framework 201306280518-160088899-46934-20705-0000 by @0.0.0.0:0 I0628 05:18:44.512413 20754 exec.cpp:323] Executor asked to shutdown I0628 05:18:44.496474 20756 hierarchical_allocator_process.hpp:616] Recovered cpus=2; mem=768; ports=[31000-32000]; disk=835849 (total allocatable: cpus=3; mem=1024; ports=[31000-32000]; disk=835849) on slave 201306280518-160088899-46934-20705-0 from framework 201306280518-160088899-46934-20705-0000 W0628 05:18:44.528261 20749 slave.cpp:1132] Ignoring shutdown framework 201306280518-160088899-46934-20705-0000 because it is terminating I0628 05:18:44.544283 20756 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 24.452us [ OK ] AllocatorTest/0.TaskFinished (1110 ms) [ RUN ] AllocatorTest/0.WhitelistSlave I0628 05:18:44.560988 20749 master.cpp:228] Master started on 67.195.138.9:46934 I0628 05:18:44.561507 20753 slave.cpp:112] Slave started on 490)@67.195.138.9:46934 I0628 05:18:44.568172 20749 master.cpp:243] Master ID: 201306280518-160088899-46934-20705 I0628 05:18:44.576208 20753 slave.cpp:204] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=835849 I0628 05:18:44.584398 20750 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:46934 I0628 05:18:44.600080 20750 hierarchical_allocator_process.hpp:491] Updated slave white list: { dummy-slave } I0628 05:18:44.607993 20750 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0628 05:18:44.615958 20750 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 7.966959ms I0628 05:18:44.584435 20749 master.cpp:526] Elected as master! I0628 05:18:44.584715 20754 sched.cpp:177] New master at [email protected]:46934 I0628 05:18:44.592560 20753 slave.cpp:528] New master detected at [email protected]:46934 I0628 05:18:44.647886 20753 slave.cpp:543] Postponing registration until recovery is complete I0628 05:18:44.655841 20753 slave.cpp:389] Finished recovery I0628 05:18:44.647929 20749 status_update_manager.cpp:155] New master detected at [email protected]:46934 I0628 05:18:44.640096 20754 master.cpp:569] Registering framework 201306280518-160088899-46934-20705-0000 at scheduler(445)@67.195.138.9:46934 I0628 05:18:44.679966 20754 master.cpp:556] Framework 201306280518-160088899-46934-20705-0000 (scheduler(445)@67.195.138.9:46934) already registered, resending acknowledgement I0628 05:18:44.679986 20752 sched.cpp:222] Framework registered with 201306280518-160088899-46934-20705-0000 I0628 05:18:44.680145 20753 hierarchical_allocator_process.hpp:327] Added framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.687937 20754 master.cpp:891] Attempting to register slave on vesta.apache.org at slave(490)@67.195.138.9:46934 I0628 05:18:44.695860 20752 sched.cpp:217] Ignoring framework registered message because the driver is already connected! I0628 05:18:44.709450 20753 hierarchical_allocator_process.hpp:705] No resources available to allocate! I0628 05:18:44.771529 20753 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 62.083721ms I0628 05:18:44.755646 20754 master.cpp:1851] Adding slave 201306280518-160088899-46934-20705-0 at vesta.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=835849 I0628 05:18:44.787642 20756 slave.cpp:588] Registered with master [email protected]:46934; given slave ID 201306280518-160088899-46934-20705-0 I0628 05:18:44.787663 20754 master.cpp:880] Slave 201306280518-160088899-46934-20705-0 (vesta.apache.org) already registered, resending acknowledgement I0628 05:18:44.787907 20750 hierarchical_allocator_process.hpp:449] Added slave 201306280518-160088899-46934-20705-0 (vesta.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=835849 (and cpus=2; mem=1024; ports=[31000-32000]; disk=835849 available) W0628 05:18:44.803540 20754 slave.cpp:612] Already registered with master [email protected]:46934 I0628 05:18:44.826493 20751 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 33.071us I0628 05:18:44.836477 20755 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 29.631us I0628 05:18:44.846518 20755 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 22.005us I0628 05:18:44.856621 20749 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 26.516us I0628 05:18:44.856781 20749 hierarchical_allocator_process.hpp:491] Updated slave white list: { dummy-slave, vesta.apache.org } I0628 05:18:44.876706 20752 hierarchical_allocator_process.hpp:727] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 to framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.876951 20752 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 303.829us I0628 05:18:44.877056 20756 master.hpp:313] Adding offer 201306280518-160088899-46934-20705-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 I0628 05:18:44.895149 20756 master.cpp:1239] Sending 1 offers to framework 201306280518-160088899-46934-20705-0000 I0628 05:18:44.906877 20756 sched.cpp:427] Stopping framework '201306280518-160088899-46934-20705-0000' I0628 05:18:44.906921 20754 master.cpp:385] Master terminating I0628 05:18:44.919057 20754 slave.cpp:484] Slave asked to shut down by [email protected]:46934 I0628 05:18:44.919108 20705 master.cpp:207] Shutting down master I0628 05:18:44.927125 20754 slave.cpp:439] Slave terminating I0628 05:18:44.935145 20705 master.hpp:323] Removing offer 201306280518-160088899-46934-20705-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=835849 on slave 201306280518-160088899-46934-20705-0 I0628 05:18:44.935186 20752 hierarchical_allocator_process.hpp:412] Deactivated framework 201306280518-160088899-46934-20705-0000 [ OK ] AllocatorTest/0.WhitelistSlave (399 ms) [----------] 9 tests from AllocatorTest/0 (6583 ms total) [----------] 1 test from LoggingTest [ RUN ] LoggingTest.Toggle I0628 05:18:44.959456 20750 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0628 05:18:44.967397 20757 process.cpp:878] Socket closed while receiving I0628 05:18:44.975450 20752 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0628 05:18:44.983185 20757 process.cpp:878] Socket closed while receiving I0628 05:18:44.991422 20749 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0628 05:18:44.999101 20757 process.cpp:878] Socket closed while receiving I0628 05:18:45.007356 20755 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0628 05:18:45.015287 20757 process.cpp:878] Socket closed while receiving I0628 05:18:45.023332 20749 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0628 05:18:45.031172 20757 process.cpp:878] Socket closed while receiving I0628 05:18:45.039181 20753 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0628 05:18:45.047163 20757 process.cpp:878] Socket closed while receiving [ OK ] LoggingTest.Toggle (96 ms) [----------] 1 test from LoggingTest (96 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 (0 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 [==========] 168 tests from 32 test cases ran. (45506 ms total) [ PASSED ] 168 tests. make[3]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/src' make[2]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/src' make[1]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/src' Making check in ec2 make[1]: Entering directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/ec2' make[1]: Nothing to be done for `check'. make[1]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/ec2' Making check in hadoop make[1]: Entering directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/hadoop' make[1]: Nothing to be done for `check'. make[1]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/hadoop' Making check in jenkins make[1]: Entering directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/jenkins' make[1]: Nothing to be done for `check'. make[1]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/jenkins' make: *** No rule to make target `GTEST_BREAK_ON_FAILURE'. Stop. Build step 'Execute shell' marked build as failure
