Reopened https://issues.apache.org/jira/browse/MESOS-534
On Sat, Jul 6, 2013 at 11:51 PM, Apache Jenkins Server < [email protected]> wrote: > See < > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/1337/ > > > > ------------------------------------------ > [...truncated 11997 lines...] > I0707 06:51:07.685837 30033 slave.cpp:485] Slave asked to shut down by > [email protected]:35887 > I0707 06:51:07.686601 30033 slave.cpp:440] Slave terminating > I0707 06:51:07.685858 30038 slave.cpp:485] Slave asked to shut down by > [email protected]:35887 > I0707 06:51:07.687998 30038 slave.cpp:1112] Asked to shut down framework > 201307070651-1015726915-35887-30014-0000 by [email protected]:35887 > I0707 06:51:07.685842 30014 master.cpp:209] Shutting down master > I0707 06:51:07.689121 30014 master.hpp:317] Removing task 0 with resources > cpus=2; mem=512 on slave 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.689676 30014 master.hpp:337] Removing offer > 201307070651-1015726915-35887-30014-3 with resources cpus=1; mem=512; > ports=[31000-32000]; disk=16888 on slave > 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.689146 30034 hierarchical_allocator_process.hpp:411] > Deactivated framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.688539 30038 slave.cpp:1137] Shutting down framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.690368 30014 master.hpp:337] Removing offer > 201307070651-1015726915-35887-30014-2 with resources cpus=4; mem=2048; > ports=[31000-32000]; disk=16888 on slave > 201307070651-1015726915-35887-30014-1 > I0707 06:51:07.698724 30034 hierarchical_allocator_process.hpp:615] > Recovered cpus=2; mem=512 (total allocatable: cpus=2; mem=512; ports=[]; > disk=0) on slave 201307070651-1015726915-35887-30014-0 from framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.716364 30038 slave.cpp:2328] Shutting down executor > 'default' of framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.718097 30034 hierarchical_allocator_process.hpp:615] > Recovered cpus=1; mem=512; ports=[31000-32000]; disk=16888 (total > allocatable: cpus=3; mem=1024; ports=[31000-32000]; disk=16888) on slave > 201307070651-1015726915-35887-30014-0 from framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.718834 30038 slave.cpp:440] Slave terminating > I0707 06:51:07.718845 30033 exec.cpp:323] Executor asked to shutdown > I0707 06:51:07.719619 30034 hierarchical_allocator_process.hpp:615] > Recovered cpus=4; mem=2048; ports=[31000-32000]; disk=16888 (total > allocatable: cpus=4; mem=2048; ports=[31000-32000]; disk=16888) on slave > 201307070651-1015726915-35887-30014-1 from framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.720101 30038 slave.cpp:1112] Asked to shut down framework > 201307070651-1015726915-35887-30014-0000 by @0.0.0.0:0 > I0707 06:51:07.721777 30034 hierarchical_allocator_process.hpp:366] > Removed framework 201307070651-1015726915-35887-30014-0000 > W0707 06:51:07.722342 30038 slave.cpp:1133] Ignoring shutdown framework > 201307070651-1015726915-35887-30014-0000 because it is terminating > I0707 06:51:07.723109 30034 hierarchical_allocator_process.hpp:476] > Removed slave 201307070651-1015726915-35887-30014-1 > [ OK ] AllocatorTest/0.SlaveAdded (321 ms) > [ RUN ] AllocatorTest/0.TaskFinished > I0707 06:51:07.725242 30033 master.cpp:230] Master started on > 67.195.138.60:35887 > I0707 06:51:07.725543 30033 master.cpp:245] Master ID: > 201307070651-1015726915-35887-30014 > W0707 06:51:07.744614 30036 master.cpp:83] No whitelist given. Advertising > offers for all slaves > I0707 06:51:07.744712 30033 master.cpp:583] Elected as master! > I0707 06:51:07.744833 30039 hierarchical_allocator_process.hpp:305] > Initializing hierarchical allocator process with master : > [email protected]:35887 > I0707 06:51:07.761414 30035 slave.cpp:113] Slave started on 98)@ > 67.195.138.60:35887 > I0707 06:51:07.761564 30035 slave.cpp:205] Slave resources: cpus=3; > mem=1024; ports=[31000-32000]; disk=16888 > I0707 06:51:07.761797 30040 sched.cpp:177] New master at > [email protected]:35887 > I0707 06:51:07.762742 30035 slave.cpp:529] New master detected at > [email protected]:35887 > I0707 06:51:07.763226 30035 slave.cpp:544] Postponing registration until > recovery is complete > I0707 06:51:07.764510 30035 slave.cpp:390] Finished recovery > I0707 06:51:07.763234 30034 status_update_manager.cpp:155] New master > detected at [email protected]:35887 > I0707 06:51:07.762823 30033 master.cpp:633] Registering framework > 201307070651-1015726915-35887-30014-0000 at scheduler(89)@ > 67.195.138.60:35887 > I0707 06:51:07.766844 30039 sched.cpp:222] Framework registered with > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.766860 30033 master.cpp:962] Attempting to register slave > on janus.apache.org at slave(98)@67.195.138.60:35887 > I0707 06:51:07.766892 30035 hierarchical_allocator_process.hpp:335] Added > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.768884 30035 hierarchical_allocator_process.hpp:704] No > resources available to allocate! > I0707 06:51:07.769636 30035 hierarchical_allocator_process.hpp:666] > Performed allocation for 0 slaves in 752.146us > I0707 06:51:07.768429 30033 master.cpp:1929] Adding slave > 201307070651-1015726915-35887-30014-0 at janus.apache.org with cpus=3; > mem=1024; ports=[31000-32000]; disk=16888 > I0707 06:51:07.771551 30036 slave.cpp:589] Registered with master > [email protected]:35887; given slave ID > 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.771762 30040 hierarchical_allocator_process.hpp:448] Added > slave 201307070651-1015726915-35887-30014-0 (janus.apache.org) with > cpus=3; mem=1024; ports=[31000-32000]; disk=16888 (and cpus=3; mem=1024; > ports=[31000-32000]; disk=16888 available) > I0707 06:51:07.772464 30040 hierarchical_allocator_process.hpp:726] > Offering cpus=3; mem=1024; ports=[31000-32000]; disk=16888 on slave > 201307070651-1015726915-35887-30014-0 to framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.773036 30040 hierarchical_allocator_process.hpp:686] > Performed allocation for slave 201307070651-1015726915-35887-30014-0 in > 585.744us > I0707 06:51:07.773067 30036 master.hpp:327] Adding offer > 201307070651-1015726915-35887-30014-0 with resources cpus=3; mem=1024; > ports=[31000-32000]; disk=16888 on slave > 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.774147 30036 master.cpp:1310] Sending 1 offers to framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.774915 30036 master.cpp:1543] Processing reply for offer > 201307070651-1015726915-35887-30014-0 on slave > 201307070651-1015726915-35887-30014-0 (janus.apache.org) for framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.775127 30036 master.hpp:305] Adding task 0 with resources > cpus=1; mem=256 on slave 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.775694 30036 master.cpp:1662] Launching task 0 of framework > 201307070651-1015726915-35887-30014-0000 with resources cpus=1; mem=256 on > slave 201307070651-1015726915-35887-30014-0 (janus.apache.org) > I0707 06:51:07.776422 30038 slave.cpp:739] Got assigned task 0 for > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.776423 30036 master.hpp:305] Adding task 1 with resources > cpus=1; mem=256 on slave 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.778136 30036 master.cpp:1662] Launching task 1 of framework > 201307070651-1015726915-35887-30014-0000 with resources cpus=1; mem=256 on > slave 201307070651-1015726915-35887-30014-0 (janus.apache.org) > I0707 06:51:07.777469 30038 slave.cpp:837] Launching task 0 for framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.778962 30036 master.hpp:337] Removing offer > 201307070651-1015726915-35887-30014-0 with resources cpus=3; mem=1024; > ports=[31000-32000]; disk=16888 on slave > 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.779028 30033 hierarchical_allocator_process.hpp:525] > Framework 201307070651-1015726915-35887-30014-0000 left cpus=1; mem=512; > ports=[31000-32000]; disk=16888 unused on slave > 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.781632 30033 hierarchical_allocator_process.hpp:568] > Framework 201307070651-1015726915-35887-30014-0000 filtered slave > 201307070651-1015726915-35887-30014-0 for 5secs > I0707 06:51:07.781339 30038 paths.hpp:303] Created executor directory > '/tmp/AllocatorTest_0_TaskFinished_dWbFWh/slaves/201307070651-1015726915-35887-30014-0/frameworks/201307070651-1015726915-35887-30014-0000/executors/default/runs/71dd6264-4bea-48d6-94a5-1155b2651edd' > I0707 06:51:07.782861 30038 slave.cpp:948] Queuing task '0' for executor > default of framework '201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.783784 30038 slave.cpp:739] Got assigned task 1 for > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.782984 30040 exec.cpp:170] Executor started at: > executor(36)@67.195.138.60:35887 with pid 30014 > I0707 06:51:07.784452 30038 slave.cpp:511] Successfully attached file > '/tmp/AllocatorTest_0_TaskFinished_dWbFWh/slaves/201307070651-1015726915-35887-30014-0/frameworks/201307070651-1015726915-35887-30014-0000/executors/default/runs/71dd6264-4bea-48d6-94a5-1155b2651edd' > I0707 06:51:07.786669 30038 slave.cpp:837] Launching task 1 for framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.787101 30038 slave.cpp:948] Queuing task '1' for executor > default of framework '201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.788264 30038 slave.cpp:1395] Got registration for executor > 'default' of framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.788728 30038 slave.cpp:1510] Flushing queued task 1 for > executor 'default' of framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.788764 30034 exec.cpp:194] Executor registered on slave > 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.789580 30038 slave.cpp:1510] Flushing queued task 0 for > executor 'default' of framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.790329 30034 exec.cpp:258] Executor asked to run task '1' > I0707 06:51:07.791841 30034 exec.cpp:258] Executor asked to run task '0' > I0707 06:51:07.793550 30034 exec.cpp:404] Executor sending status update > TASK_RUNNING (UUID: 966992f8-78be-42c5-9468-bf5209bf17ec) for task 1 of > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.793624 30033 slave.cpp:1692] Handling status update > TASK_RUNNING (UUID: 966992f8-78be-42c5-9468-bf5209bf17ec) for task 1 of > framework 201307070651-1015726915-35887-30014-0000 from executor(36)@ > 67.195.138.60:35887 > I0707 06:51:07.794884 30033 status_update_manager.cpp:290] Received status > update TASK_RUNNING (UUID: 966992f8-78be-42c5-9468-bf5209bf17ec) for task 1 > of framework 201307070651-1015726915-35887-30014-0000 with checkpoint=false > I0707 06:51:07.795510 30033 status_update_manager.cpp:450] Creating > StatusUpdate stream for task 1 of framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.794347 30034 exec.cpp:404] Executor sending status update > TASK_FINISHED (UUID: 270911ad-ead0-461f-9a52-ecc745a6a2a4) for task 1 of > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.796890 30033 status_update_manager.cpp:336] Forwarding > status update TASK_RUNNING (UUID: 966992f8-78be-42c5-9468-bf5209bf17ec) for > task 1 of framework 201307070651-1015726915-35887-30014-0000 to > [email protected]:35887 > I0707 06:51:07.797621 30036 slave.cpp:1692] Handling status update > TASK_FINISHED (UUID: 270911ad-ead0-461f-9a52-ecc745a6a2a4) for task 1 of > framework 201307070651-1015726915-35887-30014-0000 from executor(36)@ > 67.195.138.60:35887 > I0707 06:51:07.797649 30039 hierarchical_allocator_process.hpp:796] > Filtered cpus=1; mem=512; ports=[31000-32000]; disk=16888 on slave > 201307070651-1015726915-35887-30014-0 for framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.798368 30033 master.cpp:1093] Status update from slave(98)@ > 67.195.138.60:35887: task 1 of framework > 201307070651-1015726915-35887-30014-0000 is now in state TASK_RUNNING > I0707 06:51:07.798427 30034 exec.cpp:404] Executor sending status update > TASK_RUNNING (UUID: 93b8393d-4de6-42fe-bced-26104ead8b49) for task 0 of > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.799994 30036 slave.cpp:1803] Status update manager > successfully handled status update TASK_RUNNING (UUID: > 966992f8-78be-42c5-9468-bf5209bf17ec) for task 1 of framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.799995 30037 status_update_manager.cpp:290] Received status > update TASK_FINISHED (UUID: 270911ad-ead0-461f-9a52-ecc745a6a2a4) for task > 1 of framework 201307070651-1015726915-35887-30014-0000 with > checkpoint=false > I0707 06:51:07.800673 30039 hierarchical_allocator_process.hpp:666] > Performed allocation for 1 slaves in 3.115023ms > I0707 06:51:07.802330 30036 slave.cpp:1809] Sending acknowledgement for > status update TASK_RUNNING (UUID: 966992f8-78be-42c5-9468-bf5209bf17ec) for > task 1 of framework 201307070651-1015726915-35887-30014-0000 to > executor(36)@67.195.138.60:35887 > I0707 06:51:07.804137 30040 exec.cpp:290] Executor received status update > acknowledgement 966992f8-78be-42c5-9468-bf5209bf17ec for task 1 of > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.804162 30035 status_update_manager.cpp:360] Received status > update acknowledgement 966992f8-78be-42c5-9468-bf5209bf17ec for task 1 of > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.804160 30036 slave.cpp:1692] Handling status update > TASK_RUNNING (UUID: 93b8393d-4de6-42fe-bced-26104ead8b49) for task 0 of > framework 201307070651-1015726915-35887-30014-0000 from executor(36)@ > 67.195.138.60:35887 > I0707 06:51:07.806267 30035 status_update_manager.cpp:336] Forwarding > status update TASK_FINISHED (UUID: 270911ad-ead0-461f-9a52-ecc745a6a2a4) > for task 1 of framework 201307070651-1015726915-35887-30014-0000 to > [email protected]:35887 > I0707 06:51:07.807411 30035 status_update_manager.cpp:290] Received status > update TASK_RUNNING (UUID: 93b8393d-4de6-42fe-bced-26104ead8b49) for task 0 > of framework 201307070651-1015726915-35887-30014-0000 with checkpoint=false > I0707 06:51:07.807842 30035 status_update_manager.cpp:450] Creating > StatusUpdate stream for task 0 of framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.806926 30036 slave.cpp:1803] Status update manager > successfully handled status update TASK_FINISHED (UUID: > 270911ad-ead0-461f-9a52-ecc745a6a2a4) for task 1 of framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.808794 30036 slave.cpp:1809] Sending acknowledgement for > status update TASK_FINISHED (UUID: 270911ad-ead0-461f-9a52-ecc745a6a2a4) > for task 1 of framework 201307070651-1015726915-35887-30014-0000 to > executor(36)@67.195.138.60:35887 > I0707 06:51:07.808342 30035 status_update_manager.cpp:336] Forwarding > status update TASK_RUNNING (UUID: 93b8393d-4de6-42fe-bced-26104ead8b49) for > task 0 of framework 201307070651-1015726915-35887-30014-0000 to > [email protected]:35887 > I0707 06:51:07.807415 30037 master.cpp:1093] Status update from slave(98)@ > 67.195.138.60:35887: task 1 of framework > 201307070651-1015726915-35887-30014-0000 is now in state TASK_FINISHED > I0707 06:51:07.811257 30037 master.hpp:317] Removing task 1 with resources > cpus=1; mem=256 on slave 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.809680 30038 exec.cpp:290] Executor received status update > acknowledgement 270911ad-ead0-461f-9a52-ecc745a6a2a4 for task 1 of > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.809646 30036 slave.cpp:1343] Status update manager > successfully handled status update acknowledgement > 966992f8-78be-42c5-9468-bf5209bf17ec for task 1 of framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.833434 30037 master.cpp:1093] Status update from slave(98)@ > 67.195.138.60:35887: task 0 of framework > 201307070651-1015726915-35887-30014-0000 is now in state TASK_RUNNING > I0707 06:51:07.833484 30034 hierarchical_allocator_process.hpp:615] > Recovered cpus=1; mem=256 (total allocatable: cpus=2; mem=768; > ports=[31000-32000]; disk=16888) on slave > 201307070651-1015726915-35887-30014-0 from framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.864527 30036 slave.cpp:1803] Status update manager > successfully handled status update TASK_RUNNING (UUID: > 93b8393d-4de6-42fe-bced-26104ead8b49) for task 0 of framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.870102 30034 hierarchical_allocator_process.hpp:726] > Offering cpus=2; mem=768; ports=[31000-32000]; disk=16888 on slave > 201307070651-1015726915-35887-30014-0 to framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.874953 30036 slave.cpp:1809] Sending acknowledgement for > status update TASK_RUNNING (UUID: 93b8393d-4de6-42fe-bced-26104ead8b49) for > task 0 of framework 201307070651-1015726915-35887-30014-0000 to > executor(36)@67.195.138.60:35887 > I0707 06:51:07.876255 30036 exec.cpp:290] Executor received status update > acknowledgement 93b8393d-4de6-42fe-bced-26104ead8b49 for task 0 of > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.875794 30037 master.hpp:327] Adding offer > 201307070651-1015726915-35887-30014-1 with resources cpus=2; mem=768; > ports=[31000-32000]; disk=16888 on slave > 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.876281 30040 status_update_manager.cpp:360] Received status > update acknowledgement 270911ad-ead0-461f-9a52-ecc745a6a2a4 for task 1 of > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.875763 30034 hierarchical_allocator_process.hpp:666] > Performed allocation for 1 slaves in 5.681675ms > I0707 06:51:07.878978 30037 master.cpp:1310] Sending 1 offers to framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.905601 30040 status_update_manager.cpp:481] Cleaning up > status update stream for task 1 of framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.906873 30033 sched.cpp:427] Stopping framework > '201307070651-1015726915-35887-30014-0000' > I0707 06:51:07.906893 30014 master.cpp:436] Master terminating > I0707 06:51:07.908612 30014 master.cpp:209] Shutting down master > I0707 06:51:07.909214 30037 hierarchical_allocator_process.hpp:411] > Deactivated framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.907565 30040 status_update_manager.cpp:360] Received status > update acknowledgement 93b8393d-4de6-42fe-bced-26104ead8b49 for task 0 of > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.909214 30014 master.hpp:317] Removing task 0 with resources > cpus=1; mem=256 on slave 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.911048 30014 master.hpp:337] Removing offer > 201307070651-1015726915-35887-30014-1 with resources cpus=2; mem=768; > ports=[31000-32000]; disk=16888 on slave > 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.907580 30038 slave.cpp:1343] Status update manager > successfully handled status update acknowledgement > 270911ad-ead0-461f-9a52-ecc745a6a2a4 for task 1 of framework > 201307070651-1015726915-35887-30014-0000 > E0707 06:51:07.913089 30038 slave.cpp:1367] Status update acknowledgement > 270911ad-ead0-461f-9a52-ecc745a6a2a4 for task 1 of unknown executor > I0707 06:51:07.914502 30038 slave.cpp:440] Slave terminating > I0707 06:51:07.915411 30038 slave.cpp:1112] Asked to shut down framework > 201307070651-1015726915-35887-30014-0000 by @0.0.0.0:0 > I0707 06:51:07.916280 30038 slave.cpp:1137] Shutting down framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.916774 30038 slave.cpp:2328] Shutting down executor > 'default' of framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.917512 30034 exec.cpp:323] Executor asked to shutdown > I0707 06:51:07.911097 30040 hierarchical_allocator_process.hpp:615] > Recovered cpus=1; mem=256 (total allocatable: cpus=1; mem=256; ports=[]; > disk=0) on slave 201307070651-1015726915-35887-30014-0 from framework > 201307070651-1015726915-35887-30014-0000 > [ OK ] AllocatorTest/0.TaskFinished (194 ms) > [ RUN ] AllocatorTest/0.WhitelistSlave > I0707 06:51:07.919567 30035 master.cpp:230] Master started on > 67.195.138.60:35887 > I0707 06:51:07.919648 30035 master.cpp:245] Master ID: > 201307070651-1015726915-35887-30014 > I0707 06:51:07.925211 30033 slave.cpp:113] Slave started on 99)@ > 67.195.138.60:35887 > I0707 06:51:07.925884 30033 slave.cpp:205] Slave resources: cpus=2; > mem=1024; ports=[31000-32000]; disk=16888 > I0707 06:51:07.925556 30037 hierarchical_allocator_process.hpp:305] > Initializing hierarchical allocator process with master : > [email protected]:35887 > I0707 06:51:07.926941 30037 hierarchical_allocator_process.hpp:490] > Updated slave white list: { dummy-slave } > I0707 06:51:07.927958 30037 hierarchical_allocator_process.hpp:704] No > resources available to allocate! > I0707 06:51:07.928452 30037 hierarchical_allocator_process.hpp:666] > Performed allocation for 0 slaves in 494.488us > I0707 06:51:07.925731 30034 sched.cpp:177] New master at > [email protected]:35887 > I0707 06:51:07.925516 30035 master.cpp:583] Elected as master! > I0707 06:51:07.926815 30033 slave.cpp:529] New master detected at > [email protected]:35887 > I0707 06:51:07.931042 30033 slave.cpp:544] Postponing registration until > recovery is complete > I0707 06:51:07.931586 30033 slave.cpp:390] Finished recovery > I0707 06:51:07.931066 30038 status_update_manager.cpp:155] New master > detected at [email protected]:35887 > I0707 06:51:07.930590 30035 master.cpp:633] Registering framework > 201307070651-1015726915-35887-30014-0000 at scheduler(90)@ > 67.195.138.60:35887 > I0707 06:51:07.934594 30034 sched.cpp:222] Framework registered with > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.934597 30035 master.cpp:620] Framework > 201307070651-1015726915-35887-30014-0000 (scheduler(90)@ > 67.195.138.60:35887) already registered, resending acknowledgement > I0707 06:51:07.934703 30036 hierarchical_allocator_process.hpp:335] Added > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:07.936241 30036 hierarchical_allocator_process.hpp:704] No > resources available to allocate! > I0707 06:51:07.936727 30036 hierarchical_allocator_process.hpp:666] > Performed allocation for 0 slaves in 487.124us > I0707 06:51:07.935787 30040 sched.cpp:217] Ignoring framework registered > message because the driver is already connected! > I0707 06:51:07.935793 30035 master.cpp:962] Attempting to register slave > on janus.apache.org at slave(99)@67.195.138.60:35887 > I0707 06:51:07.938210 30035 master.cpp:1929] Adding slave > 201307070651-1015726915-35887-30014-0 at janus.apache.org with cpus=2; > mem=1024; ports=[31000-32000]; disk=16888 > I0707 06:51:07.938719 30037 slave.cpp:589] Registered with master > [email protected]:35887; given slave ID > 201307070651-1015726915-35887-30014-0 > I0707 06:51:07.938760 30035 master.cpp:951] Slave > 201307070651-1015726915-35887-30014-0 (janus.apache.org) already > registered, resending acknowledgement > I0707 06:51:07.938864 30038 hierarchical_allocator_process.hpp:448] Added > slave 201307070651-1015726915-35887-30014-0 (janus.apache.org) with > cpus=2; mem=1024; ports=[31000-32000]; disk=16888 (and cpus=2; mem=1024; > ports=[31000-32000]; disk=16888 available) > W0707 06:51:07.939749 30037 slave.cpp:613] Already registered with master > [email protected]:35887 > I0707 06:51:07.945891 30035 hierarchical_allocator_process.hpp:666] > Performed allocation for 1 slaves in 13.76us > I0707 06:51:07.955926 30034 hierarchical_allocator_process.hpp:666] > Performed allocation for 1 slaves in 11.507us > I0707 06:51:07.966033 30039 hierarchical_allocator_process.hpp:666] > Performed allocation for 1 slaves in 18.026us > I0707 06:51:07.976143 30040 hierarchical_allocator_process.hpp:666] > Performed allocation for 1 slaves in 20.149us > I0707 06:51:07.982357 30040 hierarchical_allocator_process.hpp:490] > Updated slave white list: { dummy-slave, janus.apache.org } > I0707 06:51:08.006227 30035 hierarchical_allocator_process.hpp:726] > Offering cpus=2; mem=1024; ports=[31000-32000]; disk=16888 on slave > 201307070651-1015726915-35887-30014-0 to framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:08.006355 30035 hierarchical_allocator_process.hpp:666] > Performed allocation for 1 slaves in 154.945us > I0707 06:51:08.006469 30038 master.hpp:327] Adding offer > 201307070651-1015726915-35887-30014-0 with resources cpus=2; mem=1024; > ports=[31000-32000]; disk=16888 on slave > 201307070651-1015726915-35887-30014-0 > I0707 06:51:08.007262 30038 master.cpp:1310] Sending 1 offers to framework > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:08.016275 30040 sched.cpp:427] Stopping framework > '201307070651-1015726915-35887-30014-0000' > I0707 06:51:08.016286 30014 master.cpp:436] Master terminating > I0707 06:51:08.019763 30014 master.cpp:209] Shutting down master > I0707 06:51:08.019781 30038 slave.cpp:485] Slave asked to shut down by > [email protected]:35887 > I0707 06:51:08.049232 30014 master.hpp:337] Removing offer > 201307070651-1015726915-35887-30014-0 with resources cpus=2; mem=1024; > ports=[31000-32000]; disk=16888 on slave > 201307070651-1015726915-35887-30014-0 > I0707 06:51:08.049252 30034 hierarchical_allocator_process.hpp:411] > Deactivated framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:08.051259 30038 slave.cpp:440] Slave terminating > I0707 06:51:08.052734 30034 hierarchical_allocator_process.hpp:615] > Recovered cpus=2; mem=1024; ports=[31000-32000]; disk=16888 (total > allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=16888) on slave > 201307070651-1015726915-35887-30014-0 from framework > 201307070651-1015726915-35887-30014-0000 > [ OK ] AllocatorTest/0.WhitelistSlave (160 ms) > [ RUN ] AllocatorTest/0.RoleTest > I0707 06:51:08.079869 30033 master.cpp:230] Master started on > 67.195.138.60:35887 > I0707 06:51:08.080211 30040 sched.cpp:177] New master at > [email protected]:35887 > I0707 06:51:08.098877 30033 master.cpp:245] Master ID: > 201307070651-1015726915-35887-30014 > W0707 06:51:08.100039 30038 master.cpp:83] No whitelist given. Advertising > offers for all slaves > I0707 06:51:08.100186 30033 master.cpp:583] Elected as master! > I0707 06:51:08.100190 30036 hierarchical_allocator_process.hpp:305] > Initializing hierarchical allocator process with master : > [email protected]:35887 > I0707 06:51:08.101989 30033 sched.cpp:418] Got error 'Role 'role1' is not > valid.' > I0707 06:51:08.102936 30033 sched.cpp:451] Aborting framework '' > I0707 06:51:08.103440 30033 sched.cpp:456] Not sending a deactivate > message as master is disconnected > I0707 06:51:08.102349 30034 sched.cpp:177] New master at > [email protected]:35887 > I0707 06:51:08.104624 30034 master.cpp:633] Registering framework > 201307070651-1015726915-35887-30014-0000 at scheduler(92)@ > 67.195.138.60:35887 > I0707 06:51:08.105126 30040 sched.cpp:222] Framework registered with > 201307070651-1015726915-35887-30014-0000 > I0707 06:51:08.105170 30034 hierarchical_allocator_process.hpp:335] Added > framework 201307070651-1015726915-35887-30014-0000 > I0707 06:51:08.106185 30034 hierarchical_allocator_process.hpp:704] No > resources available to allocate! > I0707 06:51:08.106757 30034 hierarchical_allocator_process.hpp:666] > Performed allocation for 0 slaves in 573.226us > I0707 06:51:08.105834 30039 sched.cpp:427] Stopping framework '' > I0707 06:51:08.105794 30035 sched.cpp:427] Stopping framework > '201307070651-1015726915-35887-30014-0000' > I0707 06:51:08.105794 30014 master.cpp:436] Master terminating > I0707 06:51:08.109591 30014 master.cpp:209] Shutting down master > I0707 06:51:08.116914 30038 hierarchical_allocator_process.hpp:411] > Deactivated framework 201307070651-1015726915-35887-30014-0000 > [ OK ] AllocatorTest/0.RoleTest (59 ms) > [----------] 10 tests from AllocatorTest/0 (1318 ms total) > > [----------] 1 test from LoggingTest > [ RUN ] LoggingTest.Toggle > I0707 06:51:08.138667 30038 process.cpp:2999] Handling HTTP event for > process 'logging' with path: '/logging/toggle' > I0707 06:51:08.139370 30041 process.cpp:932] Socket closed while receiving > I0707 06:51:08.140215 30034 process.cpp:2999] Handling HTTP event for > process 'logging' with path: '/logging/toggle' > I0707 06:51:08.146764 30041 process.cpp:932] Socket closed while receiving > I0707 06:51:08.147306 30035 process.cpp:2999] Handling HTTP event for > process 'logging' with path: '/logging/toggle' > I0707 06:51:08.148640 30041 process.cpp:932] Socket closed while receiving > I0707 06:51:08.163501 30039 process.cpp:2999] Handling HTTP event for > process 'logging' with path: '/logging/toggle' > I0707 06:51:08.164021 30041 process.cpp:932] Socket closed while receiving > I0707 06:51:08.164485 30036 process.cpp:2999] Handling HTTP event for > process 'logging' with path: '/logging/toggle' > I0707 06:51:08.165194 30041 process.cpp:932] Socket closed while receiving > I0707 06:51:08.165694 30040 process.cpp:2999] Handling HTTP event for > process 'logging' with path: '/logging/toggle' > I0707 06:51:08.166337 30041 process.cpp:932] Socket closed while receiving > [ OK ] LoggingTest.Toggle (28 ms) > [----------] 1 test from LoggingTest (28 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 (1 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 (28 ms) > [----------] 3 tests from FsTest (29 ms total) > > [----------] Global test environment tear-down > [==========] 170 tests from 32 test cases ran. (66055 ms total) > [ PASSED ] 169 tests. > [ FAILED ] 1 test, listed below: > [ FAILED ] ReaperTest.TerminatedChildProcess > > 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 > I0707 06:51:08.254767 30800 exec.cpp:83] Committing suicide by killing the > process group > Build step 'Execute shell' marked build as failure >
