https://issues.apache.org/jira/browse/MESOS-521 https://issues.apache.org/jira/browse/MESOS-522
On Sun, Jun 23, 2013 at 7:56 PM, Apache Jenkins Server < [email protected]> wrote: > See < > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/1233/ > > > > ------------------------------------------ > [...truncated 13846 lines...] > I0624 02:56:21.616277 364 slave.cpp:1693] Handling status update > TASK_RUNNING (UUID: 03ffcf19-70ff-4287-a3d9-778a93eede3b) for task 0 of > framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:21.616439 364 status_update_manager.cpp:290] Received status > update TASK_RUNNING (UUID: 03ffcf19-70ff-4287-a3d9-778a93eede3b) for task 0 > of framework 201306240256-143311683-38688-32750-0000 with checkpoint=false > I0624 02:56:21.616503 364 status_update_manager.cpp:450] Creating > StatusUpdate stream for task 0 of framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:21.616662 364 status_update_manager.cpp:336] Forwarding > status update TASK_RUNNING (UUID: 03ffcf19-70ff-4287-a3d9-778a93eede3b) for > task 0 of framework 201306240256-143311683-38688-32750-0000 to > [email protected]:38688 > I0624 02:56:21.616763 364 slave.cpp:1804] Status update manager > successfully handled status update TASK_RUNNING (UUID: > 03ffcf19-70ff-4287-a3d9-778a93eede3b) for task 0 of framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:21.616770 366 master.cpp:1022] Status update from slave(99)@ > 67.195.138.8:38688: task 0 of framework > 201306240256-143311683-38688-32750-0000 is now in state TASK_RUNNING > I0624 02:56:21.616859 364 slave.cpp:1810] Sending acknowledgement for > status update TASK_RUNNING (UUID: 03ffcf19-70ff-4287-a3d9-778a93eede3b) for > task 0 of framework 201306240256-143311683-38688-32750-0000 to executor(37)@ > 67.195.138.8:38688 > I0624 02:56:21.617058 363 exec.cpp:290] Executor received status update > acknowledgement 03ffcf19-70ff-4287-a3d9-778a93eede3b for task 0 of > framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:21.617144 364 status_update_manager.cpp:360] Received status > update acknowledgement 03ffcf19-70ff-4287-a3d9-778a93eede3b for task 0 of > framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:21.617355 365 master.cpp:385] Master terminating > I0624 02:56:21.617390 361 slave.cpp:1344] Status update manager > successfully handled status update acknowledgement > 03ffcf19-70ff-4287-a3d9-778a93eede3b for task 0 of framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:21.617573 32750 master.cpp:207] Shutting down master > I0624 02:56:21.617631 361 slave.cpp:1885] [email protected]:38688exited > W0624 02:56:21.617715 361 slave.cpp:1888] Master disconnected! Waiting > for a new master to be elected > I0624 02:56:21.617724 362 hierarchical_allocator_process.hpp:412] > Deactivated framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:21.617728 32750 master.hpp:303] Removing task 0 with resources > cpus=1; mem=500 on slave 201306240256-143311683-38688-32750-0 > I0624 02:56:21.617842 361 slave.cpp:1113] Asked to shut down framework > 201306240256-143311683-38688-32750-0000 by [email protected]:38688 > I0624 02:56:21.618017 361 slave.cpp:1138] Shutting down framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:21.618098 361 slave.cpp:2329] Shutting down executor > 'default' of framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:21.618151 364 hierarchical_allocator_process.hpp:616] > Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; > ports=[31000-32000]; disk=21412) on slave > 201306240256-143311683-38688-32750-0 from framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:21.618201 365 exec.cpp:323] Executor asked to shutdown > I0624 02:56:21.618306 364 hierarchical_allocator_process.hpp:367] > Removed framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:21.619287 359 master.cpp:228] Master started on > 67.195.138.8:38688 > I0624 02:56:21.619346 359 master.cpp:243] Master ID: > 201306240256-143311683-38688-32750 > I0624 02:56:21.620472 366 detector.cpp:420] Master detector > (scheduler(90)@67.195.138.8:38688) found 0 registered masters > I0624 02:56:21.620563 362 detector.cpp:420] Master detector (slave(99)@ > 67.195.138.8:38688) found 0 registered masters > W0624 02:56:21.625742 365 master.cpp:83] No whitelist given. Advertising > offers for all slaves > I0624 02:56:21.621731 361 detector.cpp:234] Master detector ( > [email protected]:38688) connected to ZooKeeper ... > I0624 02:56:21.625877 361 detector.cpp:251] Trying to create path > '/znode' in ZooKeeper > I0624 02:56:21.625855 363 hierarchical_allocator_process.hpp:295] > Initializing hierarchical allocator process with master : > [email protected]:38688 > I0624 02:56:21.625684 366 detector.cpp:441] Master detector > (scheduler(90)@67.195.138.8:38688) couldn't find any masters > I0624 02:56:21.626171 366 sched.cpp:194] No master detected, waiting for > another master > I0624 02:56:21.625757 362 detector.cpp:441] Master detector (slave(99)@ > 67.195.138.8:38688) couldn't find any masters > I0624 02:56:21.626349 362 slave.cpp:574] Lost master(s) ... waiting > I0624 02:56:21.627639 361 detector.cpp:281] Created ephemeral/sequence > znode at '/znode/0000000002' > I0624 02:56:21.627940 362 detector.cpp:420] Master detector (slave(99)@ > 67.195.138.8:38688) found 1 registered masters > I0624 02:56:21.628160 359 detector.cpp:420] Master detector > (scheduler(90)@67.195.138.8:38688) found 1 registered masters > I0624 02:56:21.628304 361 detector.cpp:420] Master detector ( > [email protected]:38688) found 1 registered masters > I0624 02:56:21.634204 362 detector.cpp:467] Master detector (slave(99)@ > 67.195.138.8:38688) got new master pid: [email protected]:38688 > I0624 02:56:21.634345 362 slave.cpp:540] New master detected at > [email protected]:38688 > I0624 02:56:21.634413 364 status_update_manager.cpp:155] New master > detected at [email protected]:38688 > I0624 02:56:21.634709 359 detector.cpp:467] Master detector > (scheduler(90)@67.195.138.8:38688) got new master pid: > [email protected]:38688 > I0624 02:56:21.634814 359 sched.cpp:177] New master at > [email protected]:38688 > W0624 02:56:21.634876 359 master.cpp:591] Ignoring re-register framework > message since not elected yet > I0624 02:56:21.635015 361 detector.cpp:467] Master detector ( > [email protected]:38688) got new master pid: [email protected]:38688 > I0624 02:56:21.635119 361 master.cpp:526] Elected as master! > I0624 02:56:22.611117 359 master.cpp:604] Re-registering framework > 201306240256-143311683-38688-32750-0000 at scheduler(90)@ > 67.195.138.8:38688 > I0624 02:56:22.611313 359 sched.cpp:246] Framework re-registered with > 201306240256-143311683-38688-32750-0000 > I0624 02:56:22.611450 363 hierarchical_allocator_process.hpp:327] Added > framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:22.611500 363 hierarchical_allocator_process.hpp:705] No > resources available to allocate! > I0624 02:56:22.611556 363 hierarchical_allocator_process.hpp:667] > Performed allocation for 0 slaves in 54.856us > I0624 02:56:22.626091 364 hierarchical_allocator_process.hpp:705] No > resources available to allocate! > I0624 02:56:22.626140 364 hierarchical_allocator_process.hpp:667] > Performed allocation for 0 slaves in 54.744us > I0624 02:56:22.635326 359 master.cpp:963] Attempting to re-register > slave 201306240256-143311683-38688-32750-0 at slave(99)@67.195.138.8:38688( > minerva.apache.org) > I0624 02:56:22.635367 359 master.cpp:1851] Adding slave > 201306240256-143311683-38688-32750-0 at minerva.apache.org with cpus=2; > mem=1024; ports=[31000-32000]; disk=21412 > I0624 02:56:22.635491 366 slave.cpp:636] Re-registered with master > [email protected]:38688 > I0624 02:56:22.635552 359 master.hpp:291] Adding task 0 with resources > cpus=1; mem=500 on slave 201306240256-143311683-38688-32750-0 > W0624 02:56:22.635753 365 slave.cpp:1274] Ignoring updating pid for > framework 201306240256-143311683-38688-32750-0000 because it is terminating > I0624 02:56:22.635865 360 hierarchical_allocator_process.hpp:449] Added > slave 201306240256-143311683-38688-32750-0 (minerva.apache.org) with > cpus=2; mem=1024; ports=[31000-32000]; disk=21412 (and cpus=1; mem=524; > ports=[31000-32000]; disk=21412 available) > I0624 02:56:22.635989 360 hierarchical_allocator_process.hpp:727] > Offering cpus=1; mem=524; ports=[31000-32000]; disk=21412 on slave > 201306240256-143311683-38688-32750-0 to framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:22.636132 360 hierarchical_allocator_process.hpp:687] > Performed allocation for slave 201306240256-143311683-38688-32750-0 in > 164.591us > I0624 02:56:22.636219 360 master.hpp:313] Adding offer > 201306240256-143311683-38688-32750-0 with resources cpus=1; mem=524; > ports=[31000-32000]; disk=21412 on slave > 201306240256-143311683-38688-32750-0 > I0624 02:56:22.636301 360 master.cpp:1239] Sending 1 offers to framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:22.636641 360 sched.cpp:427] Stopping framework > '201306240256-143311683-38688-32750-0000' > I0624 02:56:22.636656 32750 master.cpp:385] Master terminating > I0624 02:56:22.636777 32750 master.cpp:207] Shutting down master > I0624 02:56:22.636868 32750 master.hpp:303] Removing task 0 with resources > cpus=1; mem=500 on slave 201306240256-143311683-38688-32750-0 > I0624 02:56:22.636903 366 hierarchical_allocator_process.hpp:412] > Deactivated framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:22.637006 32750 master.hpp:323] Removing offer > 201306240256-143311683-38688-32750-0 with resources cpus=1; mem=524; > ports=[31000-32000]; disk=21412 on slave > 201306240256-143311683-38688-32750-0 > I0624 02:56:22.637140 360 hierarchical_allocator_process.hpp:616] > Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; > disk=0) on slave 201306240256-143311683-38688-32750-0 from framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:22.637306 360 hierarchical_allocator_process.hpp:616] > Recovered cpus=1; mem=524; ports=[31000-32000]; disk=21412 (total > allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=21412) on slave > 201306240256-143311683-38688-32750-0 from framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:22.636773 365 slave.cpp:496] Slave asked to shut down by > [email protected]:38688 > I0624 02:56:22.637428 360 hierarchical_allocator_process.hpp:367] > Removed framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:22.637431 365 slave.cpp:1113] Asked to shut down framework > 201306240256-143311683-38688-32750-0000 by [email protected]:38688 > W0624 02:56:22.637646 365 slave.cpp:1134] Ignoring shutdown framework > 201306240256-143311683-38688-32750-0000 because it is terminating > I0624 02:56:22.637608 360 hierarchical_allocator_process.hpp:477] > Removed slave 201306240256-143311683-38688-32750-0 > I0624 02:56:22.641284 362 detector.cpp:420] Master detector (slave(99)@ > 67.195.138.8:38688) found 0 registered masters > I0624 02:56:22.645629 365 slave.cpp:451] Slave terminating > I0624 02:56:22.645771 362 detector.cpp:441] Master detector (slave(99)@ > 67.195.138.8:38688) couldn't find any masters > I0624 02:56:22.645824 365 slave.cpp:1113] Asked to shut down framework > 201306240256-143311683-38688-32750-0000 by @0.0.0.0:0 > W0624 02:56:22.645969 365 slave.cpp:1134] Ignoring shutdown framework > 201306240256-143311683-38688-32750-0000 because it is terminating > [ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (2055 ms) > [ RUN ] AllocatorZooKeeperTest/0.SlaveReregistersFirst > I0624 02:56:22.647074 366 master.cpp:228] Master started on > 67.195.138.8:38688 > 2013-06-24 02:56:22,647:32750(0x2af799602700):ZOO_INFO@log_env@658: > Client environment:zookeeper.version=zookeeper C client 3.3.4 > 2013-06-24 02:56:22,647:32750(0x2af799602700):ZOO_INFO@log_env@662: > Client environment:host.name=minerva > 2013-06-24 02:56:22,648:32750(0x2af799602700):ZOO_INFO@log_env@669: > Client environment:os.name=Linux > 2013-06-24 02:56:22,648:32750(0x2af799602700):ZOO_INFO@log_env@670: > Client environment:os.arch=3.2.0-38-generic > 2013-06-24 02:56:22,648:32750(0x2af799602700):ZOO_INFO@log_env@671: > Client environment:os.version=#61-Ubuntu SMP Tue Feb 19 12:18:21 UTC 2013 > 2013-06-24 02:56:22,648:32750(0x2af799602700):ZOO_INFO@log_env@679: > Client environment:user.name=(null) > I0624 02:56:22.647137 366 master.cpp:243] Master ID: > 201306240256-143311683-38688-32750 > I0624 02:56:22.647768 359 slave.cpp:219] Slave started on 100)@ > 67.195.138.8:38688 > I0624 02:56:22.649019 360 detector.cpp:234] Master detector ( > [email protected]:38688) connected to ZooKeeper ... > I0624 02:56:22.657773 360 detector.cpp:251] Trying to create path > '/znode' in ZooKeeper > I0624 02:56:22.650229 365 detector.cpp:234] Master detector > (scheduler(91)@67.195.138.8:38688) connected to ZooKeeper ... > I0624 02:56:22.657695 359 slave.cpp:220] Slave resources: cpus=2; > mem=1024; ports=[31000-32000]; disk=21412 > W0624 02:56:22.657728 362 master.cpp:83] No whitelist given. Advertising > offers for all slaves > I0624 02:56:22.657742 361 hierarchical_allocator_process.hpp:295] > Initializing hierarchical allocator process with master : > [email protected]:38688 > I0624 02:56:22.649718 363 detector.cpp:234] Master detector (slave(100)@ > 67.195.138.8:38688) connected to ZooKeeper ... > I0624 02:56:22.657990 365 detector.cpp:251] Trying to create path > '/znode' in ZooKeeper > I0624 02:56:22.658587 363 detector.cpp:251] Trying to create path > '/znode' in ZooKeeper > I0624 02:56:22.658854 366 slave.cpp:401] Finished recovery > I0624 02:56:22.660049 360 detector.cpp:281] Created ephemeral/sequence > znode at '/znode/0000000004' > I0624 02:56:22.660408 365 detector.cpp:420] Master detector > (scheduler(91)@67.195.138.8:38688) found 1 registered masters > I0624 02:56:22.660601 360 detector.cpp:420] Master detector ( > [email protected]:38688) found 1 registered masters > I0624 02:56:22.660748 363 detector.cpp:420] Master detector (slave(100)@ > 67.195.138.8:38688) found 1 registered masters > I0624 02:56:22.666358 365 detector.cpp:467] Master detector > (scheduler(91)@67.195.138.8:38688) got new master pid: > [email protected]:38688 > I0624 02:56:22.666517 365 sched.cpp:177] New master at > [email protected]:38688 > W0624 02:56:22.666597 365 master.cpp:549] Ignoring register framework > message since not elected yet > I0624 02:56:22.666879 360 detector.cpp:467] Master detector ( > [email protected]:38688) got new master pid: [email protected]:38688 > I0624 02:56:22.666981 360 master.cpp:526] Elected as master! > I0624 02:56:22.667227 363 detector.cpp:467] Master detector (slave(100)@ > 67.195.138.8:38688) got new master pid: [email protected]:38688 > I0624 02:56:22.667441 363 slave.cpp:540] New master detected at > [email protected]:38688 > I0624 02:56:22.667520 361 status_update_manager.cpp:155] New master > detected at [email protected]:38688 > I0624 02:56:22.667603 366 master.cpp:891] Attempting to register slave > on minerva.apache.org at slave(100)@67.195.138.8:38688 > I0624 02:56:22.667677 366 master.cpp:1851] Adding slave > 201306240256-143311683-38688-32750-0 at minerva.apache.org with cpus=2; > mem=1024; ports=[31000-32000]; disk=21412 > I0624 02:56:22.667791 360 slave.cpp:600] Registered with master > [email protected]:38688; given slave ID > 201306240256-143311683-38688-32750-0 > I0624 02:56:22.667944 362 hierarchical_allocator_process.hpp:449] Added > slave 201306240256-143311683-38688-32750-0 (minerva.apache.org) with > cpus=2; mem=1024; ports=[31000-32000]; disk=21412 (and cpus=2; mem=1024; > ports=[31000-32000]; disk=21412 available) > I0624 02:56:22.668028 362 hierarchical_allocator_process.hpp:700] No > users to allocate resources! > I0624 02:56:22.668088 362 hierarchical_allocator_process.hpp:687] > Performed allocation for slave 201306240256-143311683-38688-32750-0 in > 61.065us > I0624 02:56:23.658687 360 hierarchical_allocator_process.hpp:700] No > users to allocate resources! > I0624 02:56:23.658782 360 hierarchical_allocator_process.hpp:667] > Performed allocation for 1 slaves in 109.3us > I0624 02:56:23.666931 363 master.cpp:569] Registering framework > 201306240256-143311683-38688-32750-0000 at scheduler(91)@ > 67.195.138.8:38688 > I0624 02:56:23.667045 363 sched.cpp:222] Framework registered with > 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.667114 364 hierarchical_allocator_process.hpp:327] Added > framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.667212 364 hierarchical_allocator_process.hpp:727] > Offering cpus=2; mem=1024; ports=[31000-32000]; disk=21412 on slave > 201306240256-143311683-38688-32750-0 to framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.667337 364 hierarchical_allocator_process.hpp:667] > Performed allocation for 1 slaves in 140.359us > I0624 02:56:23.667394 366 master.hpp:313] Adding offer > 201306240256-143311683-38688-32750-0 with resources cpus=2; mem=1024; > ports=[31000-32000]; disk=21412 on slave > 201306240256-143311683-38688-32750-0 > I0624 02:56:23.667485 366 master.cpp:1239] Sending 1 offers to framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.667798 365 master.cpp:1472] Processing reply for offer > 201306240256-143311683-38688-32750-0 on slave > 201306240256-143311683-38688-32750-0 (minerva.apache.org) for framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.667961 365 master.hpp:291] Adding task 0 with resources > cpus=1; mem=500 on slave 201306240256-143311683-38688-32750-0 > I0624 02:56:23.668004 365 master.cpp:1591] Launching task 0 of framework > 201306240256-143311683-38688-32750-0000 with resources cpus=1; mem=500 on > slave 201306240256-143311683-38688-32750-0 (minerva.apache.org) > I0624 02:56:23.668114 361 slave.cpp:740] Got assigned task 0 for > framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.668174 365 master.hpp:323] Removing offer > 201306240256-143311683-38688-32750-0 with resources cpus=2; mem=1024; > ports=[31000-32000]; disk=21412 on slave > 201306240256-143311683-38688-32750-0 > I0624 02:56:23.668299 365 hierarchical_allocator_process.hpp:526] > Framework 201306240256-143311683-38688-32750-0000 left cpus=1; mem=524; > ports=[31000-32000]; disk=21412 unused on slave > 201306240256-143311683-38688-32750-0 > I0624 02:56:23.668339 361 slave.cpp:838] Launching task 0 for framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.668431 365 hierarchical_allocator_process.hpp:569] > Framework 201306240256-143311683-38688-32750-0000 filtered slave > 201306240256-143311683-38688-32750-0 for 5secs > I0624 02:56:23.669816 361 paths.hpp:303] Created executor directory > '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_IeIOKu/slaves/201306240256-143311683-38688-32750-0/frameworks/201306240256-143311683-38688-32750-0000/executors/default/runs/b1f572e9-09f7-4d1a-84f9-6e3b6e1cef32' > I0624 02:56:23.670011 361 slave.cpp:949] Queuing task '0' for executor > default of framework '201306240256-143311683-38688-32750-0000 > I0624 02:56:23.670140 362 slave.cpp:522] Successfully attached file > '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_IeIOKu/slaves/201306240256-143311683-38688-32750-0/frameworks/201306240256-143311683-38688-32750-0000/executors/default/runs/b1f572e9-09f7-4d1a-84f9-6e3b6e1cef32' > I0624 02:56:23.670181 364 exec.cpp:170] Executor started at: > executor(38)@67.195.138.8:38688 with pid 32750 > I0624 02:56:23.670282 364 slave.cpp:1396] Got registration for executor > 'default' of framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.670501 364 slave.cpp:1511] Flushing queued task 0 for > executor 'default' of framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.670537 365 exec.cpp:194] Executor registered on slave > 201306240256-143311683-38688-32750-0 > I0624 02:56:23.670689 365 exec.cpp:258] Executor asked to run task '0' > I0624 02:56:23.671896 365 exec.cpp:404] Executor sending status update > TASK_RUNNING (UUID: 7fa460fb-cd17-4f97-95be-f9f930f9d7af) for task 0 of > framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.671982 365 slave.cpp:1693] Handling status update > TASK_RUNNING (UUID: 7fa460fb-cd17-4f97-95be-f9f930f9d7af) for task 0 of > framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.672108 365 status_update_manager.cpp:290] Received status > update TASK_RUNNING (UUID: 7fa460fb-cd17-4f97-95be-f9f930f9d7af) for task 0 > of framework 201306240256-143311683-38688-32750-0000 with checkpoint=false > I0624 02:56:23.672145 365 status_update_manager.cpp:450] Creating > StatusUpdate stream for task 0 of framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.672266 365 status_update_manager.cpp:336] Forwarding > status update TASK_RUNNING (UUID: 7fa460fb-cd17-4f97-95be-f9f930f9d7af) for > task 0 of framework 201306240256-143311683-38688-32750-0000 to > [email protected]:38688 > I0624 02:56:23.672366 359 master.cpp:1022] Status update from slave(100)@ > 67.195.138.8:38688: task 0 of framework > 201306240256-143311683-38688-32750-0000 is now in state TASK_RUNNING > I0624 02:56:23.672377 365 slave.cpp:1804] Status update manager > successfully handled status update TASK_RUNNING (UUID: > 7fa460fb-cd17-4f97-95be-f9f930f9d7af) for task 0 of framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.672459 365 slave.cpp:1810] Sending acknowledgement for > status update TASK_RUNNING (UUID: 7fa460fb-cd17-4f97-95be-f9f930f9d7af) for > task 0 of framework 201306240256-143311683-38688-32750-0000 to executor(38)@ > 67.195.138.8:38688 > I0624 02:56:23.672549 364 exec.cpp:290] Executor received status update > acknowledgement 7fa460fb-cd17-4f97-95be-f9f930f9d7af for task 0 of > framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.672904 32750 master.cpp:385] Master terminating > I0624 02:56:23.673005 32750 master.cpp:207] Shutting down master > I0624 02:56:23.673106 360 hierarchical_allocator_process.hpp:412] > Deactivated framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.673105 359 slave.cpp:1885] [email protected]:38688exited > I0624 02:56:23.673115 32750 master.hpp:303] Removing task 0 with resources > cpus=1; mem=500 on slave 201306240256-143311683-38688-32750-0 > I0624 02:56:23.673218 361 status_update_manager.cpp:360] Received status > update acknowledgement 7fa460fb-cd17-4f97-95be-f9f930f9d7af for task 0 of > framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.673495 364 hierarchical_allocator_process.hpp:616] > Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; > ports=[31000-32000]; disk=21412) on slave > 201306240256-143311683-38688-32750-0 from framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.673647 364 hierarchical_allocator_process.hpp:367] > Removed framework 201306240256-143311683-38688-32750-0000 > W0624 02:56:23.673269 359 slave.cpp:1888] Master disconnected! Waiting > for a new master to be elected > I0624 02:56:23.673795 359 slave.cpp:1113] Asked to shut down framework > 201306240256-143311683-38688-32750-0000 by [email protected]:38688 > I0624 02:56:23.673841 359 slave.cpp:1138] Shutting down framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.673912 359 slave.cpp:2329] Shutting down executor > 'default' of framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.674012 360 exec.cpp:323] Executor asked to shutdown > I0624 02:56:23.674031 359 slave.cpp:1344] Status update manager > successfully handled status update acknowledgement > 7fa460fb-cd17-4f97-95be-f9f930f9d7af for task 0 of framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:23.674435 361 master.cpp:228] Master started on > 67.195.138.8:38688 > I0624 02:56:23.674537 361 master.cpp:243] Master ID: > 201306240256-143311683-38688-32750 > W0624 02:56:23.674736 364 master.cpp:83] No whitelist given. Advertising > offers for all slaves > I0624 02:56:23.674864 364 hierarchical_allocator_process.hpp:295] > Initializing hierarchical allocator process with master : > [email protected]:38688 > I0624 02:56:23.676785 365 detector.cpp:234] Master detector ( > [email protected]:38688) connected to ZooKeeper ... > I0624 02:56:23.676826 365 detector.cpp:251] Trying to create path > '/znode' in ZooKeeper > I0624 02:56:23.677002 361 detector.cpp:420] Master detector > (scheduler(91)@67.195.138.8:38688) found 0 registered masters > I0624 02:56:23.677157 363 detector.cpp:420] Master detector (slave(100)@ > 67.195.138.8:38688) found 0 registered masters > I0624 02:56:23.681741 361 detector.cpp:441] Master detector > (scheduler(91)@67.195.138.8:38688) couldn't find any masters > I0624 02:56:23.681865 363 detector.cpp:441] Master detector (slave(100)@ > 67.195.138.8:38688) couldn't find any masters > I0624 02:56:23.682023 364 sched.cpp:194] No master detected, waiting for > another master > I0624 02:56:23.682076 363 slave.cpp:574] Lost master(s) ... waiting > I0624 02:56:23.683306 365 detector.cpp:281] Created ephemeral/sequence > znode at '/znode/0000000006' > I0624 02:56:23.683697 364 detector.cpp:420] Master detector > (scheduler(91)@67.195.138.8:38688) found 1 registered masters > I0624 02:56:23.683799 359 detector.cpp:420] Master detector (slave(100)@ > 67.195.138.8:38688) found 1 registered masters > I0624 02:56:23.683974 365 detector.cpp:420] Master detector ( > [email protected]:38688) found 1 registered masters > I0624 02:56:23.690341 364 detector.cpp:467] Master detector > (scheduler(91)@67.195.138.8:38688) got new master pid: > [email protected]:38688 > I0624 02:56:23.690464 365 detector.cpp:467] Master detector ( > [email protected]:38688) got new master pid: [email protected]:38688 > I0624 02:56:23.690594 366 sched.cpp:177] New master at > [email protected]:38688 > I0624 02:56:23.690630 365 master.cpp:526] Elected as master! > I0624 02:56:23.690712 359 detector.cpp:467] Master detector (slave(100)@ > 67.195.138.8:38688) got new master pid: [email protected]:38688 > I0624 02:56:23.690883 359 slave.cpp:540] New master detected at > [email protected]:38688 > I0624 02:56:23.690969 364 status_update_manager.cpp:155] New master > detected at [email protected]:38688 > I0624 02:56:23.691123 361 master.cpp:963] Attempting to re-register > slave 201306240256-143311683-38688-32750-0 at slave(100)@ > 67.195.138.8:38688 (minerva.apache.org) > I0624 02:56:23.691198 361 master.cpp:1851] Adding slave > 201306240256-143311683-38688-32750-0 at minerva.apache.org with cpus=2; > mem=1024; ports=[31000-32000]; disk=21412 > I0624 02:56:23.691357 360 slave.cpp:636] Re-registered with master > [email protected]:38688 > I0624 02:56:23.691403 361 master.hpp:291] Adding task 0 with resources > cpus=1; mem=500 on slave 201306240256-143311683-38688-32750-0 > W0624 02:56:23.691514 361 master.cpp:1943] Possibly orphaned task 0 of > framework 201306240256-143311683-38688-32750-0000 running on slave > 201306240256-143311683-38688-32750-0 (minerva.apache.org) > I0624 02:56:23.691826 361 hierarchical_allocator_process.hpp:449] Added > slave 201306240256-143311683-38688-32750-0 (minerva.apache.org) with > cpus=2; mem=1024; ports=[31000-32000]; disk=21412 (and cpus=1; mem=524; > ports=[31000-32000]; disk=21412 available) > I0624 02:56:23.691897 361 hierarchical_allocator_process.hpp:700] No > users to allocate resources! > I0624 02:56:23.691958 361 hierarchical_allocator_process.hpp:687] > Performed allocation for slave 201306240256-143311683-38688-32750-0 in > 62.218us > I0624 02:56:24.667089 360 master.cpp:604] Re-registering framework > 201306240256-143311683-38688-32750-0000 at scheduler(91)@ > 67.195.138.8:38688 > I0624 02:56:24.667274 361 sched.cpp:246] Framework re-registered with > 201306240256-143311683-38688-32750-0000 > W0624 02:56:24.667314 360 slave.cpp:1274] Ignoring updating pid for > framework 201306240256-143311683-38688-32750-0000 because it is terminating > I0624 02:56:24.667404 361 hierarchical_allocator_process.hpp:327] Added > framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:24.667486 361 hierarchical_allocator_process.hpp:727] > Offering cpus=1; mem=524; ports=[31000-32000]; disk=21412 on slave > 201306240256-143311683-38688-32750-0 to framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:24.667644 361 hierarchical_allocator_process.hpp:667] > Performed allocation for 1 slaves in 182.051us > I0624 02:56:24.667722 359 master.hpp:313] Adding offer > 201306240256-143311683-38688-32750-0 with resources cpus=1; mem=524; > ports=[31000-32000]; disk=21412 on slave > 201306240256-143311683-38688-32750-0 > I0624 02:56:24.667847 359 master.cpp:1239] Sending 1 offers to framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:24.668225 365 sched.cpp:427] Stopping framework > '201306240256-143311683-38688-32750-0000' > I0624 02:56:24.668233 32750 master.cpp:385] Master terminating > I0624 02:56:24.668419 363 slave.cpp:496] Slave asked to shut down by > [email protected]:38688 > I0624 02:56:24.668442 32750 master.cpp:207] Shutting down master > I0624 02:56:24.668488 363 slave.cpp:1113] Asked to shut down framework > 201306240256-143311683-38688-32750-0000 by [email protected]:38688 > W0624 02:56:24.668658 363 slave.cpp:1134] Ignoring shutdown framework > 201306240256-143311683-38688-32750-0000 because it is terminating > I0624 02:56:24.668687 365 hierarchical_allocator_process.hpp:412] > Deactivated framework 201306240256-143311683-38688-32750-0000 > I0624 02:56:24.668709 32750 master.hpp:303] Removing task 0 with resources > cpus=1; mem=500 on slave 201306240256-143311683-38688-32750-0 > I0624 02:56:24.668727 363 slave.cpp:1885] [email protected]:38688exited > W0624 02:56:24.668942 363 slave.cpp:1888] Master disconnected! Waiting > for a new master to be elected > I0624 02:56:24.669025 32750 master.hpp:323] Removing offer > 201306240256-143311683-38688-32750-0 with resources cpus=1; mem=524; > ports=[31000-32000]; disk=21412 on slave > 201306240256-143311683-38688-32750-0 > I0624 02:56:24.669117 364 hierarchical_allocator_process.hpp:616] > Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; > disk=0) on slave 201306240256-143311683-38688-32750-0 from framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:24.673924 364 hierarchical_allocator_process.hpp:616] > Recovered cpus=1; mem=524; ports=[31000-32000]; disk=21412 (total > allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=21412) on slave > 201306240256-143311683-38688-32750-0 from framework > 201306240256-143311683-38688-32750-0000 > I0624 02:56:24.673671 363 slave.cpp:1113] Asked to shut down framework > 201306240256-143311683-38688-32750-0000 by [email protected]:38688 > I0624 02:56:24.674079 364 hierarchical_allocator_process.hpp:367] > Removed framework 201306240256-143311683-38688-32750-0000 > W0624 02:56:24.674147 363 slave.cpp:1134] Ignoring shutdown framework > 201306240256-143311683-38688-32750-0000 because it is terminating > I0624 02:56:24.674300 364 hierarchical_allocator_process.hpp:477] > Removed slave 201306240256-143311683-38688-32750-0 > I0624 02:56:24.674546 359 slave.cpp:451] Slave terminating > I0624 02:56:24.674640 359 slave.cpp:1113] Asked to shut down framework > 201306240256-143311683-38688-32750-0000 by @0.0.0.0:0 > W0624 02:56:24.674692 359 slave.cpp:1134] Ignoring shutdown framework > 201306240256-143311683-38688-32750-0000 because it is terminating > I0624 02:56:24.675195 366 hierarchical_allocator_process.hpp:700] No > users to allocate resources! > I0624 02:56:24.675245 366 hierarchical_allocator_process.hpp:667] > Performed allocation for 0 slaves in 73.116us > [ OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (2035 ms) > I0624 02:56:24.683157 32750 zookeeper_test_server.cpp:93] Shutdown > ZooKeeperTestServer on port 37698 > [----------] 2 tests from AllocatorZooKeeperTest/0 (4091 ms total) > > [----------] Global test environment tear-down > [==========] 196 tests from 37 test cases ran. (130888 ms total) > [ PASSED ] 194 tests. > [ FAILED ] 2 tests, listed below: > [ FAILED ] > ZooKeeperMasterDetectorTest.MasterDetectorExpireSlaveZKSessionNewMaster > [ FAILED ] AllocatorTest/0.SchedulerFailover, where TypeParam = > mesos::internal::master::allocator::HierarchicalAllocatorProcess<mesos::internal::master::allocator::DRFSorter, > mesos::internal::master::allocator::DRFSorter> > > 2 FAILED TESTS > make[3]: *** [check-local] Error 1 > make[3]: Leaving directory `< > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/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-Set-JAVA_HOME/ws/build/src > '> > make[1]: *** [check] Error 2 > make[1]: Leaving directory `< > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/src > '> > make: *** [check-recursive] Error 1 > Build step 'Execute shell' marked build as failure >
