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] [email protected]:39900 exited 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 [email protected]: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 ([email protected]: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 : [email protected]: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 ([email protected]: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: [email protected]: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 [email protected]:39900 I0806 21:53:38.977018 10814 detector.cpp:467] Master detector ([email protected]:39900) got new master pid: [email protected]: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 [email protected]: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: [email protected]:39900 I0806 21:53:39.048288 10816 sched.cpp:178] New master at [email protected]: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 [email protected]: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 [email protected]:39900 I0806 21:53:39.381598 10811 slave.cpp:1140] Asked to shut down framework 201308062153-160088899-39900-10792-0000 by [email protected]: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] [email protected]:39900 exited 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 [email protected]: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 ([email protected]: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 : [email protected]: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 ([email protected]: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 ([email protected]:39900) got new master pid: [email protected]:39900 I0806 21:53:39.740938 10812 detector.cpp:467] Master detector (scheduler(102)@67.195.138.9:39900) got new master pid: [email protected]:39900 I0806 21:53:39.748831 10818 detector.cpp:467] Master detector (slave(112)@67.195.138.9:39900) got new master pid: [email protected]:39900 I0806 21:53:39.772341 10818 slave.cpp:537] New master detected at [email protected]:39900 I0806 21:53:39.780303 10813 status_update_manager.cpp:157] New master detected at [email protected]: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 [email protected]:39900; given slave ID 201308062153-160088899-39900-10792-0 I0806 21:53:39.764384 10812 sched.cpp:178] New master at [email protected]: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 [email protected]: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] [email protected]:39900 exited 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 ([email protected]: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 : [email protected]: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 ([email protected]: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: [email protected]:39900 I0806 21:53:40.378389 10818 sched.cpp:178] New master at [email protected]:39900 I0806 21:53:40.362905 10813 detector.cpp:467] Master detector (slave(112)@67.195.138.9:39900) got new master pid: [email protected]:39900 I0806 21:53:40.370863 10817 detector.cpp:467] Master detector ([email protected]:39900) got new master pid: [email protected]: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 [email protected]: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 [email protected]:39900 I0806 21:53:40.474058 10811 status_update_manager.cpp:157] New master detected at [email protected]: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 [email protected]: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 [email protected]: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 [email protected]: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
