See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/1228/>
------------------------------------------ [...truncated 12220 lines...] I0620 15:44:41.014936 2773 master.hpp:323] Removing offer 201306201544-143311683-47608-2686-3 with resources cpus=4; mem=2048; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-1 I0620 15:44:41.014967 2770 hierarchical_allocator_process.hpp:526] Framework 201306201544-143311683-47608-2686-0000 left cpus=4; mem=2048; ports=[31000-32000]; disk=17975 unused on slave 201306201544-143311683-47608-2686-1 I0620 15:44:41.065547 2772 hierarchical_allocator_process.hpp:727] Offering cpus=1; mem=512; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-0 to framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.065624 2772 hierarchical_allocator_process.hpp:727] Offering cpus=4; mem=2048; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-1 to framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.065773 2772 hierarchical_allocator_process.hpp:667] Performed allocation for 2 slaves in 241.292us I0620 15:44:41.065804 2768 master.hpp:313] Adding offer 201306201544-143311683-47608-2686-4 with resources cpus=4; mem=2048; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-1 I0620 15:44:41.065935 2768 master.hpp:313] Adding offer 201306201544-143311683-47608-2686-5 with resources cpus=1; mem=512; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.066009 2768 master.cpp:1239] Sending 2 offers to framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.066285 2768 sched.cpp:427] Stopping framework '201306201544-143311683-47608-2686-0000' I0620 15:44:41.066328 2686 master.cpp:385] Master terminating I0620 15:44:41.066458 2686 master.cpp:207] Shutting down master I0620 15:44:41.066472 2770 slave.cpp:496] Slave asked to shut down by [email protected]:47608 I0620 15:44:41.066556 2771 hierarchical_allocator_process.hpp:412] Deactivated framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.066493 2766 slave.cpp:496] Slave asked to shut down by [email protected]:47608 I0620 15:44:41.066572 2686 master.hpp:303] Removing task 0 with resources cpus=2; mem=512 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.066601 2770 slave.cpp:1113] Asked to shut down framework 201306201544-143311683-47608-2686-0000 by [email protected]:47608 I0620 15:44:41.066823 2770 slave.cpp:1138] Shutting down framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.066884 2770 slave.cpp:2320] Shutting down executor 'default' of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.066886 2768 hierarchical_allocator_process.hpp:616] Recovered cpus=2; mem=512 (total allocatable: cpus=2; mem=512; ports=[]; disk=0) on slave 201306201544-143311683-47608-2686-0 from framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.066889 2686 master.hpp:323] Removing offer 201306201544-143311683-47608-2686-5 with resources cpus=1; mem=512; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.066701 2766 slave.cpp:451] Slave terminating I0620 15:44:41.067189 2768 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=512; ports=[31000-32000]; disk=17975 (total allocatable: cpus=3; mem=1024; ports=[31000-32000]; disk=17975) on slave 201306201544-143311683-47608-2686-0 from framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.066999 2767 exec.cpp:323] Executor asked to shutdown I0620 15:44:41.067278 2686 master.hpp:323] Removing offer 201306201544-143311683-47608-2686-4 with resources cpus=4; mem=2048; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-1 I0620 15:44:41.066988 2770 slave.cpp:1885] [email protected]:47608 exited I0620 15:44:41.067395 2766 hierarchical_allocator_process.hpp:616] Recovered cpus=4; mem=2048; ports=[31000-32000]; disk=17975 (total allocatable: cpus=4; mem=2048; ports=[31000-32000]; disk=17975) on slave 201306201544-143311683-47608-2686-1 from framework 201306201544-143311683-47608-2686-0000 W0620 15:44:41.067493 2770 slave.cpp:1888] Master disconnected! Waiting for a new master to be elected I0620 15:44:41.067622 2766 hierarchical_allocator_process.hpp:367] Removed framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.067724 2770 slave.cpp:1113] Asked to shut down framework 201306201544-143311683-47608-2686-0000 by [email protected]:47608 I0620 15:44:41.067786 2766 hierarchical_allocator_process.hpp:477] Removed slave 201306201544-143311683-47608-2686-1 W0620 15:44:41.067827 2770 slave.cpp:1134] Ignoring shutdown framework 201306201544-143311683-47608-2686-0000 because it is terminating I0620 15:44:41.067936 2766 hierarchical_allocator_process.hpp:477] Removed slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.067970 2770 slave.cpp:451] Slave terminating I0620 15:44:41.068089 2770 slave.cpp:1113] Asked to shut down framework 201306201544-143311683-47608-2686-0000 by @0.0.0.0:0 W0620 15:44:41.068156 2770 slave.cpp:1134] Ignoring shutdown framework 201306201544-143311683-47608-2686-0000 because it is terminating [ OK ] AllocatorTest/0.SlaveAdded (164 ms) [ RUN ] AllocatorTest/0.TaskFinished I0620 15:44:41.069089 2769 master.cpp:228] Master started on 67.195.138.8:47608 I0620 15:44:41.069150 2769 master.cpp:243] Master ID: 201306201544-143311683-47608-2686 W0620 15:44:41.069306 2772 master.cpp:83] No whitelist given. Advertising offers for all slaves I0620 15:44:41.069429 2772 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:47608 I0620 15:44:41.069574 2769 master.cpp:526] Elected as master! I0620 15:44:41.069802 2772 slave.cpp:219] Slave started on 97)@67.195.138.8:47608 I0620 15:44:41.069844 2772 slave.cpp:220] Slave resources: cpus=3; mem=1024; ports=[31000-32000]; disk=17975 I0620 15:44:41.070255 2772 slave.cpp:540] New master detected at [email protected]:47608 I0620 15:44:41.070287 2772 slave.cpp:555] Postponing registration until recovery is complete I0620 15:44:41.070418 2766 sched.cpp:177] New master at [email protected]:47608 I0620 15:44:41.070441 2772 slave.cpp:401] Finished recovery I0620 15:44:41.070468 2767 status_update_manager.cpp:155] New master detected at [email protected]:47608 I0620 15:44:41.070641 2766 master.cpp:569] Registering framework 201306201544-143311683-47608-2686-0000 at scheduler(88)@67.195.138.8:47608 I0620 15:44:41.070833 2772 sched.cpp:222] Framework registered with 201306201544-143311683-47608-2686-0000 I0620 15:44:41.070853 2766 master.cpp:891] Attempting to register slave on minerva.apache.org at slave(97)@67.195.138.8:47608 I0620 15:44:41.070950 2766 master.cpp:1851] Adding slave 201306201544-143311683-47608-2686-0 at minerva.apache.org with cpus=3; mem=1024; ports=[31000-32000]; disk=17975 I0620 15:44:41.071092 2773 slave.cpp:600] Registered with master [email protected]:47608; given slave ID 201306201544-143311683-47608-2686-0 I0620 15:44:41.070914 2772 hierarchical_allocator_process.hpp:327] Added framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.071202 2772 hierarchical_allocator_process.hpp:705] No resources available to allocate! I0620 15:44:41.071259 2772 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 57.051us I0620 15:44:41.071347 2772 hierarchical_allocator_process.hpp:449] Added slave 201306201544-143311683-47608-2686-0 (minerva.apache.org) with cpus=3; mem=1024; ports=[31000-32000]; disk=17975 (and cpus=3; mem=1024; ports=[31000-32000]; disk=17975 available) I0620 15:44:41.071398 2772 hierarchical_allocator_process.hpp:727] Offering cpus=3; mem=1024; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-0 to framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.071574 2772 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306201544-143311683-47608-2686-0 in 182.584us I0620 15:44:41.071599 2773 master.hpp:313] Adding offer 201306201544-143311683-47608-2686-0 with resources cpus=3; mem=1024; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.071679 2773 master.cpp:1239] Sending 1 offers to framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.071920 2773 master.cpp:1472] Processing reply for offer 201306201544-143311683-47608-2686-0 on slave 201306201544-143311683-47608-2686-0 (minerva.apache.org) for framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.072010 2773 master.hpp:291] Adding task 0 with resources cpus=1; mem=256 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.072052 2773 master.cpp:1591] Launching task 0 of framework 201306201544-143311683-47608-2686-0000 with resources cpus=1; mem=256 on slave 201306201544-143311683-47608-2686-0 (minerva.apache.org) I0620 15:44:41.072139 2772 slave.cpp:740] Got assigned task 0 for framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.072175 2773 master.hpp:291] Adding task 1 with resources cpus=1; mem=256 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.072237 2773 master.cpp:1591] Launching task 1 of framework 201306201544-143311683-47608-2686-0000 with resources cpus=1; mem=256 on slave 201306201544-143311683-47608-2686-0 (minerva.apache.org) I0620 15:44:41.072299 2772 slave.cpp:838] Launching task 0 for framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.072379 2773 master.hpp:323] Removing offer 201306201544-143311683-47608-2686-0 with resources cpus=3; mem=1024; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.072451 2769 hierarchical_allocator_process.hpp:526] Framework 201306201544-143311683-47608-2686-0000 left cpus=1; mem=512; ports=[31000-32000]; disk=17975 unused on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.072626 2769 hierarchical_allocator_process.hpp:569] Framework 201306201544-143311683-47608-2686-0000 filtered slave 201306201544-143311683-47608-2686-0 for 5secs I0620 15:44:41.073287 2772 paths.hpp:303] Created executor directory '/tmp/AllocatorTest_0_TaskFinished_rTkwDz/slaves/201306201544-143311683-47608-2686-0/frameworks/201306201544-143311683-47608-2686-0000/executors/default/runs/736452fd-3093-4d1f-81ae-f26fd749e312' I0620 15:44:41.073462 2772 slave.cpp:949] Queuing task '0' for executor default of framework '201306201544-143311683-47608-2686-0000 I0620 15:44:41.073539 2772 slave.cpp:740] Got assigned task 1 for framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.073652 2769 exec.cpp:170] Executor started at: executor(36)@67.195.138.8:47608 with pid 2686 I0620 15:44:41.073659 2772 slave.cpp:522] Successfully attached file '/tmp/AllocatorTest_0_TaskFinished_rTkwDz/slaves/201306201544-143311683-47608-2686-0/frameworks/201306201544-143311683-47608-2686-0000/executors/default/runs/736452fd-3093-4d1f-81ae-f26fd749e312' I0620 15:44:41.073819 2772 slave.cpp:838] Launching task 1 for framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.073896 2772 slave.cpp:949] Queuing task '1' for executor default of framework '201306201544-143311683-47608-2686-0000 I0620 15:44:41.074013 2772 slave.cpp:1396] Got registration for executor 'default' of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.074187 2772 slave.cpp:1511] Flushing queued task 1 for executor 'default' of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.074265 2771 exec.cpp:194] Executor registered on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.074275 2772 slave.cpp:1511] Flushing queued task 0 for executor 'default' of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.074383 2771 exec.cpp:258] Executor asked to run task '1' I0620 15:44:41.074537 2771 exec.cpp:258] Executor asked to run task '0' I0620 15:44:41.075368 2771 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 77bd74df-cd52-4d91-afab-686f70d46633) for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.075453 2769 slave.cpp:1693] Handling status update TASK_RUNNING (UUID: 77bd74df-cd52-4d91-afab-686f70d46633) for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.075587 2769 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 77bd74df-cd52-4d91-afab-686f70d46633) for task 1 of framework 201306201544-143311683-47608-2686-0000 with checkpoint=false I0620 15:44:41.075623 2769 status_update_manager.cpp:450] Creating StatusUpdate stream for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.075749 2769 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 77bd74df-cd52-4d91-afab-686f70d46633) for task 1 of framework 201306201544-143311683-47608-2686-0000 to [email protected]:47608 I0620 15:44:41.075892 2768 master.cpp:1022] Status update from slave(97)@67.195.138.8:47608: task 1 of framework 201306201544-143311683-47608-2686-0000 is now in state TASK_RUNNING I0620 15:44:41.076006 2769 slave.cpp:1804] Status update manager successfully handled status update TASK_RUNNING (UUID: 77bd74df-cd52-4d91-afab-686f70d46633) for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.076042 2769 slave.cpp:1810] Sending acknowledgement for status update TASK_RUNNING (UUID: 77bd74df-cd52-4d91-afab-686f70d46633) for task 1 of framework 201306201544-143311683-47608-2686-0000 to executor(36)@67.195.138.8:47608 I0620 15:44:41.076196 2769 status_update_manager.cpp:360] Received status update acknowledgement 77bd74df-cd52-4d91-afab-686f70d46633 for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.076285 2769 slave.cpp:1344] Status update manager successfully handled status update acknowledgement 77bd74df-cd52-4d91-afab-686f70d46633 for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.076292 2771 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 6d884307-fe6d-4526-9d2e-79bc0e54f337) for task 0 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.076424 2768 slave.cpp:1693] Handling status update TASK_RUNNING (UUID: 6d884307-fe6d-4526-9d2e-79bc0e54f337) for task 0 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.076537 2768 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 6d884307-fe6d-4526-9d2e-79bc0e54f337) for task 0 of framework 201306201544-143311683-47608-2686-0000 with checkpoint=false I0620 15:44:41.076568 2768 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.076660 2768 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 6d884307-fe6d-4526-9d2e-79bc0e54f337) for task 0 of framework 201306201544-143311683-47608-2686-0000 to [email protected]:47608 I0620 15:44:41.076776 2768 master.cpp:1022] Status update from slave(97)@67.195.138.8:47608: task 0 of framework 201306201544-143311683-47608-2686-0000 is now in state TASK_RUNNING I0620 15:44:41.076788 2772 slave.cpp:1804] Status update manager successfully handled status update TASK_RUNNING (UUID: 6d884307-fe6d-4526-9d2e-79bc0e54f337) for task 0 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.076887 2772 slave.cpp:1810] Sending acknowledgement for status update TASK_RUNNING (UUID: 6d884307-fe6d-4526-9d2e-79bc0e54f337) for task 0 of framework 201306201544-143311683-47608-2686-0000 to executor(36)@67.195.138.8:47608 I0620 15:44:41.077016 2772 status_update_manager.cpp:360] Received status update acknowledgement 6d884307-fe6d-4526-9d2e-79bc0e54f337 for task 0 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.077136 2772 slave.cpp:1344] Status update manager successfully handled status update acknowledgement 6d884307-fe6d-4526-9d2e-79bc0e54f337 for task 0 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.077572 2771 exec.cpp:404] Executor sending status update TASK_FINISHED (UUID: be881c2a-21f2-4463-99e3-35abe5e471c3) for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.077625 2771 exec.cpp:290] Executor received status update acknowledgement 77bd74df-cd52-4d91-afab-686f70d46633 for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.077695 2771 exec.cpp:290] Executor received status update acknowledgement 6d884307-fe6d-4526-9d2e-79bc0e54f337 for task 0 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.077651 2768 slave.cpp:1693] Handling status update TASK_FINISHED (UUID: be881c2a-21f2-4463-99e3-35abe5e471c3) for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.077939 2767 status_update_manager.cpp:290] Received status update TASK_FINISHED (UUID: be881c2a-21f2-4463-99e3-35abe5e471c3) for task 1 of framework 201306201544-143311683-47608-2686-0000 with checkpoint=false I0620 15:44:41.078023 2767 status_update_manager.cpp:336] Forwarding status update TASK_FINISHED (UUID: be881c2a-21f2-4463-99e3-35abe5e471c3) for task 1 of framework 201306201544-143311683-47608-2686-0000 to [email protected]:47608 I0620 15:44:41.078152 2772 master.cpp:1022] Status update from slave(97)@67.195.138.8:47608: task 1 of framework 201306201544-143311683-47608-2686-0000 is now in state TASK_FINISHED I0620 15:44:41.078201 2773 slave.cpp:1804] Status update manager successfully handled status update TASK_FINISHED (UUID: be881c2a-21f2-4463-99e3-35abe5e471c3) for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.078327 2773 slave.cpp:1810] Sending acknowledgement for status update TASK_FINISHED (UUID: be881c2a-21f2-4463-99e3-35abe5e471c3) for task 1 of framework 201306201544-143311683-47608-2686-0000 to executor(36)@67.195.138.8:47608 I0620 15:44:41.078352 2772 master.hpp:303] Removing task 1 with resources cpus=1; mem=256 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.078441 2768 exec.cpp:290] Executor received status update acknowledgement be881c2a-21f2-4463-99e3-35abe5e471c3 for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.078490 2770 status_update_manager.cpp:360] Received status update acknowledgement be881c2a-21f2-4463-99e3-35abe5e471c3 for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.078662 2770 status_update_manager.cpp:481] Cleaning up status update stream for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.078655 2767 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=256 (total allocatable: cpus=2; mem=768; ports=[31000-32000]; disk=17975) on slave 201306201544-143311683-47608-2686-0 from framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.078815 2769 slave.cpp:1344] Status update manager successfully handled status update acknowledgement be881c2a-21f2-4463-99e3-35abe5e471c3 for task 1 of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.120107 2770 hierarchical_allocator_process.hpp:727] Offering cpus=2; mem=768; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-0 to framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.120322 2770 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 244.672us I0620 15:44:41.120393 2773 master.hpp:313] Adding offer 201306201544-143311683-47608-2686-1 with resources cpus=2; mem=768; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.120491 2773 master.cpp:1239] Sending 1 offers to framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.120770 2768 sched.cpp:427] Stopping framework '201306201544-143311683-47608-2686-0000' I0620 15:44:41.120826 2686 master.cpp:385] Master terminating I0620 15:44:41.120934 2769 slave.cpp:496] Slave asked to shut down by [email protected]:47608 I0620 15:44:41.120950 2686 master.cpp:207] Shutting down master I0620 15:44:41.120977 2769 slave.cpp:1113] Asked to shut down framework 201306201544-143311683-47608-2686-0000 by [email protected]:47608 I0620 15:44:41.121124 2769 slave.cpp:1138] Shutting down framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.121187 2766 hierarchical_allocator_process.hpp:412] Deactivated framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.121192 2769 slave.cpp:2320] Shutting down executor 'default' of framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.121129 2686 master.hpp:303] Removing task 0 with resources cpus=1; mem=256 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.121348 2770 exec.cpp:323] Executor asked to shutdown I0620 15:44:41.121526 2686 master.hpp:323] Removing offer 201306201544-143311683-47608-2686-1 with resources cpus=2; mem=768; ports=[31000-32000]; disk=17975 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.121552 2772 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=256 (total allocatable: cpus=1; mem=256; ports=[]; disk=0) on slave 201306201544-143311683-47608-2686-0 from framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.121722 2769 slave.cpp:1885] [email protected]:47608 exited I0620 15:44:41.121758 2772 hierarchical_allocator_process.hpp:616] Recovered cpus=2; mem=768; ports=[31000-32000]; disk=17975 (total allocatable: cpus=3; mem=1024; ports=[31000-32000]; disk=17975) on slave 201306201544-143311683-47608-2686-0 from framework 201306201544-143311683-47608-2686-0000 W0620 15:44:41.121778 2769 slave.cpp:1888] Master disconnected! Waiting for a new master to be elected I0620 15:44:41.121924 2772 hierarchical_allocator_process.hpp:367] Removed framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.121947 2769 slave.cpp:451] Slave terminating I0620 15:44:41.122061 2769 slave.cpp:1113] Asked to shut down framework 201306201544-143311683-47608-2686-0000 by @0.0.0.0:0 I0620 15:44:41.122088 2772 hierarchical_allocator_process.hpp:477] Removed slave 201306201544-143311683-47608-2686-0 W0620 15:44:41.122118 2769 slave.cpp:1134] Ignoring shutdown framework 201306201544-143311683-47608-2686-0000 because it is terminating [ OK ] AllocatorTest/0.TaskFinished (54 ms) [ RUN ] AllocatorTest/0.WhitelistSlave I0620 15:44:41.123255 2773 master.cpp:228] Master started on 67.195.138.8:47608 I0620 15:44:41.123354 2773 master.cpp:243] Master ID: 201306201544-143311683-47608-2686 I0620 15:44:41.123638 2770 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:47608 I0620 15:44:41.123713 2770 hierarchical_allocator_process.hpp:491] Updated slave white list: { dummy-slave } I0620 15:44:41.123733 2773 master.cpp:526] Elected as master! I0620 15:44:41.131127 2771 slave.cpp:219] Slave started on 98)@67.195.138.8:47608 I0620 15:44:41.131494 2769 sched.cpp:177] New master at [email protected]:47608 I0620 15:44:41.137662 2770 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0620 15:44:41.137961 2770 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 299.116us I0620 15:44:41.137809 2771 slave.cpp:220] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=17974 I0620 15:44:41.138139 2768 master.cpp:569] Registering framework 201306201544-143311683-47608-2686-0000 at scheduler(89)@67.195.138.8:47608 I0620 15:44:41.138244 2768 master.cpp:556] Framework 201306201544-143311683-47608-2686-0000 (scheduler(89)@67.195.138.8:47608) already registered, resending acknowledgement I0620 15:44:41.138272 2766 sched.cpp:222] Framework registered with 201306201544-143311683-47608-2686-0000 I0620 15:44:41.138293 2769 hierarchical_allocator_process.hpp:327] Added framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.138384 2766 sched.cpp:217] Ignoring framework registered message because the driver is already connected! I0620 15:44:41.138432 2769 hierarchical_allocator_process.hpp:705] No resources available to allocate! I0620 15:44:41.138586 2769 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 151.825us I0620 15:44:41.138736 2771 slave.cpp:540] New master detected at [email protected]:47608 I0620 15:44:41.138833 2771 slave.cpp:555] Postponing registration until recovery is complete I0620 15:44:41.138864 2771 slave.cpp:401] Finished recovery I0620 15:44:41.138885 2772 status_update_manager.cpp:155] New master detected at [email protected]:47608 I0620 15:44:41.139037 2769 master.cpp:891] Attempting to register slave on minerva.apache.org at slave(98)@67.195.138.8:47608 I0620 15:44:41.139099 2769 master.cpp:1851] Adding slave 201306201544-143311683-47608-2686-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=17974 I0620 15:44:41.139183 2768 slave.cpp:600] Registered with master [email protected]:47608; given slave ID 201306201544-143311683-47608-2686-0 I0620 15:44:41.139322 2769 master.cpp:880] Slave 201306201544-143311683-47608-2686-0 (minerva.apache.org) already registered, resending acknowledgement I0620 15:44:41.139405 2769 hierarchical_allocator_process.hpp:449] Added slave 201306201544-143311683-47608-2686-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=17974 (and cpus=2; mem=1024; ports=[31000-32000]; disk=17974 available) I0620 15:44:41.141620 2771 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 21.653us I0620 15:44:41.151667 2767 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 14.252us I0620 15:44:41.161728 2772 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 19.061us I0620 15:44:41.171983 2768 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 8.117us I0620 15:44:41.172072 2768 hierarchical_allocator_process.hpp:491] Updated slave white list: { dummy-slave, minerva.apache.org } I0620 15:44:41.181836 2773 hierarchical_allocator_process.hpp:727] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=17974 on slave 201306201544-143311683-47608-2686-0 to framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.181962 2773 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 140.657us I0620 15:44:41.182034 2773 master.hpp:313] Adding offer 201306201544-143311683-47608-2686-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=17974 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.182086 2773 master.cpp:1239] Sending 1 offers to framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.191933 2766 sched.cpp:427] Stopping framework '201306201544-143311683-47608-2686-0000' I0620 15:44:41.191983 2686 master.cpp:385] Master terminating I0620 15:44:41.192088 2766 slave.cpp:496] Slave asked to shut down by [email protected]:47608 I0620 15:44:41.192132 2766 slave.cpp:451] Slave terminating I0620 15:44:41.192087 2686 master.cpp:207] Shutting down master I0620 15:44:41.192410 2766 hierarchical_allocator_process.hpp:412] Deactivated framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.192461 2686 master.hpp:323] Removing offer 201306201544-143311683-47608-2686-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=17974 on slave 201306201544-143311683-47608-2686-0 I0620 15:44:41.192582 2766 hierarchical_allocator_process.hpp:616] Recovered cpus=2; mem=1024; ports=[31000-32000]; disk=17974 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=17974) on slave 201306201544-143311683-47608-2686-0 from framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.192700 2766 hierarchical_allocator_process.hpp:367] Removed framework 201306201544-143311683-47608-2686-0000 I0620 15:44:41.192755 2766 hierarchical_allocator_process.hpp:477] Removed slave 201306201544-143311683-47608-2686-0 [ OK ] AllocatorTest/0.WhitelistSlave (71 ms) [----------] 9 tests from AllocatorTest/0 (463 ms total) [----------] 1 test from LoggingTest [ RUN ] LoggingTest.Toggle I0620 15:44:41.193483 2772 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0620 15:44:41.194229 2774 process.cpp:878] Socket closed while receiving I0620 15:44:41.194581 2766 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0620 15:44:41.195245 2774 process.cpp:878] Socket closed while receiving I0620 15:44:41.195839 2767 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0620 15:44:41.196521 2774 process.cpp:878] Socket closed while receiving I0620 15:44:41.196930 2766 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0620 15:44:41.197330 2774 process.cpp:878] Socket closed while receiving I0620 15:44:41.197897 2768 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0620 15:44:41.198497 2774 process.cpp:878] Socket closed while receiving I0620 15:44:41.199059 2771 process.cpp:2942] Handling HTTP event for process 'logging' with path: '/logging/toggle' I0620 15:44:41.199774 2774 process.cpp:878] Socket closed while receiving [ OK ] LoggingTest.Toggle (7 ms) [----------] 1 test from LoggingTest (7 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 (6 ms) [ RUN ] FsTest.MountTableHasOption [ OK ] FsTest.MountTableHasOption (0 ms) [ RUN ] FsTest.FileSystemTableRead [ OK ] FsTest.FileSystemTableRead (6 ms) [----------] 3 tests from FsTest (12 ms total) [----------] Global test environment tear-down [==========] 166 tests from 32 test cases ran. (49951 ms total) [ PASSED ] 165 tests. [ FAILED ] 1 test, listed below: [ FAILED ] FaultToleranceTest.ReconcileIncompleteTasks 1 FAILED TEST make[3]: *** [check-local] 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 I0620 15:44:44.210546 3792 exec.cpp:83] Committing suicide by killing the process group Build step 'Execute shell' marked build as failure
