You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2013/03/21 22:08:13 UTC
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME #286
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/286/changes>
Changes:
[vinodkone] Fixed slave to delete an executor after all its pending updates have
been acknowledged.
Review: https://reviews.apache.org/r/10019
[vinodkone] Fixed a minor bug in using path::join() in cgroups isolator.
Review: https://reviews.apache.org/r/10064
[vinodkone] Fixed launcher to flush std::cout when copying local resource.
Review: https://reviews.apache.org/r/10054
[vinodkone] Add pydocs to mesos.py for Executor/Scheduler and driver methods.
From: Brian Wickman <wi...@gmail.com>
Review: https://reviews.apache.org/r/9572
------------------------------------------
[...truncated 13696 lines...]
I0321 21:08:01.724308 12840 hierarchical_allocator_process.hpp:359] Deactivated framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.725774 12837 slave.cpp:386] Slave terminating
I0321 21:08:01.726419 12837 master.cpp:537] Slave 201303212108-1015726915-53744-12778-0(janus.apache.org) disconnected
I0321 21:08:01.726932 12837 master.cpp:542] Removing disconnected slave 201303212108-1015726915-53744-12778-0(janus.apache.org) because it is not checkpointing!
I0321 21:08:01.725786 12841 status_update_manager.cpp:233] Closing status update streams for framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.725966 12840 hierarchical_allocator_process.hpp:544] Recovered cpus=2; mem=1024; ports=[31000-32000]; disk=1024 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=1024) on slave 201303212108-1015726915-53744-12778-0 from framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.727751 12778 master.cpp:477] Master terminating
I0321 21:08:01.730303 12778 master.cpp:283] Shutting down master
[ OK ] AllocatorTest/0.MockAllocator (294 ms)
[ RUN ] AllocatorTest/0.ResourcesUnused
I0321 21:08:01.731547 12848 master.cpp:309] Master started on 67.195.138.60:53744
I0321 21:08:01.731660 12848 master.cpp:324] Master ID: 201303212108-1015726915-53744-12778
I0321 21:08:01.732012 12837 sched.cpp:182] New master at master@67.195.138.60:53744
W0321 21:08:01.732125 12849 master.cpp:81] No whitelist given. Advertising offers for all slaves
I0321 21:08:01.732146 12840 hierarchical_allocator_process.hpp:236] Initializing hierarchical allocator process with master : master@67.195.138.60:53744
I0321 21:08:01.732257 12848 master.cpp:603] Elected as master!
I0321 21:08:01.736057 12848 master.cpp:646] Registering framework 201303212108-1015726915-53744-12778-0000 at scheduler(59)@67.195.138.60:53744
I0321 21:08:01.736528 12841 sched.cpp:217] Framework registered with 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.731778 12839 slave.cpp:203] Slave started on 71)@67.195.138.60:53744
I0321 21:08:01.737592 12839 slave.cpp:204] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024
I0321 21:08:01.738420 12839 slave.cpp:453] New master detected at master@67.195.138.60:53744
I0321 21:08:01.738670 12839 slave.cpp:377] Finished recovery
I0321 21:08:01.736589 12847 hierarchical_allocator_process.hpp:268] Added framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.738683 12842 status_update_manager.cpp:132] New master detected at master@67.195.138.60:53744
I0321 21:08:01.739792 12840 master.cpp:968] Attempting to register slave on janus.apache.org at slave(71)@67.195.138.60:53744
I0321 21:08:01.741765 12840 master.cpp:1224] Master now considering a slave at janus.apache.org:53744 as active
I0321 21:08:01.740726 12847 hierarchical_allocator_process.hpp:668] No resources available to allocate!
I0321 21:08:01.742837 12847 hierarchical_allocator_process.hpp:599] Performed allocation for 0 slaves in 2.11ms
I0321 21:08:01.742301 12840 master.cpp:1862] Adding slave 201303212108-1015726915-53744-12778-0 at janus.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=1024
I0321 21:08:01.743973 12839 slave.cpp:487] Registered with master; given slave ID 201303212108-1015726915-53744-12778-0
I0321 21:08:01.744081 12840 hierarchical_allocator_process.hpp:395] Added slave 201303212108-1015726915-53744-12778-0 (janus.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=1024 (and cpus=2; mem=1024; ports=[31000-32000]; disk=1024 available)
I0321 21:08:01.745344 12840 hierarchical_allocator_process.hpp:660] Found available resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:01.745884 12840 hierarchical_allocator_process.hpp:686] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0 to framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.746557 12840 hierarchical_allocator_process.hpp:619] Performed allocation for slave 201303212108-1015726915-53744-12778-0 in 1.22ms
I0321 21:08:01.746587 12839 master.hpp:309] Adding offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:01.747562 12839 master.cpp:1327] Sending 1 offers to framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.748136 12849 sched.cpp:282] Received 1 offers
I0321 21:08:01.748821 12849 master.cpp:1534] Processing reply for offer 201303212108-1015726915-53744-12778-0 on slave 201303212108-1015726915-53744-12778-0 (janus.apache.org) for framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.749281 12849 master.hpp:289] Adding task with resources cpus=1; mem=512 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:01.750329 12849 master.cpp:1651] Launching task 0 of framework 201303212108-1015726915-53744-12778-0000 with resources cpus=1; mem=512 on slave 201303212108-1015726915-53744-12778-0 (janus.apache.org)
I0321 21:08:01.750920 12849 master.hpp:318] Removing offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:01.750963 12839 slave.cpp:599] Got assigned task 0 for framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.751029 12837 hierarchical_allocator_process.hpp:471] Framework 201303212108-1015726915-53744-12778-0000 left cpus=1; mem=512; ports=[31000-32000]; disk=1024 unused on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:01.753972 12837 hierarchical_allocator_process.hpp:497] Framework 201303212108-1015726915-53744-12778-0000 filtered slave 201303212108-1015726915-53744-12778-0 for 5.00secs
I0321 21:08:01.751242 12841 sched.cpp:182] New master at master@67.195.138.60:53744
I0321 21:08:01.755070 12841 master.cpp:646] Registering framework 201303212108-1015726915-53744-12778-0001 at scheduler(60)@67.195.138.60:53744
I0321 21:08:01.755549 12841 sched.cpp:217] Framework registered with 201303212108-1015726915-53744-12778-0001
I0321 21:08:01.755595 12848 hierarchical_allocator_process.hpp:268] Added framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:01.757076 12848 hierarchical_allocator_process.hpp:660] Found available resources: cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:01.757585 12848 hierarchical_allocator_process.hpp:686] Offering cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0 to framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:01.758669 12848 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 1.61ms
I0321 21:08:01.758760 12847 master.hpp:309] Adding offer with resources cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:01.759562 12847 master.cpp:1327] Sending 1 offers to framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:01.760092 12847 sched.cpp:282] Received 1 offers
I0321 21:08:01.754935 12839 paths.hpp:302] Created executor directory '/tmp/AllocatorTest_0_ResourcesUnused_CGd45I/slaves/201303212108-1015726915-53744-12778-0/frameworks/201303212108-1015726915-53744-12778-0000/executors/default/runs/57a4ab73-b6f4-487a-908f-57f64aa6fc9b'
I0321 21:08:01.760932 12842 sched.cpp:422] Stopping framework '201303212108-1015726915-53744-12778-0000'
I0321 21:08:01.762900 12839 master.cpp:774] Asked to unregister framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.761636 12849 slave.cpp:436] Successfully attached file '/tmp/AllocatorTest_0_ResourcesUnused_CGd45I/slaves/201303212108-1015726915-53744-12778-0/frameworks/201303212108-1015726915-53744-12778-0000/executors/default/runs/57a4ab73-b6f4-487a-908f-57f64aa6fc9b'
I0321 21:08:01.764186 12849 slave.cpp:901] Asked to shut down framework 201303212108-1015726915-53744-12778-0000 by master@67.195.138.60:53744
I0321 21:08:01.764518 12849 slave.cpp:906] Shutting down framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.764983 12849 slave.cpp:1693] Shutting down executor 'default' of framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.765509 12849 status_update_manager.cpp:233] Closing status update streams for framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.761662 12837 exec.cpp:170] Executor started at: executor(19)@67.195.138.60:53744 with pid 12778
I0321 21:08:01.766574 12837 slave.cpp:1058] Got registration for executor 'default' of framework 201303212108-1015726915-53744-12778-0000
W0321 21:08:01.766996 12837 slave.cpp:1084] WARNING! executor 'default' of framework 201303212108-1015726915-53744-12778-0000 should be shutting down
I0321 21:08:01.767813 12837 exec.cpp:321] Executor asked to shutdown
I0321 21:08:01.760958 12840 sched.cpp:422] Stopping framework '201303212108-1015726915-53744-12778-0001'
I0321 21:08:01.763465 12839 master.hpp:300] Removing task with resources cpus=1; mem=512 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:01.769664 12839 master.cpp:774] Asked to unregister framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:01.770190 12848 slave.cpp:901] Asked to shut down framework 201303212108-1015726915-53744-12778-0001 by master@67.195.138.60:53744
I0321 21:08:01.770648 12848 status_update_manager.cpp:233] Closing status update streams for framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:01.763514 12842 hierarchical_allocator_process.hpp:359] Deactivated framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.772686 12842 hierarchical_allocator_process.hpp:312] Removed framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.773215 12842 hierarchical_allocator_process.hpp:359] Deactivated framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:01.770241 12839 master.hpp:318] Removing offer with resources cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:01.782284 12847 slave.cpp:386] Slave terminating
I0321 21:08:01.782493 12847 slave.cpp:901] Asked to shut down framework 201303212108-1015726915-53744-12778-0000 by @0.0.0.0:0
I0321 21:08:01.782959 12847 slave.cpp:906] Shutting down framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.783433 12847 slave.cpp:1693] Shutting down executor 'default' of framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.783968 12847 status_update_manager.cpp:233] Closing status update streams for framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.783988 12849 master.cpp:537] Slave 201303212108-1015726915-53744-12778-0(janus.apache.org) disconnected
I0321 21:08:01.785470 12849 master.cpp:542] Removing disconnected slave 201303212108-1015726915-53744-12778-0(janus.apache.org) because it is not checkpointing!
I0321 21:08:01.786022 12778 master.cpp:477] Master terminating
I0321 21:08:01.793918 12778 master.cpp:283] Shutting down master
[ OK ] AllocatorTest/0.ResourcesUnused (64 ms)
[ RUN ] AllocatorTest/0.OutOfOrderDispatch
I0321 21:08:01.795480 12847 master.cpp:309] Master started on 67.195.138.60:53744
I0321 21:08:01.795655 12847 master.cpp:324] Master ID: 201303212108-1015726915-53744-12778
I0321 21:08:01.802009 12847 master.cpp:603] Elected as master!
I0321 21:08:01.795557 12840 slave.cpp:203] Slave started on 72)@67.195.138.60:53744
I0321 21:08:01.837787 12840 slave.cpp:204] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024
I0321 21:08:01.854028 12840 slave.cpp:453] New master detected at master@67.195.138.60:53744
I0321 21:08:01.873802 12840 slave.cpp:377] Finished recovery
I0321 21:08:01.901871 12840 master.cpp:968] Attempting to register slave on janus.apache.org at slave(72)@67.195.138.60:53744
I0321 21:08:01.925788 12840 master.cpp:1224] Master now considering a slave at janus.apache.org:53744 as active
I0321 21:08:01.933765 12840 master.cpp:1862] Adding slave 201303212108-1015726915-53744-12778-0 at janus.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=1024
I0321 21:08:01.937826 12840 slave.cpp:487] Registered with master; given slave ID 201303212108-1015726915-53744-12778-0
I0321 21:08:01.795610 12841 sched.cpp:182] New master at master@67.195.138.60:53744
I0321 21:08:01.945828 12841 master.cpp:646] Registering framework 201303212108-1015726915-53744-12778-0000 at scheduler(61)@67.195.138.60:53744
I0321 21:08:01.953793 12841 sched.cpp:217] Framework registered with 201303212108-1015726915-53744-12778-0000
I0321 21:08:01.873818 12842 status_update_manager.cpp:132] New master detected at master@67.195.138.60:53744
W0321 21:08:01.802095 12837 master.cpp:81] No whitelist given. Advertising offers for all slaves
I0321 21:08:01.802122 12848 hierarchical_allocator_process.hpp:236] Initializing hierarchical allocator process with master : master@67.195.138.60:53744
I0321 21:08:01.985769 12848 hierarchical_allocator_process.hpp:395] Added slave 201303212108-1015726915-53744-12778-0 (janus.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=1024 (and cpus=2; mem=1024; ports=[31000-32000]; disk=1024 available)
I0321 21:08:01.993751 12848 hierarchical_allocator_process.hpp:632] No users to allocate resources!
I0321 21:08:02.001781 12848 hierarchical_allocator_process.hpp:619] Performed allocation for slave 201303212108-1015726915-53744-12778-0 in 8.03ms
I0321 21:08:02.005964 12848 hierarchical_allocator_process.hpp:268] Added framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.025218 12848 hierarchical_allocator_process.hpp:660] Found available resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.033802 12848 hierarchical_allocator_process.hpp:686] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0 to framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.053918 12848 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 28.75ms
I0321 21:08:02.057874 12848 master.hpp:309] Adding offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.058298 12848 master.cpp:1327] Sending 1 offers to framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.058831 12848 sched.cpp:282] Received 1 offers
I0321 21:08:02.059541 12848 sched.cpp:422] Stopping framework '201303212108-1015726915-53744-12778-0000'
I0321 21:08:02.059950 12847 master.cpp:774] Asked to unregister framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.060483 12848 slave.cpp:901] Asked to shut down framework 201303212108-1015726915-53744-12778-0000 by master@67.195.138.60:53744
I0321 21:08:02.061553 12848 status_update_manager.cpp:233] Closing status update streams for framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.060534 12847 master.hpp:318] Removing offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.060538 12839 hierarchical_allocator_process.hpp:359] Deactivated framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.063004 12839 hierarchical_allocator_process.hpp:312] Removed framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.063467 12839 hierarchical_allocator_process.hpp:544] Recovered cpus=2; mem=1024; ports=[31000-32000]; disk=1024 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=1024) on slave 201303212108-1015726915-53744-12778-0 from framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.062839 12840 sched.cpp:182] New master at master@67.195.138.60:53744
I0321 21:08:02.070325 12841 master.cpp:646] Registering framework 201303212108-1015726915-53744-12778-0001 at scheduler(62)@67.195.138.60:53744
I0321 21:08:02.070742 12840 sched.cpp:217] Framework registered with 201303212108-1015726915-53744-12778-0001
I0321 21:08:02.070760 12841 hierarchical_allocator_process.hpp:268] Added framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:02.071918 12841 hierarchical_allocator_process.hpp:660] Found available resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.072384 12841 hierarchical_allocator_process.hpp:686] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0 to framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:02.072927 12841 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 1.03ms
I0321 21:08:02.072968 12842 master.hpp:309] Adding offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.073910 12842 master.cpp:1327] Sending 1 offers to framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:02.074468 12837 sched.cpp:282] Received 1 offers
I0321 21:08:02.081894 12842 sched.cpp:422] Stopping framework '201303212108-1015726915-53744-12778-0001'
I0321 21:08:02.090011 12849 master.cpp:774] Asked to unregister framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:02.090450 12849 master.hpp:318] Removing offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.090492 12848 slave.cpp:901] Asked to shut down framework 201303212108-1015726915-53744-12778-0001 by master@67.195.138.60:53744
I0321 21:08:02.091351 12848 slave.cpp:386] Slave terminating
I0321 21:08:02.090492 12842 hierarchical_allocator_process.hpp:359] Deactivated framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:02.093019 12842 hierarchical_allocator_process.hpp:544] Recovered cpus=2; mem=1024; ports=[31000-32000]; disk=1024 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=1024) on slave 201303212108-1015726915-53744-12778-0 from framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:02.092526 12848 master.cpp:537] Slave 201303212108-1015726915-53744-12778-0(janus.apache.org) disconnected
I0321 21:08:02.094768 12848 master.cpp:542] Removing disconnected slave 201303212108-1015726915-53744-12778-0(janus.apache.org) because it is not checkpointing!
I0321 21:08:02.091378 12847 status_update_manager.cpp:233] Closing status update streams for framework 201303212108-1015726915-53744-12778-0001
I0321 21:08:02.095270 12842 master.cpp:477] Master terminating
I0321 21:08:02.096374 12778 master.cpp:283] Shutting down master
[ OK ] AllocatorTest/0.OutOfOrderDispatch (303 ms)
[ RUN ] AllocatorTest/0.SchedulerFailover
I0321 21:08:02.097878 12842 master.cpp:309] Master started on 67.195.138.60:53744
I0321 21:08:02.097929 12842 master.cpp:324] Master ID: 201303212108-1015726915-53744-12778
I0321 21:08:02.098495 12839 sched.cpp:182] New master at master@67.195.138.60:53744
W0321 21:08:02.098611 12841 master.cpp:81] No whitelist given. Advertising offers for all slaves
I0321 21:08:02.098657 12848 hierarchical_allocator_process.hpp:236] Initializing hierarchical allocator process with master : master@67.195.138.60:53744
I0321 21:08:02.098712 12842 master.cpp:603] Elected as master!
I0321 21:08:02.101575 12842 master.cpp:646] Registering framework 201303212108-1015726915-53744-12778-0000 at scheduler(63)@67.195.138.60:53744
I0321 21:08:02.098268 12849 slave.cpp:203] Slave started on 73)@67.195.138.60:53744
I0321 21:08:02.102565 12849 slave.cpp:204] Slave resources: cpus=3; mem=1024; ports=[31000-32000]; disk=14036
I0321 21:08:02.103401 12849 slave.cpp:453] New master detected at master@67.195.138.60:53744
I0321 21:08:02.103572 12849 slave.cpp:377] Finished recovery
I0321 21:08:02.102059 12842 hierarchical_allocator_process.hpp:268] Added framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.104521 12842 hierarchical_allocator_process.hpp:668] No resources available to allocate!
I0321 21:08:02.105244 12842 hierarchical_allocator_process.hpp:599] Performed allocation for 0 slaves in 724.22us
I0321 21:08:02.104161 12841 master.cpp:968] Attempting to register slave on janus.apache.org at slave(73)@67.195.138.60:53744
I0321 21:08:02.106827 12841 master.cpp:1224] Master now considering a slave at janus.apache.org:53744 as active
I0321 21:08:02.114722 12841 master.cpp:1862] Adding slave 201303212108-1015726915-53744-12778-0 at janus.apache.org with cpus=3; mem=1024; ports=[31000-32000]; disk=14036
I0321 21:08:02.101999 12837 sched.cpp:217] Framework registered with 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.103586 12839 status_update_manager.cpp:132] New master detected at master@67.195.138.60:53744
I0321 21:08:02.137893 12841 slave.cpp:487] Registered with master; given slave ID 201303212108-1015726915-53744-12778-0
I0321 21:08:02.137985 12849 hierarchical_allocator_process.hpp:395] Added slave 201303212108-1015726915-53744-12778-0 (janus.apache.org) with cpus=3; mem=1024; ports=[31000-32000]; disk=14036 (and cpus=3; mem=1024; ports=[31000-32000]; disk=14036 available)
I0321 21:08:02.143165 12849 hierarchical_allocator_process.hpp:660] Found available resources: cpus=3; mem=1024; ports=[31000-32000]; disk=14036 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.143673 12849 hierarchical_allocator_process.hpp:686] Offering cpus=3; mem=1024; ports=[31000-32000]; disk=14036 on slave 201303212108-1015726915-53744-12778-0 to framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.144336 12849 hierarchical_allocator_process.hpp:619] Performed allocation for slave 201303212108-1015726915-53744-12778-0 in 1.18ms
I0321 21:08:02.144407 12841 master.hpp:309] Adding offer with resources cpus=3; mem=1024; ports=[31000-32000]; disk=14036 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.145452 12841 master.cpp:1327] Sending 1 offers to framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.145900 12841 sched.cpp:282] Received 1 offers
I0321 21:08:02.146476 12841 master.cpp:1534] Processing reply for offer 201303212108-1015726915-53744-12778-0 on slave 201303212108-1015726915-53744-12778-0 (janus.apache.org) for framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.146968 12841 master.hpp:289] Adding task with resources cpus=1; mem=256 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.147449 12841 master.cpp:1651] Launching task 0 of framework 201303212108-1015726915-53744-12778-0000 with resources cpus=1; mem=256 on slave 201303212108-1015726915-53744-12778-0 (janus.apache.org)
I0321 21:08:02.153838 12841 master.hpp:318] Removing offer with resources cpus=3; mem=1024; ports=[31000-32000]; disk=14036 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.153908 12848 slave.cpp:599] Got assigned task 0 for framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.153976 12840 hierarchical_allocator_process.hpp:471] Framework 201303212108-1015726915-53744-12778-0000 left cpus=2; mem=768; ports=[31000-32000]; disk=14036 unused on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.183214 12848 paths.hpp:302] Created executor directory '/tmp/AllocatorTest_0_SchedulerFailover_tkrx75/slaves/201303212108-1015726915-53744-12778-0/frameworks/201303212108-1015726915-53744-12778-0000/executors/default/runs/adf852db-92bd-4ca2-bfbf-407907d046da'
I0321 21:08:02.183625 12848 slave.cpp:436] Successfully attached file '/tmp/AllocatorTest_0_SchedulerFailover_tkrx75/slaves/201303212108-1015726915-53744-12778-0/frameworks/201303212108-1015726915-53744-12778-0000/executors/default/runs/adf852db-92bd-4ca2-bfbf-407907d046da'
I0321 21:08:02.183657 12847 exec.cpp:170] Executor started at: executor(20)@67.195.138.60:53744 with pid 12778
I0321 21:08:02.184847 12847 slave.cpp:1058] Got registration for executor 'default' of framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.185374 12847 slave.cpp:1133] Flushing queued tasks for framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.185459 12842 exec.cpp:194] Executor registered on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.186467 12842 exec.cpp:258] Executor asked to run task '0'
I0321 21:08:02.187021 12840 sched.cpp:422] Stopping framework '201303212108-1015726915-53744-12778-0000'
I0321 21:08:02.187525 12839 master.cpp:488] Framework 201303212108-1015726915-53744-12778-0000 disconnected
I0321 21:08:02.188120 12839 master.cpp:500] Giving framework 201303212108-1015726915-53744-12778-0000 500.00ms to failover
I0321 21:08:02.188169 12840 hierarchical_allocator_process.hpp:359] Deactivated framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.188251 12848 sched.cpp:182] New master at master@67.195.138.60:53744
I0321 21:08:02.192150 12848 master.cpp:681] Re-registering framework 201303212108-1015726915-53744-12778-0000 at scheduler(64)@67.195.138.60:53744
I0321 21:08:02.192589 12848 master.cpp:700] Framework 201303212108-1015726915-53744-12778-0000 failed over
I0321 21:08:02.197842 12848 sched.cpp:217] Framework registered with 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.197903 12849 slave.cpp:968] Updating framework 201303212108-1015726915-53744-12778-0000 pid to scheduler(64)@67.195.138.60:53744
I0321 21:08:02.197939 12837 hierarchical_allocator_process.hpp:327] Activated framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.217767 12837 hierarchical_allocator_process.hpp:660] Found available resources: cpus=2; mem=768; ports=[31000-32000]; disk=14036 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.225766 12837 hierarchical_allocator_process.hpp:686] Offering cpus=2; mem=768; ports=[31000-32000]; disk=14036 on slave 201303212108-1015726915-53744-12778-0 to framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.233866 12837 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 16.11ms
I0321 21:08:02.233953 12841 master.hpp:309] Adding offer with resources cpus=2; mem=768; ports=[31000-32000]; disk=14036 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.235322 12841 master.cpp:1327] Sending 1 offers to framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.235752 12841 sched.cpp:282] Received 1 offers
I0321 21:08:02.236294 12847 sched.cpp:422] Stopping framework '201303212108-1015726915-53744-12778-0000'
I0321 21:08:02.236716 12847 master.cpp:488] Framework 201303212108-1015726915-53744-12778-0000 disconnected
I0321 21:08:02.237171 12847 master.cpp:500] Giving framework 201303212108-1015726915-53744-12778-0000 500.00ms to failover
I0321 21:08:02.237720 12847 master.hpp:318] Removing offer with resources cpus=2; mem=768; ports=[31000-32000]; disk=14036 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.237241 12842 hierarchical_allocator_process.hpp:359] Deactivated framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.239158 12842 hierarchical_allocator_process.hpp:544] Recovered cpus=2; mem=768; ports=[31000-32000]; disk=14036 (total allocatable: cpus=2; mem=768; ports=[31000-32000]; disk=14036) on slave 201303212108-1015726915-53744-12778-0 from framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.737858 12839 master.cpp:1259] Framework failover timeout, removing framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.738086 12839 master.hpp:300] Removing task with resources cpus=1; mem=256 on slave 201303212108-1015726915-53744-12778-0
I0321 21:08:02.773913 12839 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=256 (total allocatable: cpus=3; mem=1024; ports=[31000-32000]; disk=14036) on slave 201303212108-1015726915-53744-12778-0 from framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.738163 12840 slave.cpp:901] Asked to shut down framework 201303212108-1015726915-53744-12778-0000 by master@67.195.138.60:53744
I0321 21:08:02.853783 12840 slave.cpp:906] Shutting down framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.874120 12840 slave.cpp:1693] Shutting down executor 'default' of framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.877802 12840 slave.cpp:386] Slave terminating
I0321 21:08:02.897821 12840 slave.cpp:901] Asked to shut down framework 201303212108-1015726915-53744-12778-0000 by @0.0.0.0:0
I0321 21:08:02.905798 12840 slave.cpp:906] Shutting down framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.909813 12840 slave.cpp:1693] Shutting down executor 'default' of framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.917839 12840 master.cpp:537] Slave 201303212108-1015726915-53744-12778-0(janus.apache.org) disconnected
I0321 21:08:02.929796 12840 master.cpp:542] Removing disconnected slave 201303212108-1015726915-53744-12778-0(janus.apache.org) because it is not checkpointing!
I0321 21:08:02.877874 12849 status_update_manager.cpp:233] Closing status update streams for framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.938237 12849 status_update_manager.cpp:233] Closing status update streams for framework 201303212108-1015726915-53744-12778-0000
I0321 21:08:02.937870 12778 master.cpp:477] Master terminating
tests/allocator_tests.cpp:642: Failure
Actual function call count doesn't match EXPECT_CALL(exec, shutdown(_))...
Expected: to be called once
Actual: never called - unsatisfied and active
I0321 21:08:02.939414 12778 master.cpp:283] Shutting down master
[ FAILED ] AllocatorTest/0.SchedulerFailover, where TypeParam = mesos::internal::master::HierarchicalAllocatorProcess<mesos::internal::master::DRFSorter, mesos::internal::master::DRFSorter> (843 ms)
[ RUN ] AllocatorTest/0.FrameworkExited
I0321 21:08:02.877851 12848 exec.cpp:321] Executor asked to shutdown
pure virtual method called
terminate called without an active exception
/bin/bash: line 5: 12778 Aborted ${dir}$tst
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-In-Src-Set-JAVA_HOME/ws/src'>
make[2]: *** [check-am] Error 2
make[2]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'>
make[1]: *** [check] Error 2
make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'>
make: *** [check-recursive] Error 1
I0321 21:08:03.825489 15205 exec.cpp:83] Committing suicide by killing the process group
I0321 21:08:03.829480 15183 exec.cpp:83] Committing suicide by killing the process group
I0321 21:08:03.833468 15200 exec.cpp:83] Committing suicide by killing the process group
Process leaked file descriptors. See http://wiki.jenkins-ci.org/display/JENKINS/Spawning+processes+from+build for more information
Build step 'Execute shell' marked build as failure