https://issues.apache.org/jira/browse/MESOS-403
On Tue, Aug 6, 2013 at 2:53 PM, Apache Jenkins Server < jenk...@builds.apache.org> wrote: > See < > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/1564/changes > > > > Changes: > > [bmahler] Fixed process::collect to handle an empty list. > > ------------------------------------------ > [...truncated 19209 lines...] > I0806 21:53:38.679910 10815 slave.cpp:1821] Sending acknowledgement for > status update TASK_RUNNING (UUID: c1ba21a5-00dc-4756-b439-d01fa14534cd) for > task 0 of framework 201308062153-160088899-39900-10792-0000 to executor(39)@ > 67.195.138.9:39900 > I0806 21:53:38.672288 10792 master.cpp:446] Master terminating > I0806 21:53:38.672008 10818 sched.cpp:395] Scheduler::statusUpdate took > 14.152us > I0806 21:53:38.687922 10816 exec.cpp:320] Executor received status update > acknowledgement c1ba21a5-00dc-4756-b439-d01fa14534cd for task 0 of > framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:38.695842 10792 master.cpp:209] Shutting down master > I0806 21:53:38.695914 10815 slave.cpp:1896] master@67.195.138.9:39900exited > W0806 21:53:38.727736 10815 slave.cpp:1899] Master disconnected! Waiting > for a new master to be elected > I0806 21:53:38.719817 10817 hierarchical_allocator_process.hpp:393] > Deactivated framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:38.719799 10792 master.hpp:321] Removing task 0 with resources > cpus(*):1; mem(*):500 on slave 201308062153-160088899-39900-10792-0 > I0806 21:53:38.751782 10811 hierarchical_allocator_process.hpp:595] > Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):2; mem(*):1024; > disk(*):763099; ports(*):[31000-32000]) on slave > 201308062153-160088899-39900-10792-0 from framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:38.735823 10814 status_update_manager.cpp:362] Received status > update acknowledgement (UUID: c1ba21a5-00dc-4756-b439-d01fa14534cd) for > task 0 of framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:38.735754 10815 slave.cpp:1140] Asked to shut down framework > 201308062153-160088899-39900-10792-0000 by master@67.195.138.9:39900 > I0806 21:53:38.813009 10815 slave.cpp:1165] Shutting down framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:38.797780 10814 detector.cpp:234] Master detector ( > master@67.195.138.9:39900) connected to ZooKeeper ... > I0806 21:53:38.797996 10813 detector.cpp:420] Master detector (slave(111)@ > 67.195.138.9:39900) found 0 registered masters > I0806 21:53:38.836930 10813 detector.cpp:441] Master detector (slave(111)@ > 67.195.138.9:39900) couldn't find any masters > I0806 21:53:38.760412 10817 master.cpp:230] Master started on > 67.195.138.9:39900 > I0806 21:53:38.852861 10817 master.cpp:245] Master ID: > 201308062153-160088899-39900-10792 > I0806 21:53:38.828958 10814 detector.cpp:251] Trying to create path > '/znode' in ZooKeeper > I0806 21:53:38.798109 10816 detector.cpp:420] Master detector > (scheduler(101)@67.195.138.9:39900) found 0 registered masters > I0806 21:53:38.820945 10815 slave.cpp:2340] Shutting down executor > 'default' of framework 201308062153-160088899-39900-10792-0000 > W0806 21:53:38.860939 10818 master.cpp:83] No whitelist given. Advertising > offers for all slaves > I0806 21:53:38.861146 10813 hierarchical_allocator_process.hpp:287] > Initializing hierarchical allocator process with master : > master@67.195.138.9:39900 > I0806 21:53:38.876780 10816 detector.cpp:441] Master detector > (scheduler(101)@67.195.138.9:39900) couldn't find any masters > I0806 21:53:38.885349 10814 detector.cpp:281] Created ephemeral/sequence > znode at '/znode/0000000002' > I0806 21:53:38.885678 10817 detector.cpp:420] Master detector (slave(111)@ > 67.195.138.9:39900) found 1 registered masters > I0806 21:53:38.896761 10812 exec.cpp:360] Executor asked to shutdown > I0806 21:53:38.896774 10815 slave.cpp:1359] Status update manager > successfully handled status update acknowledgement (UUID: > c1ba21a5-00dc-4756-b439-d01fa14534cd) for task 0 of framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:38.920711 10811 sched.cpp:202] No master detected, waiting for > another master > I0806 21:53:38.960542 10811 sched.cpp:214] Scheduler::disconnected took > 12.661us > I0806 21:53:38.929191 10814 detector.cpp:420] Master detector ( > master@67.195.138.9:39900) found 1 registered masters > I0806 21:53:38.937118 10817 detector.cpp:467] Master detector (slave(111)@ > 67.195.138.9:39900) got new master pid: master@67.195.138.9:39900 > I0806 21:53:38.944591 10812 exec.cpp:375] Executor::shutdown took 11.975us > I0806 21:53:38.952564 10815 slave.cpp:571] Lost master(s) ... waiting > I0806 21:53:39.000426 10815 slave.cpp:537] New master detected at > master@67.195.138.9:39900 > I0806 21:53:38.977018 10814 detector.cpp:467] Master detector ( > master@67.195.138.9:39900) got new master pid: master@67.195.138.9:39900 > I0806 21:53:38.921226 10816 detector.cpp:420] Master detector > (scheduler(101)@67.195.138.9:39900) found 1 registered masters > I0806 21:53:39.008401 10813 status_update_manager.cpp:157] New master > detected at master@67.195.138.9:39900 > I0806 21:53:39.016435 10817 master.cpp:593] Elected as master! > I0806 21:53:39.024863 10816 detector.cpp:467] Master detector > (scheduler(101)@67.195.138.9:39900) got new master pid: > master@67.195.138.9:39900 > I0806 21:53:39.048288 10816 sched.cpp:178] New master at > master@67.195.138.9:39900 > I0806 21:53:39.056246 10814 master.cpp:685] Re-registering framework > 201308062153-160088899-39900-10792-0000 at scheduler(101)@ > 67.195.138.9:39900 > I0806 21:53:39.064313 10816 sched.cpp:268] Framework re-registered with > 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.064402 10814 hierarchical_allocator_process.hpp:317] Added > framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.072168 10816 sched.cpp:282] Scheduler::reregistered took > 11.145us > I0806 21:53:39.080169 10814 hierarchical_allocator_process.hpp:684] No > resources available to allocate! > I0806 21:53:39.096081 10814 hierarchical_allocator_process.hpp:646] > Performed allocation for 0 slaves in 15.910633ms > I0806 21:53:39.285725 10817 master.cpp:1044] Attempting to re-register > slave 201308062153-160088899-39900-10792-0 at slave(111)@ > 67.195.138.9:39900 (vesta.apache.org) > I0806 21:53:39.285877 10817 master.cpp:1951] Adding slave > 201308062153-160088899-39900-10792-0 at vesta.apache.org with cpus(*):2; > mem(*):1024; disk(*):763099; ports(*):[31000-32000] > I0806 21:53:39.293973 10815 slave.cpp:638] Re-registered with master > master@67.195.138.9:39900 > I0806 21:53:39.294003 10817 master.hpp:309] Adding task 0 with resources > cpus(*):1; mem(*):500 on slave 201308062153-160088899-39900-10792-0 > W0806 21:53:39.310000 10817 slave.cpp:1301] Ignoring updating pid for > framework 201308062153-160088899-39900-10792-0000 because it is terminating > I0806 21:53:39.310204 10815 hierarchical_allocator_process.hpp:430] Added > slave 201308062153-160088899-39900-10792-0 (vesta.apache.org) with > cpus(*):2; mem(*):1024; disk(*):763099; ports(*):[31000-32000] (and > cpus(*):1; mem(*):524; disk(*):763099; ports(*):[31000-32000] available) > I0806 21:53:39.325849 10815 hierarchical_allocator_process.hpp:709] > Offering cpus(*):1; mem(*):524; disk(*):763099; ports(*):[31000-32000] on > slave 201308062153-160088899-39900-10792-0 to framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.333868 10815 hierarchical_allocator_process.hpp:666] > Performed allocation for slave 201308062153-160088899-39900-10792-0 in > 8.078616ms > I0806 21:53:39.333926 10818 master.hpp:331] Adding offer > 201308062153-160088899-39900-10792-0 with resources cpus(*):1; mem(*):524; > disk(*):763099; ports(*):[31000-32000] on slave > 201308062153-160088899-39900-10792-0 > I0806 21:53:39.349730 10818 master.cpp:1332] Sending 1 offers to framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.357789 10812 sched.cpp:340] Scheduler::resourceOffers took > 21.545us > I0806 21:53:39.357961 10792 master.cpp:446] Master terminating > I0806 21:53:39.373661 10811 slave.cpp:493] Slave asked to shut down by > master@67.195.138.9:39900 > I0806 21:53:39.381598 10811 slave.cpp:1140] Asked to shut down framework > 201308062153-160088899-39900-10792-0000 by master@67.195.138.9:39900 > W0806 21:53:39.389554 10811 slave.cpp:1161] Ignoring shutdown framework > 201308062153-160088899-39900-10792-0000 because it is terminating > I0806 21:53:39.397521 10811 slave.cpp:1896] master@67.195.138.9:39900exited > W0806 21:53:39.405499 10811 slave.cpp:1899] Master disconnected! Waiting > for a new master to be elected > I0806 21:53:39.373666 10792 master.cpp:209] Shutting down master > I0806 21:53:39.421531 10818 slave.cpp:1140] Asked to shut down framework > 201308062153-160088899-39900-10792-0000 by master@67.195.138.9:39900 > W0806 21:53:39.429426 10818 slave.cpp:1161] Ignoring shutdown framework > 201308062153-160088899-39900-10792-0000 because it is terminating > I0806 21:53:39.365700 10812 sched.cpp:498] Stopping framework > '201308062153-160088899-39900-10792-0000' > I0806 21:53:39.421567 10816 hierarchical_allocator_process.hpp:393] > Deactivated framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.421536 10792 master.hpp:321] Removing task 0 with resources > cpus(*):1; mem(*):500 on slave 201308062153-160088899-39900-10792-0 > I0806 21:53:39.471052 10792 master.hpp:341] Removing offer > 201308062153-160088899-39900-10792-0 with resources cpus(*):1; mem(*):524; > disk(*):763099; ports(*):[31000-32000] on slave > 201308062153-160088899-39900-10792-0 > I0806 21:53:39.471210 10811 hierarchical_allocator_process.hpp:595] > Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):1; mem(*):500) > on slave 201308062153-160088899-39900-10792-0 from framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.479722 10812 slave.cpp:448] Slave terminating > I0806 21:53:39.502847 10812 slave.cpp:1140] Asked to shut down framework > 201308062153-160088899-39900-10792-0000 by @0.0.0.0:0 > I0806 21:53:39.491576 10814 detector.cpp:420] Master detector (slave(111)@ > 67.195.138.9:39900) found 0 registered masters > I0806 21:53:39.487005 10811 hierarchical_allocator_process.hpp:595] > Recovered cpus(*):1; mem(*):524; disk(*):763099; ports(*):[31000-32000] > (total allocatable: cpus(*):2; mem(*):1024; disk(*):763099; > ports(*):[31000-32000]) on slave 201308062153-160088899-39900-10792-0 from > framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.526810 10811 hierarchical_allocator_process.hpp:348] > Removed framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.534826 10811 hierarchical_allocator_process.hpp:456] > Removed slave 201308062153-160088899-39900-10792-0 > W0806 21:53:39.510803 10812 slave.cpp:1161] Ignoring shutdown framework > 201308062153-160088899-39900-10792-0000 because it is terminating > I0806 21:53:39.518797 10814 detector.cpp:441] Master detector (slave(111)@ > 67.195.138.9:39900) couldn't find any masters > [ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (1751 ms) > [ RUN ] AllocatorZooKeeperTest/0.SlaveReregistersFirst > 2013-08-06 21:53:39,562:10792(0x2ae0f27a5700):ZOO_INFO@log_env@658: > Client environment:zookeeper.version=zookeeper C client 3.3.4 > 2013-08-06 21:53:39,562:10792(0x2ae0f27a5700):ZOO_INFO@log_env@662: > Client environment:host.name=vesta.apache.org > 2013-08-06 21:53:39,562:10792(0x2ae0f27a5700):ZOO_INFO@log_env@669: > Client environment:os.name=Linux > 2013-08-06 21:53:39,562:10792(0x2ae0f27a5700):ZOO_INFO@log_env@670: > Client environment:os.arch=3.2.0-51-generic > 2013-08-06 21:53:39,562:10792(0x2ae0f27a5700):ZOO_INFO@log_env@671: > Client environment:os.version=#77-Ubuntu SMP Wed Jul 24 20:18:19 UTC 2013 > 2013-08-06 21:53:39,562:10792(0x2ae0f27a5700):ZOO_INFO@log_env@679: > Client environment:user.name=(null) > I0806 21:53:39.561928 10816 master.cpp:230] Master started on > 67.195.138.9:39900 > I0806 21:53:39.562510 10814 slave.cpp:113] Slave started on 112)@ > 67.195.138.9:39900 > I0806 21:53:39.592993 10814 slave.cpp:213] Slave resources: cpus(*):2; > mem(*):1024; disk(*):763099; ports(*):[31000-32000] > I0806 21:53:39.583091 10815 detector.cpp:234] Master detector ( > master@67.195.138.9:39900) connected to ZooKeeper ... > I0806 21:53:39.583621 10818 detector.cpp:234] Master detector (slave(112)@ > 67.195.138.9:39900) connected to ZooKeeper ... > I0806 21:53:39.616822 10818 detector.cpp:251] Trying to create path > '/znode' in ZooKeeper > I0806 21:53:39.568990 10816 master.cpp:245] Master ID: > 201308062153-160088899-39900-10792 > I0806 21:53:39.601562 10814 slave.cpp:398] Finished recovery > I0806 21:53:39.608856 10815 detector.cpp:251] Trying to create path > '/znode' in ZooKeeper > I0806 21:53:39.584106 10812 detector.cpp:234] Master detector > (scheduler(102)@67.195.138.9:39900) connected to ZooKeeper ... > I0806 21:53:39.625901 10818 detector.cpp:420] Master detector (slave(112)@ > 67.195.138.9:39900) found 0 registered masters > W0806 21:53:39.632902 10817 master.cpp:83] No whitelist given. Advertising > offers for all slaves > I0806 21:53:39.632899 10813 hierarchical_allocator_process.hpp:287] > Initializing hierarchical allocator process with master : > master@67.195.138.9:39900 > I0806 21:53:39.656692 10812 detector.cpp:251] Trying to create path > '/znode' in ZooKeeper > I0806 21:53:39.662647 10815 detector.cpp:281] Created ephemeral/sequence > znode at '/znode/0000000004' > I0806 21:53:39.674341 10818 detector.cpp:441] Master detector (slave(112)@ > 67.195.138.9:39900) couldn't find any masters > I0806 21:53:39.716505 10811 slave.cpp:571] Lost master(s) ... waiting > I0806 21:53:39.709061 10815 detector.cpp:420] Master detector ( > master@67.195.138.9:39900) found 1 registered masters > I0806 21:53:39.701627 10812 detector.cpp:420] Master detector > (scheduler(102)@67.195.138.9:39900) found 1 registered masters > I0806 21:53:39.716966 10818 detector.cpp:420] Master detector (slave(112)@ > 67.195.138.9:39900) found 1 registered masters > I0806 21:53:39.732902 10815 detector.cpp:467] Master detector ( > master@67.195.138.9:39900) got new master pid: master@67.195.138.9:39900 > I0806 21:53:39.740938 10812 detector.cpp:467] Master detector > (scheduler(102)@67.195.138.9:39900) got new master pid: > master@67.195.138.9:39900 > I0806 21:53:39.748831 10818 detector.cpp:467] Master detector (slave(112)@ > 67.195.138.9:39900) got new master pid: master@67.195.138.9:39900 > I0806 21:53:39.772341 10818 slave.cpp:537] New master detected at > master@67.195.138.9:39900 > I0806 21:53:39.780303 10813 status_update_manager.cpp:157] New master > detected at master@67.195.138.9:39900 > I0806 21:53:39.756407 10815 master.cpp:593] Elected as master! > I0806 21:53:39.796247 10815 master.cpp:972] Attempting to register slave > on vesta.apache.org at slave(112)@67.195.138.9:39900 > I0806 21:53:39.804170 10815 master.cpp:1951] Adding slave > 201308062153-160088899-39900-10792-0 at vesta.apache.org with cpus(*):2; > mem(*):1024; disk(*):763099; ports(*):[31000-32000] > I0806 21:53:39.812202 10811 slave.cpp:597] Registered with master > master@67.195.138.9:39900; given slave ID > 201308062153-160088899-39900-10792-0 > I0806 21:53:39.764384 10812 sched.cpp:178] New master at > master@67.195.138.9:39900 > I0806 21:53:39.812315 10813 hierarchical_allocator_process.hpp:430] Added > slave 201308062153-160088899-39900-10792-0 (vesta.apache.org) with > cpus(*):2; mem(*):1024; disk(*):763099; ports(*):[31000-32000] (and > cpus(*):2; mem(*):1024; disk(*):763099; ports(*):[31000-32000] available) > I0806 21:53:39.836096 10813 hierarchical_allocator_process.hpp:666] > Performed allocation for slave 201308062153-160088899-39900-10792-0 in > 6.61us > I0806 21:53:39.828189 10812 master.cpp:643] Registering framework > 201308062153-160088899-39900-10792-0000 at scheduler(102)@ > 67.195.138.9:39900 > I0806 21:53:39.852082 10812 sched.cpp:237] Framework registered with > 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.860014 10812 sched.cpp:251] Scheduler::registered took > 11.434us > I0806 21:53:39.852108 10811 hierarchical_allocator_process.hpp:317] Added > framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.875999 10811 hierarchical_allocator_process.hpp:709] > Offering cpus(*):2; mem(*):1024; disk(*):763099; ports(*):[31000-32000] on > slave 201308062153-160088899-39900-10792-0 to framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.884035 10811 hierarchical_allocator_process.hpp:646] > Performed allocation for 1 slaves in 8.087018ms > I0806 21:53:39.884094 10816 master.hpp:331] Adding offer > 201308062153-160088899-39900-10792-0 with resources cpus(*):2; mem(*):1024; > disk(*):763099; ports(*):[31000-32000] on slave > 201308062153-160088899-39900-10792-0 > I0806 21:53:39.899935 10816 master.cpp:1332] Sending 1 offers to framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.908114 10817 sched.cpp:340] Scheduler::resourceOffers took > 168.854us > I0806 21:53:39.915935 10817 master.cpp:1565] Processing reply for offer > 201308062153-160088899-39900-10792-0 on slave > 201308062153-160088899-39900-10792-0 (vesta.apache.org) for framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.923874 10817 master.hpp:309] Adding task 0 with resources > cpus(*):1; mem(*):500 on slave 201308062153-160088899-39900-10792-0 > I0806 21:53:39.931772 10817 master.cpp:1684] Launching task 0 of framework > 201308062153-160088899-39900-10792-0000 with resources cpus(*):1; > mem(*):500 on slave 201308062153-160088899-39900-10792-0 (vesta.apache.org > ) > I0806 21:53:39.939862 10817 master.hpp:341] Removing offer > 201308062153-160088899-39900-10792-0 with resources cpus(*):2; mem(*):1024; > disk(*):763099; ports(*):[31000-32000] on slave > 201308062153-160088899-39900-10792-0 > I0806 21:53:39.939900 10816 slave.cpp:747] Got assigned task 0 for > framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.939929 10818 hierarchical_allocator_process.hpp:505] > Framework 201308062153-160088899-39900-10792-0000 left cpus(*):1; > mem(*):524; disk(*):763099; ports(*):[31000-32000] unused on slave > 201308062153-160088899-39900-10792-0 > I0806 21:53:39.963767 10818 hierarchical_allocator_process.hpp:548] > Framework 201308062153-160088899-39900-10792-0000 filtered slave > 201308062153-160088899-39900-10792-0 for 5secs > I0806 21:53:39.955883 10816 slave.cpp:845] Launching task 0 for framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:39.981019 10816 paths.hpp:303] Created executor directory > '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_LPp7rV/slaves/201308062153-160088899-39900-10792-0/frameworks/201308062153-160088899-39900-10792-0000/executors/default/runs/01be6ad6-2663-4a0e-8256-5a0b79ecdb04' > I0806 21:53:39.987709 10816 slave.cpp:956] Queuing task '0' for executor > default of framework '201308062153-160088899-39900-10792-0000 > I0806 21:53:39.987871 10815 exec.cpp:171] Executor started at: > executor(40)@67.195.138.9:39900 with pid 10792 > I0806 21:53:39.995599 10816 slave.cpp:519] Successfully attached file > '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_LPp7rV/slaves/201308062153-160088899-39900-10792-0/frameworks/201308062153-160088899-39900-10792-0000/executors/default/runs/01be6ad6-2663-4a0e-8256-5a0b79ecdb04' > I0806 21:53:40.011566 10816 slave.cpp:1413] Got registration for executor > 'default' of framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.019556 10816 slave.cpp:1528] Flushing queued task 0 for > executor 'default' of framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.019582 10811 exec.cpp:195] Executor registered on slave > 201308062153-160088899-39900-10792-0 > I0806 21:53:40.035454 10811 exec.cpp:206] Executor::registered took > 13.338us > I0806 21:53:40.043476 10811 exec.cpp:274] Executor asked to run task '0' > I0806 21:53:40.051415 10811 exec.cpp:283] Executor::launchTask took > 21.385us > I0806 21:53:40.060520 10811 exec.cpp:464] Executor sending status update > TASK_RUNNING (UUID: b587f3b0-69dd-4e48-9be7-24ecddf6fdd1) for task 0 of > framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.067389 10811 slave.cpp:1710] Handling status update > TASK_RUNNING (UUID: b587f3b0-69dd-4e48-9be7-24ecddf6fdd1) for task 0 of > framework 201308062153-160088899-39900-10792-0000 from executor(40)@ > 67.195.138.9:39900 > I0806 21:53:40.075402 10811 status_update_manager.cpp:292] Received status > update TASK_RUNNING (UUID: b587f3b0-69dd-4e48-9be7-24ecddf6fdd1) for task 0 > of framework 201308062153-160088899-39900-10792-0000 with checkpoint=false > I0806 21:53:40.083282 10811 status_update_manager.cpp:452] Creating > StatusUpdate stream for task 0 of framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.091325 10811 status_update_manager.cpp:338] Forwarding > status update TASK_RUNNING (UUID: b587f3b0-69dd-4e48-9be7-24ecddf6fdd1) for > task 0 of framework 201308062153-160088899-39900-10792-0000 to > master@67.195.138.9:39900 > I0806 21:53:40.099304 10812 master.cpp:1103] Status update from slave(112)@ > 67.195.138.9:39900: task 0 of framework > 201308062153-160088899-39900-10792-0000 is now in state TASK_RUNNING > I0806 21:53:40.107313 10812 sched.cpp:395] Scheduler::statusUpdate took > 15.9us > I0806 21:53:40.099339 10811 slave.cpp:1815] Status update manager > successfully handled status update TASK_RUNNING (UUID: > b587f3b0-69dd-4e48-9be7-24ecddf6fdd1) for task 0 of framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.107597 10792 master.cpp:446] Master terminating > I0806 21:53:40.131189 10792 master.cpp:209] Shutting down master > I0806 21:53:40.139157 10818 hierarchical_allocator_process.hpp:393] > Deactivated framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.139163 10792 master.hpp:321] Removing task 0 with resources > cpus(*):1; mem(*):500 on slave 201308062153-160088899-39900-10792-0 > I0806 21:53:40.123153 10811 slave.cpp:1821] Sending acknowledgement for > status update TASK_RUNNING (UUID: b587f3b0-69dd-4e48-9be7-24ecddf6fdd1) for > task 0 of framework 201308062153-160088899-39900-10792-0000 to executor(40)@ > 67.195.138.9:39900 > I0806 21:53:40.155256 10815 hierarchical_allocator_process.hpp:595] > Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):2; mem(*):1024; > disk(*):763099; ports(*):[31000-32000]) on slave > 201308062153-160088899-39900-10792-0 from framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.163135 10817 exec.cpp:320] Executor received status update > acknowledgement b587f3b0-69dd-4e48-9be7-24ecddf6fdd1 for task 0 of > framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.163269 10811 slave.cpp:1896] master@67.195.138.9:39900exited > I0806 21:53:40.163270 10816 status_update_manager.cpp:362] Received status > update acknowledgement (UUID: b587f3b0-69dd-4e48-9be7-24ecddf6fdd1) for > task 0 of framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.171674 10814 master.cpp:230] Master started on > 67.195.138.9:39900 > I0806 21:53:40.230834 10814 master.cpp:245] Master ID: > 201308062153-160088899-39900-10792 > I0806 21:53:40.205026 10817 detector.cpp:234] Master detector ( > master@67.195.138.9:39900) connected to ZooKeeper ... > I0806 21:53:40.246727 10817 detector.cpp:251] Trying to create path > '/znode' in ZooKeeper > I0806 21:53:40.205327 10818 detector.cpp:420] Master detector > (scheduler(102)@67.195.138.9:39900) found 0 registered masters > I0806 21:53:40.262692 10818 detector.cpp:441] Master detector > (scheduler(102)@67.195.138.9:39900) couldn't find any masters > I0806 21:53:40.280541 10812 sched.cpp:202] No master detected, waiting for > another master > I0806 21:53:40.239076 10814 hierarchical_allocator_process.hpp:287] > Initializing hierarchical allocator process with master : > master@67.195.138.9:39900 > I0806 21:53:40.205204 10813 detector.cpp:420] Master detector (slave(112)@ > 67.195.138.9:39900) found 0 registered masters > I0806 21:53:40.306550 10813 detector.cpp:441] Master detector (slave(112)@ > 67.195.138.9:39900) couldn't find any masters > I0806 21:53:40.268620 10817 detector.cpp:281] Created ephemeral/sequence > znode at '/znode/0000000006' > W0806 21:53:40.238970 10815 master.cpp:83] No whitelist given. Advertising > offers for all slaves > I0806 21:53:40.281034 10818 detector.cpp:420] Master detector > (scheduler(102)@67.195.138.9:39900) found 1 registered masters > I0806 21:53:40.290599 10812 sched.cpp:214] Scheduler::disconnected took > 9.407us > W0806 21:53:40.194928 10811 slave.cpp:1899] Master disconnected! Waiting > for a new master to be elected > I0806 21:53:40.315060 10813 detector.cpp:420] Master detector (slave(112)@ > 67.195.138.9:39900) found 1 registered masters > I0806 21:53:40.323072 10817 detector.cpp:420] Master detector ( > master@67.195.138.9:39900) found 1 registered masters > I0806 21:53:40.338940 10818 detector.cpp:467] Master detector > (scheduler(102)@67.195.138.9:39900) got new master pid: > master@67.195.138.9:39900 > I0806 21:53:40.378389 10818 sched.cpp:178] New master at > master@67.195.138.9:39900 > I0806 21:53:40.362905 10813 detector.cpp:467] Master detector (slave(112)@ > 67.195.138.9:39900) got new master pid: master@67.195.138.9:39900 > I0806 21:53:40.370863 10817 detector.cpp:467] Master detector ( > master@67.195.138.9:39900) got new master pid: master@67.195.138.9:39900 > I0806 21:53:40.402283 10817 master.cpp:593] Elected as master! > I0806 21:53:40.354434 10811 slave.cpp:1140] Asked to shut down framework > 201308062153-160088899-39900-10792-0000 by master@67.195.138.9:39900 > I0806 21:53:40.418172 10811 slave.cpp:1165] Shutting down framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.426151 10811 slave.cpp:2340] Shutting down executor > 'default' of framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.434165 10814 exec.cpp:360] Executor asked to shutdown > I0806 21:53:40.442109 10814 exec.cpp:375] Executor::shutdown took 9.642us > I0806 21:53:40.434192 10811 slave.cpp:1359] Status update manager > successfully handled status update acknowledgement (UUID: > b587f3b0-69dd-4e48-9be7-24ecddf6fdd1) for task 0 of framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.458053 10811 slave.cpp:571] Lost master(s) ... waiting > I0806 21:53:40.466037 10811 slave.cpp:537] New master detected at > master@67.195.138.9:39900 > I0806 21:53:40.474058 10811 status_update_manager.cpp:157] New master > detected at master@67.195.138.9:39900 > I0806 21:53:40.474140 10812 master.cpp:1044] Attempting to re-register > slave 201308062153-160088899-39900-10792-0 at slave(112)@ > 67.195.138.9:39900 (vesta.apache.org) > I0806 21:53:40.489928 10812 master.cpp:1951] Adding slave > 201308062153-160088899-39900-10792-0 at vesta.apache.org with cpus(*):2; > mem(*):1024; disk(*):763099; ports(*):[31000-32000] > I0806 21:53:40.498000 10816 slave.cpp:638] Re-registered with master > master@67.195.138.9:39900 > I0806 21:53:40.498009 10812 master.hpp:309] Adding task 0 with resources > cpus(*):1; mem(*):500 on slave 201308062153-160088899-39900-10792-0 > W0806 21:53:40.513864 10812 master.cpp:2043] Possibly orphaned task 0 of > framework 201308062153-160088899-39900-10792-0000 running on slave > 201308062153-160088899-39900-10792-0 (vesta.apache.org) > I0806 21:53:40.522007 10812 hierarchical_allocator_process.hpp:430] Added > slave 201308062153-160088899-39900-10792-0 (vesta.apache.org) with > cpus(*):2; mem(*):1024; disk(*):763099; ports(*):[31000-32000] (and > cpus(*):1; mem(*):524; disk(*):763099; ports(*):[31000-32000] available) > I0806 21:53:40.529803 10812 hierarchical_allocator_process.hpp:666] > Performed allocation for slave 201308062153-160088899-39900-10792-0 in > 5.71us > I0806 21:53:40.829064 10818 master.cpp:685] Re-registering framework > 201308062153-160088899-39900-10792-0000 at scheduler(102)@ > 67.195.138.9:39900 > I0806 21:53:40.829289 10813 sched.cpp:268] Framework re-registered with > 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.856715 10813 sched.cpp:282] Scheduler::reregistered took > 11.311us > I0806 21:53:40.829403 10814 hierarchical_allocator_process.hpp:317] Added > framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.872731 10814 hierarchical_allocator_process.hpp:709] > Offering cpus(*):1; mem(*):524; disk(*):763099; ports(*):[31000-32000] on > slave 201308062153-160088899-39900-10792-0 to framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.880776 10814 hierarchical_allocator_process.hpp:646] > Performed allocation for 1 slaves in 8.086509ms > W0806 21:53:40.829319 10818 slave.cpp:1301] Ignoring updating pid for > framework 201308062153-160088899-39900-10792-0000 because it is terminating > I0806 21:53:40.880864 10812 master.hpp:331] Adding offer > 201308062153-160088899-39900-10792-0 with resources cpus(*):1; mem(*):524; > disk(*):763099; ports(*):[31000-32000] on slave > 201308062153-160088899-39900-10792-0 > I0806 21:53:40.904630 10812 master.cpp:1332] Sending 1 offers to framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.912722 10811 sched.cpp:340] Scheduler::resourceOffers took > 35.272us > I0806 21:53:40.912933 10792 master.cpp:446] Master terminating > I0806 21:53:40.928503 10792 master.cpp:209] Shutting down master > I0806 21:53:40.936547 10792 master.hpp:321] Removing task 0 with resources > cpus(*):1; mem(*):500 on slave 201308062153-160088899-39900-10792-0 > I0806 21:53:40.920613 10811 sched.cpp:498] Stopping framework > '201308062153-160088899-39900-10792-0000' > I0806 21:53:40.936553 10815 hierarchical_allocator_process.hpp:393] > Deactivated framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.928539 10817 slave.cpp:493] Slave asked to shut down by > master@67.195.138.9:39900 > I0806 21:53:40.944541 10792 master.hpp:341] Removing offer > 201308062153-160088899-39900-10792-0 with resources cpus(*):1; mem(*):524; > disk(*):763099; ports(*):[31000-32000] on slave > 201308062153-160088899-39900-10792-0 > I0806 21:53:40.960530 10815 hierarchical_allocator_process.hpp:595] > Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):1; mem(*):500) > on slave 201308062153-160088899-39900-10792-0 from framework > 201308062153-160088899-39900-10792-0000 > I0806 21:53:40.968474 10817 slave.cpp:1140] Asked to shut down framework > 201308062153-160088899-39900-10792-0000 by master@67.195.138.9:39900 > W0806 21:53:41.008223 10817 slave.cpp:1161] Ignoring shutdown framework > 201308062153-160088899-39900-10792-0000 because it is terminating > I0806 21:53:40.998486 10818 detector.cpp:420] Master detector (slave(112)@ > 67.195.138.9:39900) found 0 registered masters > I0806 21:53:40.992461 10815 hierarchical_allocator_process.hpp:595] > Recovered cpus(*):1; mem(*):524; disk(*):763099; ports(*):[31000-32000] > (total allocatable: cpus(*):2; mem(*):1024; disk(*):763099; > ports(*):[31000-32000]) on slave 201308062153-160088899-39900-10792-0 from > framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:41.016188 10817 slave.cpp:448] Slave terminating > I0806 21:53:41.024170 10818 detector.cpp:441] Master detector (slave(112)@ > 67.195.138.9:39900) couldn't find any masters > I0806 21:53:41.032166 10815 hierarchical_allocator_process.hpp:348] > Removed framework 201308062153-160088899-39900-10792-0000 > I0806 21:53:41.040096 10817 slave.cpp:1140] Asked to shut down framework > 201308062153-160088899-39900-10792-0000 by @0.0.0.0:0 > W0806 21:53:41.064018 10817 slave.cpp:1161] Ignoring shutdown framework > 201308062153-160088899-39900-10792-0000 because it is terminating > I0806 21:53:41.056123 10815 hierarchical_allocator_process.hpp:456] > Removed slave 201308062153-160088899-39900-10792-0 > [ OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (1519 ms) > I0806 21:53:41.085932 10792 zookeeper_test_server.cpp:93] Shutdown > ZooKeeperTestServer on port 41581 > [----------] 2 tests from AllocatorZooKeeperTest/0 (3270 ms total) > > [----------] Global test environment tear-down > [==========] 210 tests from 38 test cases ran. (429587 ms total) > [ PASSED ] 209 tests. > [ FAILED ] 1 test, listed below: > [ FAILED ] CoordinatorTest.TruncateLearnedFill > > 1 FAILED TEST > make[3]: *** [check-local] Error 1 > make[3]: Leaving directory > `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/src' > make[2]: *** [check-am] Error 2 > make[2]: Leaving directory > `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/src' > make[1]: *** [check] Error 2 > make[1]: Leaving directory > `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/src' > make: *** [check-recursive] Error 1 > Build step 'Execute shell' marked build as failure >
