See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/1101/>
------------------------------------------ [...truncated 13873 lines...] I0702 20:07:29.001410 5485 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: a985f042-4f89-4dee-a114-72e29548a402) for task 0 of framework 201307022007-143311683-33341-5463-0000 to [email protected]:33341 I0702 20:07:29.001525 5482 master.cpp:1093] Status update from slave(100)@67.195.138.8:33341: task 0 of framework 201307022007-143311683-33341-5463-0000 is now in state TASK_RUNNING I0702 20:07:29.001528 5485 slave.cpp:1803] Status update manager successfully handled status update TASK_RUNNING (UUID: a985f042-4f89-4dee-a114-72e29548a402) for task 0 of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.001646 5485 slave.cpp:1809] Sending acknowledgement for status update TASK_RUNNING (UUID: a985f042-4f89-4dee-a114-72e29548a402) for task 0 of framework 201307022007-143311683-33341-5463-0000 to executor(37)@67.195.138.8:33341 I0702 20:07:29.001771 5487 exec.cpp:290] Executor received status update acknowledgement a985f042-4f89-4dee-a114-72e29548a402 for task 0 of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.001799 5485 status_update_manager.cpp:360] Received status update acknowledgement a985f042-4f89-4dee-a114-72e29548a402 for task 0 of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.001919 5485 slave.cpp:1343] Status update manager successfully handled status update acknowledgement a985f042-4f89-4dee-a114-72e29548a402 for task 0 of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.002084 5484 master.cpp:436] Master terminating I0702 20:07:29.002174 5463 master.cpp:209] Shutting down master I0702 20:07:29.002184 5484 slave.cpp:1884] [email protected]:33341 exited W0702 20:07:29.002290 5484 slave.cpp:1887] Master disconnected! Waiting for a new master to be elected I0702 20:07:29.002312 5485 hierarchical_allocator_process.hpp:411] Deactivated framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.002346 5463 master.hpp:317] Removing task 0 with resources cpus=1; mem=500 on slave 201307022007-143311683-33341-5463-0 I0702 20:07:29.002404 5484 slave.cpp:1112] Asked to shut down framework 201307022007-143311683-33341-5463-0000 by [email protected]:33341 I0702 20:07:29.002573 5484 slave.cpp:1137] Shutting down framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.002636 5484 slave.cpp:2328] Shutting down executor 'default' of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.002646 5489 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=21006) on slave 201307022007-143311683-33341-5463-0 from framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.002833 5489 hierarchical_allocator_process.hpp:366] Removed framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.002720 5482 exec.cpp:323] Executor asked to shutdown I0702 20:07:29.003715 5486 master.cpp:230] Master started on 67.195.138.8:33341 I0702 20:07:29.003779 5486 master.cpp:245] Master ID: 201307022007-143311683-33341-5463 I0702 20:07:29.004866 5482 detector.cpp:420] Master detector (scheduler(93)@67.195.138.8:33341) found 0 registered masters I0702 20:07:29.009671 5482 detector.cpp:441] Master detector (scheduler(93)@67.195.138.8:33341) couldn't find any masters I0702 20:07:29.005928 5487 detector.cpp:234] Master detector ([email protected]:33341) connected to ZooKeeper ... W0702 20:07:29.009796 5484 master.cpp:83] No whitelist given. Advertising offers for all slaves I0702 20:07:29.009824 5487 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0702 20:07:29.009835 5485 sched.cpp:194] No master detected, waiting for another master I0702 20:07:29.009870 5482 hierarchical_allocator_process.hpp:305] Initializing hierarchical allocator process with master : [email protected]:33341 I0702 20:07:29.005100 5489 detector.cpp:420] Master detector (slave(100)@67.195.138.8:33341) found 0 registered masters I0702 20:07:29.010321 5489 detector.cpp:441] Master detector (slave(100)@67.195.138.8:33341) couldn't find any masters I0702 20:07:29.010442 5489 slave.cpp:563] Lost master(s) ... waiting I0702 20:07:29.011718 5487 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000002' I0702 20:07:29.012110 5482 detector.cpp:420] Master detector (slave(100)@67.195.138.8:33341) found 1 registered masters I0702 20:07:29.012238 5485 detector.cpp:420] Master detector (scheduler(93)@67.195.138.8:33341) found 1 registered masters I0702 20:07:29.012564 5487 detector.cpp:420] Master detector ([email protected]:33341) found 1 registered masters I0702 20:07:29.018121 5482 detector.cpp:467] Master detector (slave(100)@67.195.138.8:33341) got new master pid: [email protected]:33341 I0702 20:07:29.018256 5482 slave.cpp:529] New master detected at [email protected]:33341 I0702 20:07:29.018321 5485 detector.cpp:467] Master detector (scheduler(93)@67.195.138.8:33341) got new master pid: [email protected]:33341 I0702 20:07:29.018331 5489 status_update_manager.cpp:155] New master detected at [email protected]:33341 I0702 20:07:29.018487 5487 detector.cpp:467] Master detector ([email protected]:33341) got new master pid: [email protected]:33341 I0702 20:07:29.018543 5489 sched.cpp:177] New master at [email protected]:33341 I0702 20:07:29.018653 5487 master.cpp:583] Elected as master! I0702 20:07:29.018699 5487 master.cpp:675] Re-registering framework 201307022007-143311683-33341-5463-0000 at scheduler(93)@67.195.138.8:33341 I0702 20:07:29.018852 5489 sched.cpp:246] Framework re-registered with 201307022007-143311683-33341-5463-0000 I0702 20:07:29.018911 5487 hierarchical_allocator_process.hpp:335] Added framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.018942 5487 hierarchical_allocator_process.hpp:704] No resources available to allocate! I0702 20:07:29.019008 5487 hierarchical_allocator_process.hpp:666] Performed allocation for 0 slaves in 66.196us I0702 20:07:29.995666 5490 master.cpp:1034] Attempting to re-register slave 201307022007-143311683-33341-5463-0 at slave(100)@67.195.138.8:33341 (minerva.apache.org) I0702 20:07:29.995803 5490 master.cpp:1929] Adding slave 201307022007-143311683-33341-5463-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=21006 I0702 20:07:29.996037 5490 master.hpp:305] Adding task 0 with resources cpus=1; mem=500 on slave 201307022007-143311683-33341-5463-0 I0702 20:07:29.996026 5487 slave.cpp:630] Re-registered with master [email protected]:33341 W0702 20:07:29.996273 5487 slave.cpp:1273] Ignoring updating pid for framework 201307022007-143311683-33341-5463-0000 because it is terminating I0702 20:07:29.996352 5486 hierarchical_allocator_process.hpp:448] Added slave 201307022007-143311683-33341-5463-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=21006 (and cpus=1; mem=524; ports=[31000-32000]; disk=21006 available) I0702 20:07:29.996444 5486 hierarchical_allocator_process.hpp:726] Offering cpus=1; mem=524; ports=[31000-32000]; disk=21006 on slave 201307022007-143311683-33341-5463-0 to framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.996567 5486 hierarchical_allocator_process.hpp:686] Performed allocation for slave 201307022007-143311683-33341-5463-0 in 130.997us I0702 20:07:29.996611 5490 master.hpp:327] Adding offer 201307022007-143311683-33341-5463-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=21006 on slave 201307022007-143311683-33341-5463-0 I0702 20:07:29.996692 5490 master.cpp:1310] Sending 1 offers to framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.997174 5483 sched.cpp:427] Stopping framework '201307022007-143311683-33341-5463-0000' I0702 20:07:29.997200 5463 master.cpp:436] Master terminating I0702 20:07:29.997370 5487 slave.cpp:485] Slave asked to shut down by [email protected]:33341 I0702 20:07:29.997438 5487 slave.cpp:1112] Asked to shut down framework 201307022007-143311683-33341-5463-0000 by [email protected]:33341 W0702 20:07:29.997488 5487 slave.cpp:1133] Ignoring shutdown framework 201307022007-143311683-33341-5463-0000 because it is terminating I0702 20:07:29.997567 5487 slave.cpp:1884] [email protected]:33341 exited I0702 20:07:29.997375 5463 master.cpp:209] Shutting down master W0702 20:07:29.997648 5487 slave.cpp:1887] Master disconnected! Waiting for a new master to be elected I0702 20:07:29.997835 5487 slave.cpp:1112] Asked to shut down framework 201307022007-143311683-33341-5463-0000 by [email protected]:33341 I0702 20:07:29.997835 5484 hierarchical_allocator_process.hpp:411] Deactivated framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.997836 5463 master.hpp:317] Removing task 0 with resources cpus=1; mem=500 on slave 201307022007-143311683-33341-5463-0 W0702 20:07:29.997876 5487 slave.cpp:1133] Ignoring shutdown framework 201307022007-143311683-33341-5463-0000 because it is terminating I0702 20:07:29.998186 5487 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201307022007-143311683-33341-5463-0 from framework 201307022007-143311683-33341-5463-0000 I0702 20:07:29.998191 5463 master.hpp:337] Removing offer 201307022007-143311683-33341-5463-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=21006 on slave 201307022007-143311683-33341-5463-0 I0702 20:07:29.998358 5487 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=21006 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=21006) on slave 201307022007-143311683-33341-5463-0 from framework 201307022007-143311683-33341-5463-0000 I0702 20:07:30.005835 5485 hierarchical_allocator_process.hpp:366] Removed framework 201307022007-143311683-33341-5463-0000 I0702 20:07:30.005894 5485 hierarchical_allocator_process.hpp:476] Removed slave 201307022007-143311683-33341-5463-0 I0702 20:07:30.006568 5463 slave.cpp:440] Slave terminating I0702 20:07:30.006624 5463 slave.cpp:1112] Asked to shut down framework 201307022007-143311683-33341-5463-0000 by @0.0.0.0:0 I0702 20:07:30.007400 5485 detector.cpp:420] Master detector (slave(100)@67.195.138.8:33341) found 0 registered masters I0702 20:07:30.010639 5486 hierarchical_allocator_process.hpp:704] No resources available to allocate! W0702 20:07:30.013612 5463 slave.cpp:1133] Ignoring shutdown framework 201307022007-143311683-33341-5463-0000 because it is terminating I0702 20:07:30.013676 5485 detector.cpp:441] Master detector (slave(100)@67.195.138.8:33341) couldn't find any masters I0702 20:07:30.013743 5486 hierarchical_allocator_process.hpp:666] Performed allocation for 0 slaves in 3.162124ms [ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (2041 ms) [ RUN ] AllocatorZooKeeperTest/0.SlaveReregistersFirst I0702 20:07:30.015000 5484 master.cpp:230] Master started on 67.195.138.8:33341 2013-07-02 20:07:30,015:5463(0x2b55fdb3d700):ZOO_INFO@log_env@658: Client environment:zookeeper.version=zookeeper C client 3.3.4 2013-07-02 20:07:30,015:5463(0x2b55fdb3d700):ZOO_INFO@log_env@662: Client environment:host.name=minerva 2013-07-02 20:07:30,015:5463(0x2b55fdb3d700):ZOO_INFO@log_env@669: Client environment:os.name=Linux 2013-07-02 20:07:30,015:5463(0x2b55fdb3d700):ZOO_INFO@log_env@670: Client environment:os.arch=3.2.0-38-generic 2013-07-02 20:07:30,015:5463(0x2b55fdb3d700):ZOO_INFO@log_env@671: Client environment:os.version=#61-Ubuntu SMP Tue Feb 19 12:18:21 UTC 2013 2013-07-02 20:07:30,015:5463(0x2b55fdb3d700):ZOO_INFO@log_env@679: Client environment:user.name=(null) 2013-07-02 20:07:30,016:5463(0x2b55fdb3d700):ZOO_INFO@log_env@687: Client environment:user.home=/home/jenkins I0702 20:07:30.015069 5484 master.cpp:245] Master ID: 201307022007-143311683-33341-5463 I0702 20:07:30.015698 5482 slave.cpp:113] Slave started on 101)@67.195.138.8:33341 I0702 20:07:30.025789 5485 hierarchical_allocator_process.hpp:305] Initializing hierarchical allocator process with master : [email protected]:33341 I0702 20:07:30.025902 5482 slave.cpp:205] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=21006 I0702 20:07:30.017608 5486 detector.cpp:234] Master detector (slave(101)@67.195.138.8:33341) connected to ZooKeeper ... I0702 20:07:30.026051 5486 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0702 20:07:30.017086 5489 detector.cpp:234] Master detector ([email protected]:33341) connected to ZooKeeper ... I0702 20:07:30.026185 5489 detector.cpp:251] Trying to create path '/znode' in ZooKeeper W0702 20:07:30.025754 5487 master.cpp:83] No whitelist given. Advertising offers for all slaves I0702 20:07:30.018180 5490 detector.cpp:234] Master detector (scheduler(94)@67.195.138.8:33341) connected to ZooKeeper ... I0702 20:07:30.026520 5490 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0702 20:07:30.026587 5483 slave.cpp:390] Finished recovery I0702 20:07:30.027436 5486 detector.cpp:420] Master detector (slave(101)@67.195.138.8:33341) found 0 registered masters I0702 20:07:30.027539 5486 detector.cpp:441] Master detector (slave(101)@67.195.138.8:33341) couldn't find any masters I0702 20:07:30.027643 5483 slave.cpp:563] Lost master(s) ... waiting I0702 20:07:30.028451 5489 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000004' I0702 20:07:30.028498 5490 detector.cpp:420] Master detector (scheduler(94)@67.195.138.8:33341) found 1 registered masters I0702 20:07:30.028831 5484 detector.cpp:420] Master detector (slave(101)@67.195.138.8:33341) found 1 registered masters I0702 20:07:30.028983 5489 detector.cpp:420] Master detector ([email protected]:33341) found 1 registered masters I0702 20:07:30.034267 5490 detector.cpp:467] Master detector (scheduler(94)@67.195.138.8:33341) got new master pid: [email protected]:33341 I0702 20:07:30.034379 5490 sched.cpp:177] New master at [email protected]:33341 W0702 20:07:30.034490 5486 master.cpp:606] Ignoring register framework message since not elected yet I0702 20:07:30.034538 5484 detector.cpp:467] Master detector (slave(101)@67.195.138.8:33341) got new master pid: [email protected]:33341 I0702 20:07:30.034703 5489 detector.cpp:467] Master detector ([email protected]:33341) got new master pid: [email protected]:33341 I0702 20:07:30.034852 5483 slave.cpp:529] New master detected at [email protected]:33341 I0702 20:07:30.034888 5489 master.cpp:583] Elected as master! I0702 20:07:30.034936 5487 status_update_manager.cpp:155] New master detected at [email protected]:33341 I0702 20:07:30.035006 5489 master.cpp:962] Attempting to register slave on minerva.apache.org at slave(101)@67.195.138.8:33341 I0702 20:07:30.035115 5489 master.cpp:1929] Adding slave 201307022007-143311683-33341-5463-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=21006 I0702 20:07:30.035228 5486 slave.cpp:589] Registered with master [email protected]:33341; given slave ID 201307022007-143311683-33341-5463-0 I0702 20:07:30.035363 5487 hierarchical_allocator_process.hpp:448] Added slave 201307022007-143311683-33341-5463-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=21006 (and cpus=2; mem=1024; ports=[31000-32000]; disk=21006 available) I0702 20:07:30.035436 5487 hierarchical_allocator_process.hpp:686] Performed allocation for slave 201307022007-143311683-33341-5463-0 in 6.354us I0702 20:07:31.026015 5487 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 12.195us I0702 20:07:31.035274 5489 master.cpp:633] Registering framework 201307022007-143311683-33341-5463-0000 at scheduler(94)@67.195.138.8:33341 I0702 20:07:31.035368 5489 hierarchical_allocator_process.hpp:335] Added framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.035370 5484 sched.cpp:222] Framework registered with 201307022007-143311683-33341-5463-0000 I0702 20:07:31.035450 5489 hierarchical_allocator_process.hpp:726] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=21006 on slave 201307022007-143311683-33341-5463-0 to framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.035783 5489 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 336.331us I0702 20:07:31.035832 5485 master.hpp:327] Adding offer 201307022007-143311683-33341-5463-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=21006 on slave 201307022007-143311683-33341-5463-0 I0702 20:07:31.035922 5485 master.cpp:1310] Sending 1 offers to framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.036192 5489 master.cpp:1543] Processing reply for offer 201307022007-143311683-33341-5463-0 on slave 201307022007-143311683-33341-5463-0 (minerva.apache.org) for framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.036370 5489 master.hpp:305] Adding task 0 with resources cpus=1; mem=500 on slave 201307022007-143311683-33341-5463-0 I0702 20:07:31.036423 5489 master.cpp:1662] Launching task 0 of framework 201307022007-143311683-33341-5463-0000 with resources cpus=1; mem=500 on slave 201307022007-143311683-33341-5463-0 (minerva.apache.org) I0702 20:07:31.036535 5485 slave.cpp:739] Got assigned task 0 for framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.036594 5489 master.hpp:337] Removing offer 201307022007-143311683-33341-5463-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=21006 on slave 201307022007-143311683-33341-5463-0 I0702 20:07:31.036708 5489 hierarchical_allocator_process.hpp:525] Framework 201307022007-143311683-33341-5463-0000 left cpus=1; mem=524; ports=[31000-32000]; disk=21006 unused on slave 201307022007-143311683-33341-5463-0 I0702 20:07:31.036734 5485 slave.cpp:837] Launching task 0 for framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.036855 5489 hierarchical_allocator_process.hpp:568] Framework 201307022007-143311683-33341-5463-0000 filtered slave 201307022007-143311683-33341-5463-0 for 5secs I0702 20:07:31.038244 5485 paths.hpp:303] Created executor directory '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_a2KKay/slaves/201307022007-143311683-33341-5463-0/frameworks/201307022007-143311683-33341-5463-0000/executors/default/runs/fec15fa8-0107-473e-b1a3-6d256461b5f0' I0702 20:07:31.038406 5485 slave.cpp:948] Queuing task '0' for executor default of framework '201307022007-143311683-33341-5463-0000 I0702 20:07:31.038555 5490 slave.cpp:511] Successfully attached file '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_a2KKay/slaves/201307022007-143311683-33341-5463-0/frameworks/201307022007-143311683-33341-5463-0000/executors/default/runs/fec15fa8-0107-473e-b1a3-6d256461b5f0' I0702 20:07:31.038599 5486 exec.cpp:170] Executor started at: executor(38)@67.195.138.8:33341 with pid 5463 I0702 20:07:31.038878 5489 slave.cpp:1395] Got registration for executor 'default' of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.039005 5489 slave.cpp:1510] Flushing queued task 0 for executor 'default' of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.039079 5487 exec.cpp:194] Executor registered on slave 201307022007-143311683-33341-5463-0 I0702 20:07:31.039219 5487 exec.cpp:258] Executor asked to run task '0' I0702 20:07:31.040460 5487 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 376ada85-b352-4780-a6b9-35f129100baf) for task 0 of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.040554 5487 slave.cpp:1692] Handling status update TASK_RUNNING (UUID: 376ada85-b352-4780-a6b9-35f129100baf) for task 0 of framework 201307022007-143311683-33341-5463-0000 from executor(38)@67.195.138.8:33341 I0702 20:07:31.040720 5487 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 376ada85-b352-4780-a6b9-35f129100baf) for task 0 of framework 201307022007-143311683-33341-5463-0000 with checkpoint=false I0702 20:07:31.040773 5487 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.040870 5487 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 376ada85-b352-4780-a6b9-35f129100baf) for task 0 of framework 201307022007-143311683-33341-5463-0000 to [email protected]:33341 I0702 20:07:31.041045 5490 master.cpp:1093] Status update from slave(101)@67.195.138.8:33341: task 0 of framework 201307022007-143311683-33341-5463-0000 is now in state TASK_RUNNING I0702 20:07:31.041064 5487 slave.cpp:1803] Status update manager successfully handled status update TASK_RUNNING (UUID: 376ada85-b352-4780-a6b9-35f129100baf) for task 0 of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.041183 5487 slave.cpp:1809] Sending acknowledgement for status update TASK_RUNNING (UUID: 376ada85-b352-4780-a6b9-35f129100baf) for task 0 of framework 201307022007-143311683-33341-5463-0000 to executor(38)@67.195.138.8:33341 I0702 20:07:31.041316 5490 exec.cpp:290] Executor received status update acknowledgement 376ada85-b352-4780-a6b9-35f129100baf for task 0 of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.041560 5486 status_update_manager.cpp:360] Received status update acknowledgement 376ada85-b352-4780-a6b9-35f129100baf for task 0 of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.041721 5485 slave.cpp:1343] Status update manager successfully handled status update acknowledgement 376ada85-b352-4780-a6b9-35f129100baf for task 0 of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.041813 5485 master.cpp:436] Master terminating I0702 20:07:31.041923 5484 slave.cpp:1884] [email protected]:33341 exited I0702 20:07:31.041925 5463 master.cpp:209] Shutting down master W0702 20:07:31.041971 5484 slave.cpp:1887] Master disconnected! Waiting for a new master to be elected I0702 20:07:31.042166 5484 slave.cpp:1112] Asked to shut down framework 201307022007-143311683-33341-5463-0000 by [email protected]:33341 I0702 20:07:31.042182 5463 master.hpp:317] Removing task 0 with resources cpus=1; mem=500 on slave 201307022007-143311683-33341-5463-0 I0702 20:07:31.042187 5490 hierarchical_allocator_process.hpp:411] Deactivated framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.042201 5484 slave.cpp:1137] Shutting down framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.042695 5484 slave.cpp:2328] Shutting down executor 'default' of framework 201307022007-143311683-33341-5463-0000 I0702 20:07:31.042755 5484 exec.cpp:323] Executor asked to shutdown I0702 20:07:31.043359 5484 master.cpp:230] Master started on 67.195.138.8:33341 I0702 20:07:31.043416 5484 master.cpp:245] Master ID: 201307022007-143311683-33341-5463 I0702 20:07:31.044167 5486 detector.cpp:420] Master detector (scheduler(94)@67.195.138.8:33341) found 0 registered masters I0702 20:07:31.049698 5486 detector.cpp:441] Master detector (scheduler(94)@67.195.138.8:33341) couldn't find any masters W0702 20:07:31.049770 5489 master.cpp:83] No whitelist given. Advertising offers for all slaves I0702 20:07:31.044306 5487 detector.cpp:420] Master detector (slave(101)@67.195.138.8:33341) found 0 registered masters I0702 20:07:31.049810 5486 sched.cpp:194] No master detected, waiting for another master I0702 20:07:31.045359 5483 detector.cpp:234] Master detector ([email protected]:33341) connected to ZooKeeper ... I0702 20:07:31.050050 5489 hierarchical_allocator_process.hpp:305] Initializing hierarchical allocator process with master : [email protected]:33341 I0702 20:07:31.050083 5487 detector.cpp:441] Master detector (slave(101)@67.195.138.8:33341) couldn't find any masters I0702 20:07:31.050148 5483 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0702 20:07:31.050385 5490 slave.cpp:563] Lost master(s) ... waiting I0702 20:07:31.051892 5483 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000006' I0702 20:07:31.052124 5484 detector.cpp:420] Master detector (scheduler(94)@67.195.138.8:33341) found 1 registered masters I0702 20:07:31.052356 5485 detector.cpp:420] Master detector (slave(101)@67.195.138.8:33341) found 1 registered masters I0702 20:07:31.052501 5483 detector.cpp:420] Master detector ([email protected]:33341) found 1 registered masters I0702 20:07:31.058085 5484 detector.cpp:467] Master detector (scheduler(94)@67.195.138.8:33341) got new master pid: [email protected]:33341 I0702 20:07:31.058194 5484 sched.cpp:177] New master at [email protected]:33341 I0702 20:07:31.058343 5483 detector.cpp:467] Master detector ([email protected]:33341) got new master pid: [email protected]:33341 I0702 20:07:31.058434 5483 master.cpp:583] Elected as master! I0702 20:07:31.058614 5485 detector.cpp:467] Master detector (slave(101)@67.195.138.8:33341) got new master pid: [email protected]:33341 I0702 20:07:31.058747 5485 slave.cpp:529] New master detected at [email protected]:33341 I0702 20:07:31.058841 5486 status_update_manager.cpp:155] New master detected at [email protected]:33341 I0702 20:07:31.058903 5484 master.cpp:1034] Attempting to re-register slave 201307022007-143311683-33341-5463-0 at slave(101)@67.195.138.8:33341 (minerva.apache.org) I0702 20:07:31.059008 5484 master.cpp:1929] Adding slave 201307022007-143311683-33341-5463-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=21006 I0702 20:07:31.059106 5485 slave.cpp:630] Re-registered with master [email protected]:33341 I0702 20:07:31.059131 5484 master.hpp:305] Adding task 0 with resources cpus=1; mem=500 on slave 201307022007-143311683-33341-5463-0 W0702 20:07:31.059218 5484 master.cpp:2021] Possibly orphaned task 0 of framework 201307022007-143311683-33341-5463-0000 running on slave 201307022007-143311683-33341-5463-0 (minerva.apache.org) I0702 20:07:31.059465 5484 hierarchical_allocator_process.hpp:448] Added slave 201307022007-143311683-33341-5463-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=21006 (and cpus=1; mem=524; ports=[31000-32000]; disk=21006 available) I0702 20:07:31.059520 5484 hierarchical_allocator_process.hpp:686] Performed allocation for slave 201307022007-143311683-33341-5463-0 in 6.586us I0702 20:07:32.035440 5485 master.cpp:675] Re-registering framework 201307022007-143311683-33341-5463-0000 at scheduler(94)@67.195.138.8:33341 I0702 20:07:32.035761 5489 sched.cpp:246] Framework re-registered with 201307022007-143311683-33341-5463-0000 W0702 20:07:32.035807 5487 slave.cpp:1273] Ignoring updating pid for framework 201307022007-143311683-33341-5463-0000 because it is terminating I0702 20:07:32.035960 5484 hierarchical_allocator_process.hpp:335] Added framework 201307022007-143311683-33341-5463-0000 I0702 20:07:32.036118 5484 hierarchical_allocator_process.hpp:726] Offering cpus=1; mem=524; ports=[31000-32000]; disk=21006 on slave 201307022007-143311683-33341-5463-0 to framework 201307022007-143311683-33341-5463-0000 I0702 20:07:32.036275 5484 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 196.586us I0702 20:07:32.036389 5486 master.hpp:327] Adding offer 201307022007-143311683-33341-5463-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=21006 on slave 201307022007-143311683-33341-5463-0 I0702 20:07:32.036569 5486 master.cpp:1310] Sending 1 offers to framework 201307022007-143311683-33341-5463-0000 I0702 20:07:32.036972 5485 sched.cpp:427] Stopping framework '201307022007-143311683-33341-5463-0000' I0702 20:07:32.036985 5463 master.cpp:436] Master terminating I0702 20:07:32.037093 5463 master.cpp:209] Shutting down master I0702 20:07:32.037286 5463 master.hpp:317] Removing task 0 with resources cpus=1; mem=500 on slave 201307022007-143311683-33341-5463-0 I0702 20:07:32.037302 5490 hierarchical_allocator_process.hpp:411] Deactivated framework 201307022007-143311683-33341-5463-0000 I0702 20:07:32.037127 5483 slave.cpp:485] Slave asked to shut down by [email protected]:33341 I0702 20:07:32.037690 5483 slave.cpp:1112] Asked to shut down framework 201307022007-143311683-33341-5463-0000 by [email protected]:33341 W0702 20:07:32.045609 5483 slave.cpp:1133] Ignoring shutdown framework 201307022007-143311683-33341-5463-0000 because it is terminating I0702 20:07:32.037698 5490 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201307022007-143311683-33341-5463-0 from framework 201307022007-143311683-33341-5463-0000 I0702 20:07:32.037534 5463 master.hpp:337] Removing offer 201307022007-143311683-33341-5463-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=21006 on slave 201307022007-143311683-33341-5463-0 I0702 20:07:32.045672 5483 slave.cpp:1884] [email protected]:33341 exited W0702 20:07:32.045876 5483 slave.cpp:1887] Master disconnected! Waiting for a new master to be elected I0702 20:07:32.045933 5483 slave.cpp:1112] Asked to shut down framework 201307022007-143311683-33341-5463-0000 by [email protected]:33341 W0702 20:07:32.046037 5483 slave.cpp:1133] Ignoring shutdown framework 201307022007-143311683-33341-5463-0000 because it is terminating I0702 20:07:32.046205 5490 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=21006 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=21006) on slave 201307022007-143311683-33341-5463-0 from framework 201307022007-143311683-33341-5463-0000 I0702 20:07:32.046391 5490 hierarchical_allocator_process.hpp:366] Removed framework 201307022007-143311683-33341-5463-0000 I0702 20:07:32.046499 5490 hierarchical_allocator_process.hpp:476] Removed slave 201307022007-143311683-33341-5463-0 I0702 20:07:32.046579 5463 slave.cpp:440] Slave terminating I0702 20:07:32.046620 5463 slave.cpp:1112] Asked to shut down framework 201307022007-143311683-33341-5463-0000 by @0.0.0.0:0 W0702 20:07:32.053621 5463 slave.cpp:1133] Ignoring shutdown framework 201307022007-143311683-33341-5463-0000 because it is terminating I0702 20:07:32.050433 5484 hierarchical_allocator_process.hpp:704] No resources available to allocate! I0702 20:07:32.053746 5484 hierarchical_allocator_process.hpp:666] Performed allocation for 0 slaves in 3.329851ms I0702 20:07:32.047365 5490 detector.cpp:420] Master detector (slave(101)@67.195.138.8:33341) found 0 registered masters I0702 20:07:32.053961 5490 detector.cpp:441] Master detector (slave(101)@67.195.138.8:33341) couldn't find any masters [ OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (2040 ms) I0702 20:07:32.055728 5463 zookeeper_test_server.cpp:93] Shutdown ZooKeeperTestServer on port 38599 [----------] 2 tests from AllocatorZooKeeperTest/0 (4081 ms total) [----------] Global test environment tear-down [==========] 198 tests from 37 test cases ran. (76403 ms total) [ PASSED ] 197 tests. [ FAILED ] 1 test, listed below: [ FAILED ] GarbageCollectorTest.Unschedule 1 FAILED TEST make[3]: *** [check-local] Error 1 make[3]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'> make[2]: *** [check-am] Error 2 make[2]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'> make[1]: *** [check] Error 2 make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'> make: *** [check-recursive] Error 1 Build step 'Execute shell' marked build as failure
