Apparently 2 -> 5 seconds was not enough ... I'll be increasing this to 10 seconds.
On Wed, Apr 24, 2013 at 10:43 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/315/changes > > > > Changes: > > [benh] Fixed bug creating SVN tag in release.sh. > > Review: https://reviews.apache.org/r/10767 > > [benh] Removed use of AWAIT_*_FOR since defaults have been increased. > > Review: https://reviews.apache.org/r/10765 > > [benh] Increased default duration to await on futures when testing. > > Review: https://reviews.apache.org/r/10764 > > [benh] Missed refactors for new testing abstractions after rebase. > > [benh] Fixed a comment. > > Review: https://reviews.apache.org/r/10761 > > [benh] Updated output of libprocess gtest abstractions. > > Review: https://reviews.apache.org/r/10760 > > [benh] Updated some tests to use new testing abstractions. > > Review: https://reviews.apache.org/r/10759 > > [benh] Added a Socket reference to Encoder. > > Review: https://reviews.apache.org/r/10742 > > [benh] Increased timeouts used in log tests to avoid test failures due to > slow hardware or resource contention from other processes. > > Review: https://reviews.apache.org/r/10464 > > [benh] Used libprocess testing abstractions in log tests. > > Review: https://reviews.apache.org/r/10463 > > [benh] Fixed bug in test where Scheduler::error might not have been invoked > before we attempted to stop the scheduler driver. > > Review: https://reviews.apache.org/r/10462 > > [benh] Replaced libprocess specific testing abstractions. > > Review: https://reviews.apache.org/r/10461 > > [benh] Renamed and improved testing abstractions for awaiting on futures. > > Review: https://reviews.apache.org/r/10460 > > [benh] Updated some variable naming to be consistent. > > Review: https://reviews.apache.org/r/10459 > > [benh] Removed or replaced use of ProcessIsolator with TestingIsolator. > > Review: https://reviews.apache.org/r/10458 > > [benh] Removed unused testing utilities. > > Review: https://reviews.apache.org/r/10457 > > [benh] Cleaned up fault tolerant tests and fixed a disabled test. > > Review: https://reviews.apache.org/r/10456 > > ------------------------------------------ > [...truncated 14061 lines...] > I0425 05:43:22.705091 16663 hierarchical_allocator_process.hpp:599] > Performed allocation for 0 slaves in 468.636000000000024us > I0425 05:43:22.704150 16658 master.cpp:1224] Master now considering a > slave at janus.apache.org:43815 as active > I0425 05:43:22.706063 16658 master.cpp:1885] Adding slave > 201304250543-1015726915-43815-16581-0 at janus.apache.org with cpus=3; > mem=1024; ports=[31000-32000]; disk=13799 > I0425 05:43:22.706575 16662 slave.cpp:590] Registered with master > [email protected]:43815; given slave ID > 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.706732 16658 hierarchical_allocator_process.hpp:395] Added > slave 201304250543-1015726915-43815-16581-0 (janus.apache.org) with > cpus=3; mem=1024; ports=[31000-32000]; disk=13799 (and cpus=3; mem=1024; > ports=[31000-32000]; disk=13799 available) > I0425 05:43:22.708606 16658 hierarchical_allocator_process.hpp:660] Found > available resources: cpus=3; mem=1024; ports=[31000-32000]; disk=13799 on > slave 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.709053 16658 hierarchical_allocator_process.hpp:686] > Offering cpus=3; mem=1024; ports=[31000-32000]; disk=13799 on slave > 201304250543-1015726915-43815-16581-0 to framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.709674 16658 hierarchical_allocator_process.hpp:619] > Performed allocation for slave 201304250543-1015726915-43815-16581-0 in > 1.074961000000000ms > I0425 05:43:22.709727 16662 master.hpp:309] Adding offer with resources > cpus=3; mem=1024; ports=[31000-32000]; disk=13799 on slave > 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.710639 16662 master.cpp:1327] Sending 1 offers to framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.711164 16657 sched.cpp:282] Received 1 offers > I0425 05:43:22.711884 16661 master.cpp:1556] Processing reply for offer > 201304250543-1015726915-43815-16581-0 on slave > 201304250543-1015726915-43815-16581-0 (janus.apache.org) for framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.712255 16661 master.hpp:289] Adding task with resources > cpus=1; mem=256 on slave 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.712704 16661 master.cpp:1674] Launching task 0 of framework > 201304250543-1015726915-43815-16581-0000 with resources cpus=1; mem=256 on > slave 201304250543-1015726915-43815-16581-0 (janus.apache.org) > I0425 05:43:22.713314 16661 master.hpp:289] Adding task with resources > cpus=1; mem=256 on slave 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.713327 16662 slave.cpp:719] Got assigned task 0 for > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.713778 16661 master.cpp:1674] Launching task 1 of framework > 201304250543-1015726915-43815-16581-0000 with resources cpus=1; mem=256 on > slave 201304250543-1015726915-43815-16581-0 (janus.apache.org) > I0425 05:43:22.714896 16661 master.hpp:318] Removing offer with resources > cpus=3; mem=1024; ports=[31000-32000]; disk=13799 on slave > 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.714485 16662 slave.cpp:817] Launching task 0 for framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.714939 16663 hierarchical_allocator_process.hpp:471] > Framework 201304250543-1015726915-43815-16581-0000 left cpus=1; mem=512; > ports=[31000-32000]; disk=13799 unused on slave > 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.716990 16662 paths.hpp:302] Created executor directory > '/tmp/AllocatorTest_0_TaskFinished_2Ras4U/slaves/201304250543-1015726915-43815-16581-0/frameworks/201304250543-1015726915-43815-16581-0000/executors/default/runs/d78a9200-df2e-45d9-ac21-9b2656e7b4b6' > I0425 05:43:22.717155 16662 slave.cpp:928] Queuing task '0' for executor > default of framework '201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.717473 16662 slave.cpp:719] Got assigned task 1 for > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.717322 16663 exec.cpp:170] Executor started at: > executor(30)@67.195.138.60:43815 with pid 16581 > I0425 05:43:22.718040 16662 slave.cpp:512] Successfully attached file > '/tmp/AllocatorTest_0_TaskFinished_2Ras4U/slaves/201304250543-1015726915-43815-16581-0/frameworks/201304250543-1015726915-43815-16581-0000/executors/default/runs/d78a9200-df2e-45d9-ac21-9b2656e7b4b6' > I0425 05:43:22.718992 16662 slave.cpp:817] Launching task 1 for framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.719498 16662 slave.cpp:928] Queuing task '1' for executor > default of framework '201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.719998 16662 slave.cpp:1385] Got registration for executor > 'default' of framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.720617 16662 slave.cpp:1500] Flushing queued task 1 for > executor 'default' of framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.721048 16662 slave.cpp:1500] Flushing queued task 0 for > executor 'default' of framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.720635 16658 exec.cpp:194] Executor registered on slave > 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.722061 16658 exec.cpp:258] Executor asked to run task '1' > I0425 05:43:22.722566 16658 exec.cpp:258] Executor asked to run task '0' > I0425 05:43:22.723002 16658 exec.cpp:382] Executor sending status update > for task 1 in state TASK_RUNNING > I0425 05:43:22.724639 16658 exec.cpp:382] Executor sending status update > for task 0 in state TASK_RUNNING > I0425 05:43:22.724663 16656 slave.cpp:1729] Handling status update > TASK_RUNNING (UUID: 7eb0d859-44ff-4ceb-8ebf-30ada707ea1b) for task 1 of > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.725111 16659 status_update_manager.cpp:289] Received status > update TASK_RUNNING (UUID: 7eb0d859-44ff-4ceb-8ebf-30ada707ea1b) for task 1 > of framework 201304250543-1015726915-43815-16581-0000 with checkpoint=false > I0425 05:43:22.725500 16659 status_update_manager.cpp:450] Creating > StatusUpdate stream for task 1 of framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.726035 16659 status_update_manager.cpp:335] Forwarding > status update TASK_RUNNING (UUID: 7eb0d859-44ff-4ceb-8ebf-30ada707ea1b) for > task 1 of framework 201304250543-1015726915-43815-16581-0000 to the master > at [email protected]:43815 > I0425 05:43:22.725654 16658 slave.cpp:1729] Handling status update > TASK_RUNNING (UUID: 15e2a8d7-5bf2-4946-b47b-8aeffc87ff4a) for task 0 of > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.726584 16663 master.cpp:1086] Status update from (761)@ > 67.195.138.60:43815: task 1 of framework > 201304250543-1015726915-43815-16581-0000 is now in state TASK_RUNNING > I0425 05:43:22.727107 16658 slave.cpp:1786] Status update manager > successfully handled status update TASK_RUNNING (UUID: > 7eb0d859-44ff-4ceb-8ebf-30ada707ea1b) for task 1 of framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.727126 16657 status_update_manager.cpp:289] Received status > update TASK_RUNNING (UUID: 15e2a8d7-5bf2-4946-b47b-8aeffc87ff4a) for task 0 > of framework 201304250543-1015726915-43815-16581-0000 with checkpoint=false > I0425 05:43:22.728318 16663 sched.cpp:327] Received status update > TASK_RUNNING (UUID: 7eb0d859-44ff-4ceb-8ebf-30ada707ea1b) for task 1 of > framework 201304250543-1015726915-43815-16581-0000 from slave(89)@ > 67.195.138.60:43815 > I0425 05:43:22.729202 16658 slave.cpp:1792] Sending acknowledgement for > status update TASK_RUNNING (UUID: 7eb0d859-44ff-4ceb-8ebf-30ada707ea1b) for > task 1 of framework 201304250543-1015726915-43815-16581-0000 to executor > executor(30)@67.195.138.60:43815 > I0425 05:43:22.729651 16657 status_update_manager.cpp:450] Creating > StatusUpdate stream for task 0 of framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.730182 16663 sched.cpp:360] Sending ACK for status update > TASK_RUNNING (UUID: 7eb0d859-44ff-4ceb-8ebf-30ada707ea1b) for task 1 of > framework 201304250543-1015726915-43815-16581-0000 to slave(89)@ > 67.195.138.60:43815 > I0425 05:43:22.730710 16661 exec.cpp:289] Executor received ACK for status > update of task 1 of framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.731173 16657 status_update_manager.cpp:335] Forwarding > status update TASK_RUNNING (UUID: 15e2a8d7-5bf2-4946-b47b-8aeffc87ff4a) for > task 0 of framework 201304250543-1015726915-43815-16581-0000 to the master > at [email protected]:43815 > I0425 05:43:22.731642 16663 slave.cpp:1292] Got status update > acknowledgement 7eb0d859-44ff-4ceb-8ebf-30ada707ea1b for task 1 of > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.750844 16658 hierarchical_allocator_process.hpp:660] Found > available resources: cpus=1; mem=512; ports=[31000-32000]; disk=13799 on > slave 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.813057 16656 master.cpp:1086] Status update from (761)@ > 67.195.138.60:43815: task 0 of framework > 201304250543-1015726915-43815-16581-0000 is now in state TASK_RUNNING > I0425 05:43:22.814440 16656 sched.cpp:327] Received status update > TASK_RUNNING (UUID: 15e2a8d7-5bf2-4946-b47b-8aeffc87ff4a) for task 0 of > framework 201304250543-1015726915-43815-16581-0000 from slave(89)@ > 67.195.138.60:43815 > I0425 05:43:22.813489 16660 status_update_manager.cpp:360] Received status > update acknowledgement 7eb0d859-44ff-4ceb-8ebf-30ada707ea1b for task 1 of > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.813973 16658 hierarchical_allocator_process.hpp:686] > Offering cpus=1; mem=512; ports=[31000-32000]; disk=13799 on slave > 201304250543-1015726915-43815-16581-0 to framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.813467 16663 slave.cpp:1786] Status update manager > successfully handled status update TASK_RUNNING (UUID: > 15e2a8d7-5bf2-4946-b47b-8aeffc87ff4a) for task 0 of framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.816324 16663 slave.cpp:1792] Sending acknowledgement for > status update TASK_RUNNING (UUID: 15e2a8d7-5bf2-4946-b47b-8aeffc87ff4a) for > task 0 of framework 201304250543-1015726915-43815-16581-0000 to executor > executor(30)@67.195.138.60:43815 > I0425 05:43:22.815968 16658 hierarchical_allocator_process.hpp:599] > Performed allocation for 1 slaves in 65.145745000000005ms > I0425 05:43:22.816025 16660 master.hpp:309] Adding offer with resources > cpus=1; mem=512; ports=[31000-32000]; disk=13799 on slave > 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.817790 16660 master.cpp:1327] Sending 1 offers to framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.816808 16663 slave.cpp:1335] Status update manager > successfully handled status update acknowledgement > 7eb0d859-44ff-4ceb-8ebf-30ada707ea1b for task 1 of framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.816829 16657 exec.cpp:289] Executor received ACK for status > update of task 0 of framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.814898 16656 sched.cpp:360] Sending ACK for status update > TASK_RUNNING (UUID: 15e2a8d7-5bf2-4946-b47b-8aeffc87ff4a) for task 0 of > framework 201304250543-1015726915-43815-16581-0000 to slave(89)@ > 67.195.138.60:43815 > I0425 05:43:22.820251 16656 sched.cpp:282] Received 1 offers > I0425 05:43:22.820268 16662 slave.cpp:1292] Got status update > acknowledgement 15e2a8d7-5bf2-4946-b47b-8aeffc87ff4a for task 0 of > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.820734 16659 master.cpp:1556] Processing reply for offer > 201304250543-1015726915-43815-16581-1 on slave > 201304250543-1015726915-43815-16581-0 (janus.apache.org) for framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.820842 16656 exec.cpp:382] Executor sending status update > for task 1 in state TASK_FINISHED > I0425 05:43:22.821156 16662 status_update_manager.cpp:360] Received status > update acknowledgement 15e2a8d7-5bf2-4946-b47b-8aeffc87ff4a for task 0 of > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.823716 16662 slave.cpp:1335] Status update manager > successfully handled status update acknowledgement > 15e2a8d7-5bf2-4946-b47b-8aeffc87ff4a for task 0 of framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.821707 16657 hierarchical_allocator_process.hpp:471] > Framework 201304250543-1015726915-43815-16581-0000 left cpus=1; mem=512; > ports=[31000-32000]; disk=13799 unused on slave > 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.821682 16659 master.hpp:318] Removing offer with resources > cpus=1; mem=512; ports=[31000-32000]; disk=13799 on slave > 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.824199 16662 slave.cpp:1729] Handling status update > TASK_FINISHED (UUID: 0e32a68d-b587-4afc-a89c-f2ef528da75d) for task 1 of > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.825911 16663 status_update_manager.cpp:289] Received status > update TASK_FINISHED (UUID: 0e32a68d-b587-4afc-a89c-f2ef528da75d) for task > 1 of framework 201304250543-1015726915-43815-16581-0000 with > checkpoint=false > I0425 05:43:22.826282 16663 status_update_manager.cpp:335] Forwarding > status update TASK_FINISHED (UUID: 0e32a68d-b587-4afc-a89c-f2ef528da75d) > for task 1 of framework 201304250543-1015726915-43815-16581-0000 to the > master at [email protected]:43815 > I0425 05:43:22.826860 16663 slave.cpp:1786] Status update manager > successfully handled status update TASK_FINISHED (UUID: > 0e32a68d-b587-4afc-a89c-f2ef528da75d) for task 1 of framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.827267 16663 slave.cpp:1792] Sending acknowledgement for > status update TASK_FINISHED (UUID: 0e32a68d-b587-4afc-a89c-f2ef528da75d) > for task 1 of framework 201304250543-1015726915-43815-16581-0000 to > executor executor(30)@67.195.138.60:43815 > I0425 05:43:22.826915 16662 master.cpp:1086] Status update from (761)@ > 67.195.138.60:43815: task 1 of framework > 201304250543-1015726915-43815-16581-0000 is now in state TASK_FINISHED > I0425 05:43:22.827929 16658 exec.cpp:289] Executor received ACK for status > update of task 1 of framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.828408 16662 master.hpp:300] Removing task with resources > cpus=1; mem=256 on slave 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.828415 16663 sched.cpp:327] Received status update > TASK_FINISHED (UUID: 0e32a68d-b587-4afc-a89c-f2ef528da75d) for task 1 of > framework 201304250543-1015726915-43815-16581-0000 from slave(89)@ > 67.195.138.60:43815 > I0425 05:43:22.829545 16661 hierarchical_allocator_process.hpp:544] > Recovered cpus=1; mem=256 (total allocatable: cpus=2; mem=768; > ports=[31000-32000]; disk=13799) on slave > 201304250543-1015726915-43815-16581-0 from framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.829936 16663 sched.cpp:360] Sending ACK for status update > TASK_FINISHED (UUID: 0e32a68d-b587-4afc-a89c-f2ef528da75d) for task 1 of > framework 201304250543-1015726915-43815-16581-0000 to slave(89)@ > 67.195.138.60:43815 > I0425 05:43:22.830950 16663 slave.cpp:1292] Got status update > acknowledgement 0e32a68d-b587-4afc-a89c-f2ef528da75d for task 1 of > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.831558 16658 status_update_manager.cpp:360] Received status > update acknowledgement 0e32a68d-b587-4afc-a89c-f2ef528da75d for task 1 of > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.832610 16658 status_update_manager.cpp:481] Cleaning up > status update stream for task 1 of framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.833113 16658 slave.cpp:1335] Status update manager > successfully handled status update acknowledgement > 0e32a68d-b587-4afc-a89c-f2ef528da75d for task 1 of framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.868098 16663 hierarchical_allocator_process.hpp:660] Found > available resources: cpus=2; mem=768; ports=[31000-32000]; disk=13799 on > slave 201304250543-1015726915-43815-16581-0 > I0425 05:43:22.868168 16663 hierarchical_allocator_process.hpp:686] > Offering cpus=2; mem=768; ports=[31000-32000]; disk=13799 on slave > 201304250543-1015726915-43815-16581-0 to framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:22.899209 16663 hierarchical_allocator_process.hpp:599] > Performed allocation for 1 slaves in 31.133813000000004ms > I0425 05:43:22.899269 16660 master.hpp:309] Adding offer with resources > cpus=2; mem=768; ports=[31000-32000]; disk=13799 on slave > 201304250543-1015726915-43815-16581-0 > I0425 05:43:23.002543 16660 master.cpp:1327] Sending 1 offers to framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.031121 16656 sched.cpp:282] Received 1 offers > I0425 05:43:23.031920 16658 sched.cpp:422] Stopping framework > '201304250543-1015726915-43815-16581-0000' > I0425 05:43:23.032063 16661 master.cpp:774] Asked to unregister framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.032524 16658 slave.cpp:1099] Asked to shut down framework > 201304250543-1015726915-43815-16581-0000 by [email protected]:43815 > I0425 05:43:23.032549 16663 hierarchical_allocator_process.hpp:359] > Deactivated framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.032554 16661 master.hpp:300] Removing task with resources > cpus=1; mem=256 on slave 201304250543-1015726915-43815-16581-0 > I0425 05:43:23.032973 16658 slave.cpp:1124] Shutting down framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.034430 16658 slave.cpp:2302] Shutting down executor > 'default' of framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.034132 16657 hierarchical_allocator_process.hpp:544] > Recovered cpus=1; mem=256 (total allocatable: cpus=1; mem=256; ports=[]; > disk=0) on slave 201304250543-1015726915-43815-16581-0 from framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.035475 16657 hierarchical_allocator_process.hpp:544] > Recovered cpus=2; mem=768; ports=[31000-32000]; disk=13799 (total > allocatable: cpus=3; mem=1024; ports=[31000-32000]; disk=13799) on slave > 201304250543-1015726915-43815-16581-0 from framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.034919 16656 exec.cpp:321] Executor asked to shutdown > I0425 05:43:23.034031 16661 master.hpp:318] Removing offer with resources > cpus=2; mem=768; ports=[31000-32000]; disk=13799 on slave > 201304250543-1015726915-43815-16581-0 > I0425 05:43:23.043354 16581 master.cpp:477] Master terminating > I0425 05:43:23.043532 16581 master.cpp:283] Shutting down master > I0425 05:43:23.043531 16656 slave.cpp:486] Slave asked to shut down by > [email protected]:43815 > I0425 05:43:23.044134 16660 hierarchical_allocator_process.hpp:423] > Removed slave 201304250543-1015726915-43815-16581-0 > I0425 05:43:23.044457 16656 slave.cpp:1099] Asked to shut down framework > 201304250543-1015726915-43815-16581-0000 by [email protected]:43815 > W0425 05:43:23.045394 16656 slave.cpp:1120] Ignoring shutdown framework > 201304250543-1015726915-43815-16581-0000 because it is terminating > I0425 05:43:23.045897 16656 slave.cpp:441] Slave terminating > I0425 05:43:23.046366 16656 slave.cpp:1099] Asked to shut down framework > 201304250543-1015726915-43815-16581-0000 by @0.0.0.0:0 > W0425 05:43:23.046866 16656 slave.cpp:1120] Ignoring shutdown framework > 201304250543-1015726915-43815-16581-0000 because it is terminating > I0425 05:43:23.051844 16661 hierarchical_allocator_process.hpp:668] No > resources available to allocate! > I0425 05:43:23.103122 16661 hierarchical_allocator_process.hpp:599] > Performed allocation for 0 slaves in 51.289102000000000ms > [ OK ] AllocatorTest/0.TaskFinished (451 ms) > [ RUN ] AllocatorTest/0.WhitelistSlave > I0425 05:43:23.134866 16659 master.cpp:309] Master started on > 67.195.138.60:43815 > I0425 05:43:23.134950 16659 master.cpp:324] Master ID: > 201304250543-1015726915-43815-16581 > I0425 05:43:23.135390 16660 slave.cpp:210] Slave started on 90)@ > 67.195.138.60:43815 > I0425 05:43:23.152130 16657 hierarchical_allocator_process.hpp:236] > Initializing hierarchical allocator process with master : > [email protected]:43815 > I0425 05:43:23.152765 16657 hierarchical_allocator_process.hpp:437] > Updated slave white list: > I0425 05:43:23.152410 16661 sched.cpp:182] New master at > [email protected]:43815 > I0425 05:43:23.152406 16660 slave.cpp:211] Slave resources: cpus=2; > mem=1024; ports=[31000-32000]; disk=13799 > I0425 05:43:23.152302 16659 master.cpp:603] Elected as master! > I0425 05:43:23.153216 16657 hierarchical_allocator_process.hpp:439] > dummy-slave > I0425 05:43:23.154793 16659 master.cpp:646] Registering framework > 201304250543-1015726915-43815-16581-0000 at scheduler(80)@ > 67.195.138.60:43815 > I0425 05:43:23.155699 16661 sched.cpp:217] Framework registered with > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.155184 16657 hierarchical_allocator_process.hpp:632] No > users to allocate resources! > I0425 05:43:23.156617 16657 hierarchical_allocator_process.hpp:599] > Performed allocation for 0 slaves in 1.434983000000000ms > I0425 05:43:23.157152 16657 hierarchical_allocator_process.hpp:268] Added > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.157625 16657 hierarchical_allocator_process.hpp:668] No > resources available to allocate! > I0425 05:43:23.158129 16657 hierarchical_allocator_process.hpp:599] > Performed allocation for 0 slaves in 505.177000000000021us > I0425 05:43:23.155715 16659 master.cpp:633] Framework > 201304250543-1015726915-43815-16581-0000 (scheduler(80)@ > 67.195.138.60:43815) already registered, resending acknowledgement > I0425 05:43:23.154830 16660 slave.cpp:530] New master detected at > [email protected]:43815 > I0425 05:43:23.172045 16660 slave.cpp:545] Postponing registration until > recovery is complete > I0425 05:43:23.172510 16660 slave.cpp:391] Finished recovery > I0425 05:43:23.172085 16662 status_update_manager.cpp:154] New master > detected at [email protected]:43815 > I0425 05:43:23.171521 16659 sched.cpp:212] Ignoring framework registered > message because the driver is already connected! > I0425 05:43:23.173136 16663 master.cpp:968] Attempting to register slave > on janus.apache.org at slave(90)@67.195.138.60:43815 > I0425 05:43:23.174438 16663 master.cpp:1224] Master now considering a > slave at janus.apache.org:43815 as active > I0425 05:43:23.174934 16663 master.cpp:1885] Adding slave > 201304250543-1015726915-43815-16581-0 at janus.apache.org with cpus=2; > mem=1024; ports=[31000-32000]; disk=13799 > I0425 05:43:23.175454 16656 slave.cpp:590] Registered with master > [email protected]:43815; given slave ID > 201304250543-1015726915-43815-16581-0 > I0425 05:43:23.175537 16663 master.cpp:957] Slave > 201304250543-1015726915-43815-16581-0 (janus.apache.org) already > registered, resending acknowledgement > I0425 05:43:23.175631 16660 hierarchical_allocator_process.hpp:395] Added > slave 201304250543-1015726915-43815-16581-0 (janus.apache.org) with > cpus=2; mem=1024; ports=[31000-32000]; disk=13799 (and cpus=2; mem=1024; > ports=[31000-32000]; disk=13799 available) > I0425 05:43:23.176923 16660 hierarchical_allocator_process.hpp:668] No > resources available to allocate! > I0425 05:43:23.177393 16660 hierarchical_allocator_process.hpp:619] > Performed allocation for slave 201304250543-1015726915-43815-16581-0 in > 483.368000000000052us > I0425 05:43:23.182706 16663 hierarchical_allocator_process.hpp:668] No > resources available to allocate! > I0425 05:43:23.182749 16663 hierarchical_allocator_process.hpp:599] > Performed allocation for 1 slaves in 53.947000000000003us > I0425 05:43:23.192806 16662 hierarchical_allocator_process.hpp:668] No > resources available to allocate! > I0425 05:43:23.192857 16662 hierarchical_allocator_process.hpp:599] > Performed allocation for 1 slaves in 109.069000000000017us > I0425 05:43:23.263149 16659 hierarchical_allocator_process.hpp:668] No > resources available to allocate! > I0425 05:43:23.263222 16659 hierarchical_allocator_process.hpp:599] > Performed allocation for 1 slaves in 125.532000000000011us > I0425 05:43:23.273185 16661 hierarchical_allocator_process.hpp:668] No > resources available to allocate! > I0425 05:43:23.273233 16661 hierarchical_allocator_process.hpp:599] > Performed allocation for 1 slaves in 68.660000000000011us > I0425 05:43:23.282392 16661 hierarchical_allocator_process.hpp:437] > Updated slave white list: > I0425 05:43:23.282795 16661 hierarchical_allocator_process.hpp:439] > dummy-slave > I0425 05:43:23.283257 16661 hierarchical_allocator_process.hpp:439] > janus.apache.org > I0425 05:43:23.293305 16658 hierarchical_allocator_process.hpp:660] Found > available resources: cpus=2; mem=1024; ports=[31000-32000]; disk=13799 on > slave 201304250543-1015726915-43815-16581-0 > I0425 05:43:23.293380 16658 hierarchical_allocator_process.hpp:686] > Offering cpus=2; mem=1024; ports=[31000-32000]; disk=13799 on slave > 201304250543-1015726915-43815-16581-0 to framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.304335 16658 hierarchical_allocator_process.hpp:599] > Performed allocation for 1 slaves in 11.087327000000000ms > I0425 05:43:23.304406 16660 master.hpp:309] Adding offer with resources > cpus=2; mem=1024; ports=[31000-32000]; disk=13799 on slave > 201304250543-1015726915-43815-16581-0 > I0425 05:43:23.374493 16660 master.cpp:1327] Sending 1 offers to framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.374979 16663 sched.cpp:282] Received 1 offers > I0425 05:43:23.383939 16662 sched.cpp:422] Stopping framework > '201304250543-1015726915-43815-16581-0000' > I0425 05:43:23.483886 16662 master.cpp:774] Asked to unregister framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.539165 16656 hierarchical_allocator_process.hpp:359] > Deactivated framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.564630 16656 hierarchical_allocator_process.hpp:544] > Recovered cpus=2; mem=1024; ports=[31000-32000]; disk=13799 (total > allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=13799) on slave > 201304250543-1015726915-43815-16581-0 from framework > 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.539232 16662 master.hpp:318] Removing offer with resources > cpus=2; mem=1024; ports=[31000-32000]; disk=13799 on slave > 201304250543-1015726915-43815-16581-0 > I0425 05:43:23.539198 16657 slave.cpp:1099] Asked to shut down framework > 201304250543-1015726915-43815-16581-0000 by [email protected]:43815 > I0425 05:43:23.565670 16581 master.cpp:477] Master terminating > I0425 05:43:23.566457 16581 master.cpp:283] Shutting down master > W0425 05:43:23.565955 16657 slave.cpp:1114] Cannot shut down unknown > framework 201304250543-1015726915-43815-16581-0000 > I0425 05:43:23.567097 16663 hierarchical_allocator_process.hpp:423] > Removed slave 201304250543-1015726915-43815-16581-0 > I0425 05:43:23.567407 16657 slave.cpp:486] Slave asked to shut down by > [email protected]:43815 > I0425 05:43:23.568351 16657 slave.cpp:441] Slave terminating > [ OK ] AllocatorTest/0.WhitelistSlave (435 ms) > [----------] 9 tests from AllocatorTest/0 (6213 ms total) > > [----------] 1 test from LoggingTest > [ RUN ] LoggingTest.Toggle > I0425 05:43:23.569807 16656 process.cpp:2921] Handling HTTP event for > process 'logging' with path: '/logging/toggle' > I0425 05:43:23.570368 16664 process.cpp:870] Socket closed while receiving > I0425 05:43:23.570979 16658 process.cpp:2921] Handling HTTP event for > process 'logging' with path: '/logging/toggle' > I0425 05:43:23.571558 16664 process.cpp:870] Socket closed while receiving > I0425 05:43:23.572022 16657 process.cpp:2921] Handling HTTP event for > process 'logging' with path: '/logging/toggle' > I0425 05:43:23.572635 16664 process.cpp:870] Socket closed while receiving > I0425 05:43:23.573022 16658 process.cpp:2921] Handling HTTP event for > process 'logging' with path: '/logging/toggle' > I0425 05:43:23.573429 16664 process.cpp:870] Socket closed while receiving > I0425 05:43:23.575053 16660 process.cpp:2921] Handling HTTP event for > process 'logging' with path: '/logging/toggle' > I0425 05:43:23.575412 16664 process.cpp:870] Socket closed while receiving > I0425 05:43:23.575948 16660 process.cpp:2921] Handling HTTP event for > process 'logging' with path: '/logging/toggle' > I0425 05:43:23.576380 16664 process.cpp:870] 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 (1 ms) > [ RUN ] CgroupsCpusetTest.ManyCPUManyCpusets > [ OK ] CgroupsCpusetTest.ManyCPUManyCpusets (0 ms) > [ RUN ] CgroupsCpusetTest.IntegerAllocations > [ OK ] CgroupsCpusetTest.IntegerAllocations (0 ms) > [----------] 5 tests from CgroupsCpusetTest (1 ms total) > > [----------] 3 tests from FsTest > [ RUN ] FsTest.MountTableRead > [ OK ] FsTest.MountTableRead (0 ms) > [ RUN ] FsTest.MountTableHasOption > [ OK ] FsTest.MountTableHasOption (0 ms) > [ RUN ] FsTest.FileSystemTableRead > [ OK ] FsTest.FileSystemTableRead (60 ms) > [----------] 3 tests from FsTest (60 ms total) > > [----------] 5 tests from ProcTest > [ RUN ] ProcTest.pids > [ OK ] ProcTest.pids (1 ms) > [ RUN ] ProcTest.children > [ OK ] ProcTest.children (17 ms) > [ RUN ] ProcTest.cpus > [ OK ] ProcTest.cpus (0 ms) > [ RUN ] ProcTest.SystemStatus > [ OK ] ProcTest.SystemStatus (0 ms) > [ RUN ] ProcTest.ProcessStatus > [ OK ] ProcTest.ProcessStatus (0 ms) > [----------] 5 tests from ProcTest (18 ms total) > > [----------] Global test environment tear-down > [==========] 173 tests from 36 test cases ran. (128108 ms total) > [ PASSED ] 172 tests. > [ FAILED ] 1 test, listed below: > [ FAILED ] CoordinatorTest.TruncateLearnedFill > > 1 FAILED TEST > FAIL: mesos-tests > ================== > 1 of 1 test failed > ================== > make[3]: *** [check-TESTS] Error 1 > make[3]: Leaving directory `< > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src > '> > make[2]: *** [check-am] Error 2 > make[2]: Leaving directory `< > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src > '> > make[1]: *** [check] Error 2 > make[1]: Leaving directory `< > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src > '> > make: *** [check-recursive] Error 1 > Build step 'Execute shell' marked build as failure >
