See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/1536/>
------------------------------------------ [...truncated 14872 lines...] I0803 10:36:46.771754 521 exec.cpp:283] Executor::launchTask took 21.285us I0803 10:36:46.772920 521 exec.cpp:464] Executor sending status update TASK_RUNNING (UUID: c7b5fdc6-f6f3-4ac9-b5e3-0ad82291795e) for task 0 of framework 201308031036-143311683-41746-417-0000 I0803 10:36:46.773004 521 slave.cpp:1720] Handling status update TASK_RUNNING (UUID: c7b5fdc6-f6f3-4ac9-b5e3-0ad82291795e) for task 0 of framework 201308031036-143311683-41746-417-0000 from executor(38)@67.195.138.8:41746 I0803 10:36:46.773113 525 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: c7b5fdc6-f6f3-4ac9-b5e3-0ad82291795e) for task 0 of framework 201308031036-143311683-41746-417-0000 with checkpoint=false I0803 10:36:46.773160 525 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201308031036-143311683-41746-417-0000 I0803 10:36:46.773296 525 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: c7b5fdc6-f6f3-4ac9-b5e3-0ad82291795e) for task 0 of framework 201308031036-143311683-41746-417-0000 to [email protected]:41746 I0803 10:36:46.773370 521 master.cpp:1103] Status update from slave(108)@67.195.138.8:41746: task 0 of framework 201308031036-143311683-41746-417-0000 is now in state TASK_RUNNING I0803 10:36:46.773394 525 slave.cpp:1831] Status update manager successfully handled status update TASK_RUNNING (UUID: c7b5fdc6-f6f3-4ac9-b5e3-0ad82291795e) for task 0 of framework 201308031036-143311683-41746-417-0000 I0803 10:36:46.773458 521 sched.cpp:395] Scheduler::statusUpdate took 15.599us I0803 10:36:46.773458 525 slave.cpp:1837] Sending acknowledgement for status update TASK_RUNNING (UUID: c7b5fdc6-f6f3-4ac9-b5e3-0ad82291795e) for task 0 of framework 201308031036-143311683-41746-417-0000 to executor(38)@67.195.138.8:41746 I0803 10:36:46.773628 527 exec.cpp:320] Executor received status update acknowledgement c7b5fdc6-f6f3-4ac9-b5e3-0ad82291795e for task 0 of framework 201308031036-143311683-41746-417-0000 I0803 10:36:46.773674 527 status_update_manager.cpp:360] Received status update acknowledgement c7b5fdc6-f6f3-4ac9-b5e3-0ad82291795e for task 0 of framework 201308031036-143311683-41746-417-0000 I0803 10:36:46.773890 527 slave.cpp:1371] Status update manager successfully handled status update acknowledgement c7b5fdc6-f6f3-4ac9-b5e3-0ad82291795e for task 0 of framework 201308031036-143311683-41746-417-0000 I0803 10:36:46.774039 417 master.cpp:446] Master terminating I0803 10:36:46.774286 417 master.cpp:209] Shutting down master I0803 10:36:46.774323 523 slave.cpp:1912] [email protected]:41746 exited I0803 10:36:46.774394 521 hierarchical_allocator_process.hpp:393] Deactivated framework 201308031036-143311683-41746-417-0000 W0803 10:36:46.774430 523 slave.cpp:1915] Master disconnected! Waiting for a new master to be elected I0803 10:36:46.774423 417 master.hpp:321] Removing task 0 with resources cpus(*):1; mem(*):500 on slave 201308031036-143311683-41746-417-0 I0803 10:36:46.774559 523 slave.cpp:1140] Asked to shut down framework 201308031036-143311683-41746-417-0000 by [email protected]:41746 I0803 10:36:46.774663 523 slave.cpp:1165] Shutting down framework 201308031036-143311683-41746-417-0000 I0803 10:36:46.774713 525 hierarchical_allocator_process.hpp:595] Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000]) on slave 201308031036-143311683-41746-417-0 from framework 201308031036-143311683-41746-417-0000 I0803 10:36:46.774902 523 slave.cpp:2356] Shutting down executor 'default' of framework 201308031036-143311683-41746-417-0000 I0803 10:36:46.775055 527 exec.cpp:360] Executor asked to shutdown I0803 10:36:46.775091 527 exec.cpp:375] Executor::shutdown took 9.746us I0803 10:36:46.775876 525 master.cpp:230] Master started on 67.195.138.8:41746 I0803 10:36:46.776010 525 master.cpp:245] Master ID: 201308031036-143311683-41746-417 I0803 10:36:46.777590 522 detector.cpp:420] Master detector (slave(108)@67.195.138.8:41746) found 0 registered masters I0803 10:36:46.785647 522 detector.cpp:441] Master detector (slave(108)@67.195.138.8:41746) couldn't find any masters I0803 10:36:46.778213 524 detector.cpp:234] Master detector ([email protected]:41746) connected to ZooKeeper ... I0803 10:36:46.785768 524 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0803 10:36:46.785748 522 slave.cpp:571] Lost master(s) ... waiting I0803 10:36:46.778440 527 detector.cpp:420] Master detector (scheduler(99)@67.195.138.8:41746) found 0 registered masters I0803 10:36:46.785945 527 detector.cpp:441] Master detector (scheduler(99)@67.195.138.8:41746) couldn't find any masters I0803 10:36:46.786017 527 sched.cpp:202] No master detected, waiting for another master I0803 10:36:46.786082 527 sched.cpp:214] Scheduler::disconnected took 10.814us W0803 10:36:46.786173 527 master.cpp:83] No whitelist given. Advertising offers for all slaves I0803 10:36:46.786223 522 hierarchical_allocator_process.hpp:287] Initializing hierarchical allocator process with master : [email protected]:41746 I0803 10:36:46.790967 524 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000002' I0803 10:36:46.791535 525 detector.cpp:420] Master detector (slave(108)@67.195.138.8:41746) found 1 registered masters I0803 10:36:46.791651 526 detector.cpp:420] Master detector (scheduler(99)@67.195.138.8:41746) found 1 registered masters I0803 10:36:46.791877 524 detector.cpp:420] Master detector ([email protected]:41746) found 1 registered masters I0803 10:36:46.798329 525 detector.cpp:467] Master detector (slave(108)@67.195.138.8:41746) got new master pid: [email protected]:41746 I0803 10:36:46.798447 525 slave.cpp:537] New master detected at [email protected]:41746 I0803 10:36:46.798521 527 status_update_manager.cpp:155] New master detected at [email protected]:41746 I0803 10:36:46.798643 526 detector.cpp:467] Master detector (scheduler(99)@67.195.138.8:41746) got new master pid: [email protected]:41746 I0803 10:36:46.798831 526 sched.cpp:178] New master at [email protected]:41746 I0803 10:36:46.798882 524 detector.cpp:467] Master detector ([email protected]:41746) got new master pid: [email protected]:41746 W0803 10:36:46.799042 524 master.cpp:665] Ignoring re-register framework message since not elected yet I0803 10:36:46.799118 524 master.cpp:593] Elected as master! I0803 10:36:47.767880 528 master.cpp:685] Re-registering framework 201308031036-143311683-41746-417-0000 at scheduler(99)@67.195.138.8:41746 I0803 10:36:47.768283 523 sched.cpp:268] Framework re-registered with 201308031036-143311683-41746-417-0000 I0803 10:36:47.768506 523 sched.cpp:282] Scheduler::reregistered took 48.76us I0803 10:36:47.768374 527 hierarchical_allocator_process.hpp:317] Added framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.768709 527 hierarchical_allocator_process.hpp:684] No resources available to allocate! I0803 10:36:47.768766 527 hierarchical_allocator_process.hpp:646] Performed allocation for 0 slaves in 57.992us I0803 10:36:47.786896 522 hierarchical_allocator_process.hpp:684] No resources available to allocate! I0803 10:36:47.787050 522 hierarchical_allocator_process.hpp:646] Performed allocation for 0 slaves in 183.582us I0803 10:36:47.799273 528 master.cpp:1044] Attempting to re-register slave 201308031036-143311683-41746-417-0 at slave(108)@67.195.138.8:41746 (minerva.apache.org) I0803 10:36:47.799402 528 master.cpp:1951] Adding slave 201308031036-143311683-41746-417-0 at minerva.apache.org with cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000] I0803 10:36:47.799561 526 slave.cpp:638] Re-registered with master [email protected]:41746 I0803 10:36:47.799618 528 master.hpp:309] Adding task 0 with resources cpus(*):1; mem(*):500 on slave 201308031036-143311683-41746-417-0 W0803 10:36:47.799952 528 slave.cpp:1301] Ignoring updating pid for framework 201308031036-143311683-41746-417-0000 because it is terminating I0803 10:36:47.800065 526 hierarchical_allocator_process.hpp:430] Added slave 201308031036-143311683-41746-417-0 (minerva.apache.org) with cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000] (and cpus(*):1; mem(*):524; disk(*):21415; ports(*):[31000-32000] available) I0803 10:36:47.800192 526 hierarchical_allocator_process.hpp:709] Offering cpus(*):1; mem(*):524; disk(*):21415; ports(*):[31000-32000] on slave 201308031036-143311683-41746-417-0 to framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.800345 526 hierarchical_allocator_process.hpp:666] Performed allocation for slave 201308031036-143311683-41746-417-0 in 188.391us I0803 10:36:47.800403 528 master.hpp:331] Adding offer 201308031036-143311683-41746-417-0 with resources cpus(*):1; mem(*):524; disk(*):21415; ports(*):[31000-32000] on slave 201308031036-143311683-41746-417-0 I0803 10:36:47.800525 528 master.cpp:1332] Sending 1 offers to framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.800727 523 sched.cpp:340] Scheduler::resourceOffers took 42.349us I0803 10:36:47.800921 528 sched.cpp:498] Stopping framework '201308031036-143311683-41746-417-0000' I0803 10:36:47.800953 417 master.cpp:446] Master terminating I0803 10:36:47.801048 523 slave.cpp:493] Slave asked to shut down by [email protected]:41746 I0803 10:36:47.801069 417 master.cpp:209] Shutting down master I0803 10:36:47.801092 523 slave.cpp:1140] Asked to shut down framework 201308031036-143311683-41746-417-0000 by [email protected]:41746 W0803 10:36:47.801298 523 slave.cpp:1161] Ignoring shutdown framework 201308031036-143311683-41746-417-0000 because it is terminating I0803 10:36:47.801347 523 slave.cpp:1912] [email protected]:41746 exited W0803 10:36:47.801412 523 slave.cpp:1915] Master disconnected! Waiting for a new master to be elected I0803 10:36:47.801471 523 slave.cpp:1140] Asked to shut down framework 201308031036-143311683-41746-417-0000 by [email protected]:41746 W0803 10:36:47.801551 523 slave.cpp:1161] Ignoring shutdown framework 201308031036-143311683-41746-417-0000 because it is terminating I0803 10:36:47.801218 527 hierarchical_allocator_process.hpp:393] Deactivated framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.801561 417 master.hpp:321] Removing task 0 with resources cpus(*):1; mem(*):500 on slave 201308031036-143311683-41746-417-0 I0803 10:36:47.801811 417 master.hpp:341] Removing offer 201308031036-143311683-41746-417-0 with resources cpus(*):1; mem(*):524; disk(*):21415; ports(*):[31000-32000] on slave 201308031036-143311683-41746-417-0 I0803 10:36:47.801894 525 hierarchical_allocator_process.hpp:595] Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):1; mem(*):500) on slave 201308031036-143311683-41746-417-0 from framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.801992 525 hierarchical_allocator_process.hpp:595] Recovered cpus(*):1; mem(*):524; disk(*):21415; ports(*):[31000-32000] (total allocatable: cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000]) on slave 201308031036-143311683-41746-417-0 from framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.802142 525 hierarchical_allocator_process.hpp:348] Removed framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.802202 525 hierarchical_allocator_process.hpp:456] Removed slave 201308031036-143311683-41746-417-0 I0803 10:36:47.803046 417 slave.cpp:448] Slave terminating I0803 10:36:47.803093 417 slave.cpp:1140] Asked to shut down framework 201308031036-143311683-41746-417-0000 by @0.0.0.0:0 W0803 10:36:47.803143 417 slave.cpp:1161] Ignoring shutdown framework 201308031036-143311683-41746-417-0000 because it is terminating [ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (2059 ms) [ RUN ] AllocatorZooKeeperTest/0.SlaveReregistersFirst I0803 10:36:47.804220 524 master.cpp:230] Master started on 67.195.138.8:41746 I0803 10:36:47.804281 524 master.cpp:245] Master ID: 201308031036-143311683-41746-417 I0803 10:36:47.804702 521 slave.cpp:113] Slave started on 109)@67.195.138.8:41746 I0803 10:36:47.813817 521 slave.cpp:213] Slave resources: cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000] I0803 10:36:47.813982 525 hierarchical_allocator_process.hpp:287] Initializing hierarchical allocator process with master : [email protected]:41746 W0803 10:36:47.814031 523 master.cpp:83] No whitelist given. Advertising offers for all slaves I0803 10:36:47.814261 521 slave.cpp:398] Finished recovery I0803 10:36:47.806581 527 detector.cpp:234] Master detector (scheduler(100)@67.195.138.8:41746) connected to ZooKeeper ... I0803 10:36:47.807096 522 detector.cpp:234] Master detector (slave(109)@67.195.138.8:41746) connected to ZooKeeper ... I0803 10:36:47.814350 527 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0803 10:36:47.814417 522 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0803 10:36:47.815750 522 detector.cpp:420] Master detector (slave(109)@67.195.138.8:41746) found 0 registered masters I0803 10:36:47.815789 522 detector.cpp:441] Master detector (slave(109)@67.195.138.8:41746) couldn't find any masters I0803 10:36:47.815883 522 slave.cpp:571] Lost master(s) ... waiting I0803 10:36:47.815970 527 detector.cpp:420] Master detector (scheduler(100)@67.195.138.8:41746) found 0 registered masters I0803 10:36:47.816001 527 detector.cpp:441] Master detector (scheduler(100)@67.195.138.8:41746) couldn't find any masters I0803 10:36:47.816086 527 sched.cpp:202] No master detected, waiting for another master I0803 10:36:47.819349 526 detector.cpp:234] Master detector ([email protected]:41746) connected to ZooKeeper ... I0803 10:36:47.819403 526 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0803 10:36:47.828408 526 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000004' I0803 10:36:47.829129 525 detector.cpp:420] Master detector (scheduler(100)@67.195.138.8:41746) found 1 registered masters I0803 10:36:47.829355 521 detector.cpp:420] Master detector (slave(109)@67.195.138.8:41746) found 1 registered masters I0803 10:36:47.829685 526 detector.cpp:420] Master detector ([email protected]:41746) found 1 registered masters I0803 10:36:47.834780 526 detector.cpp:467] Master detector ([email protected]:41746) got new master pid: [email protected]:41746 I0803 10:36:47.834826 525 detector.cpp:467] Master detector (scheduler(100)@67.195.138.8:41746) got new master pid: [email protected]:41746 I0803 10:36:47.834919 526 master.cpp:593] Elected as master! I0803 10:36:47.835072 526 sched.cpp:178] New master at [email protected]:41746 I0803 10:36:47.835232 526 master.cpp:643] Registering framework 201308031036-143311683-41746-417-0000 at scheduler(100)@67.195.138.8:41746 I0803 10:36:47.835335 526 sched.cpp:237] Framework registered with 201308031036-143311683-41746-417-0000 I0803 10:36:47.835379 526 sched.cpp:251] Scheduler::registered took 15.758us I0803 10:36:47.835463 528 hierarchical_allocator_process.hpp:317] Added framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.835497 521 detector.cpp:467] Master detector (slave(109)@67.195.138.8:41746) got new master pid: [email protected]:41746 I0803 10:36:47.835608 528 hierarchical_allocator_process.hpp:684] No resources available to allocate! I0803 10:36:47.835767 521 slave.cpp:537] New master detected at [email protected]:41746 I0803 10:36:47.835783 528 hierarchical_allocator_process.hpp:646] Performed allocation for 0 slaves in 178.205us I0803 10:36:47.835938 523 status_update_manager.cpp:155] New master detected at [email protected]:41746 I0803 10:36:47.835991 521 master.cpp:972] Attempting to register slave on minerva.apache.org at slave(109)@67.195.138.8:41746 I0803 10:36:47.836158 521 master.cpp:1951] Adding slave 201308031036-143311683-41746-417-0 at minerva.apache.org with cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000] I0803 10:36:47.836299 528 slave.cpp:597] Registered with master [email protected]:41746; given slave ID 201308031036-143311683-41746-417-0 I0803 10:36:47.836499 524 hierarchical_allocator_process.hpp:430] Added slave 201308031036-143311683-41746-417-0 (minerva.apache.org) with cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000] (and cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000] available) I0803 10:36:47.836627 524 hierarchical_allocator_process.hpp:709] Offering cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000] on slave 201308031036-143311683-41746-417-0 to framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.836773 524 hierarchical_allocator_process.hpp:666] Performed allocation for slave 201308031036-143311683-41746-417-0 in 187.247us I0803 10:36:47.836855 528 master.hpp:331] Adding offer 201308031036-143311683-41746-417-0 with resources cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000] on slave 201308031036-143311683-41746-417-0 I0803 10:36:47.836972 528 master.cpp:1332] Sending 1 offers to framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.837391 521 sched.cpp:340] Scheduler::resourceOffers took 183.913us I0803 10:36:47.837543 521 master.cpp:1565] Processing reply for offer 201308031036-143311683-41746-417-0 on slave 201308031036-143311683-41746-417-0 (minerva.apache.org) for framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.837679 521 master.hpp:309] Adding task 0 with resources cpus(*):1; mem(*):500 on slave 201308031036-143311683-41746-417-0 I0803 10:36:47.837728 521 master.cpp:1684] Launching task 0 of framework 201308031036-143311683-41746-417-0000 with resources cpus(*):1; mem(*):500 on slave 201308031036-143311683-41746-417-0 (minerva.apache.org) I0803 10:36:47.837836 528 slave.cpp:747] Got assigned task 0 for framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.837888 521 master.hpp:341] Removing offer 201308031036-143311683-41746-417-0 with resources cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000] on slave 201308031036-143311683-41746-417-0 I0803 10:36:47.838039 521 hierarchical_allocator_process.hpp:505] Framework 201308031036-143311683-41746-417-0000 left cpus(*):1; mem(*):524; disk(*):21415; ports(*):[31000-32000] unused on slave 201308031036-143311683-41746-417-0 I0803 10:36:47.838106 528 slave.cpp:845] Launching task 0 for framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.838189 521 hierarchical_allocator_process.hpp:548] Framework 201308031036-143311683-41746-417-0000 filtered slave 201308031036-143311683-41746-417-0 for 5secs I0803 10:36:47.839548 528 paths.hpp:303] Created executor directory '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_7dR999/slaves/201308031036-143311683-41746-417-0/frameworks/201308031036-143311683-41746-417-0000/executors/default/runs/d72f0067-3d46-410b-984c-aeb446be07a4' I0803 10:36:47.839818 528 slave.cpp:956] Queuing task '0' for executor default of framework '201308031036-143311683-41746-417-0000 I0803 10:36:47.839951 524 slave.cpp:519] Successfully attached file '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_7dR999/slaves/201308031036-143311683-41746-417-0/frameworks/201308031036-143311683-41746-417-0000/executors/default/runs/d72f0067-3d46-410b-984c-aeb446be07a4' I0803 10:36:47.839969 521 exec.cpp:171] Executor started at: executor(39)@67.195.138.8:41746 with pid 417 I0803 10:36:47.840134 521 slave.cpp:1423] Got registration for executor 'default' of framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.840226 521 slave.cpp:1538] Flushing queued task 0 for executor 'default' of framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.840286 524 exec.cpp:195] Executor registered on slave 201308031036-143311683-41746-417-0 I0803 10:36:47.840380 524 exec.cpp:206] Executor::registered took 12.201us I0803 10:36:47.840487 524 exec.cpp:274] Executor asked to run task '0' I0803 10:36:47.840548 524 exec.cpp:283] Executor::launchTask took 27.932us I0803 10:36:47.841845 524 exec.cpp:464] Executor sending status update TASK_RUNNING (UUID: cc9aea43-e0b6-4b61-87bb-bfe6c395975a) for task 0 of framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.841938 524 slave.cpp:1720] Handling status update TASK_RUNNING (UUID: cc9aea43-e0b6-4b61-87bb-bfe6c395975a) for task 0 of framework 201308031036-143311683-41746-417-0000 from executor(39)@67.195.138.8:41746 I0803 10:36:47.842094 526 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: cc9aea43-e0b6-4b61-87bb-bfe6c395975a) for task 0 of framework 201308031036-143311683-41746-417-0000 with checkpoint=false I0803 10:36:47.842154 526 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.842286 526 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: cc9aea43-e0b6-4b61-87bb-bfe6c395975a) for task 0 of framework 201308031036-143311683-41746-417-0000 to [email protected]:41746 I0803 10:36:47.842392 521 master.cpp:1103] Status update from slave(109)@67.195.138.8:41746: task 0 of framework 201308031036-143311683-41746-417-0000 is now in state TASK_RUNNING I0803 10:36:47.842413 526 slave.cpp:1831] Status update manager successfully handled status update TASK_RUNNING (UUID: cc9aea43-e0b6-4b61-87bb-bfe6c395975a) for task 0 of framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.842684 526 slave.cpp:1837] Sending acknowledgement for status update TASK_RUNNING (UUID: cc9aea43-e0b6-4b61-87bb-bfe6c395975a) for task 0 of framework 201308031036-143311683-41746-417-0000 to executor(39)@67.195.138.8:41746 I0803 10:36:47.842607 527 sched.cpp:395] Scheduler::statusUpdate took 30.382us I0803 10:36:47.842895 526 exec.cpp:320] Executor received status update acknowledgement cc9aea43-e0b6-4b61-87bb-bfe6c395975a for task 0 of framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.842967 417 master.cpp:446] Master terminating I0803 10:36:47.843060 417 master.cpp:209] Shutting down master I0803 10:36:47.843158 527 slave.cpp:1912] [email protected]:41746 exited W0803 10:36:47.843210 527 slave.cpp:1915] Master disconnected! Waiting for a new master to be elected I0803 10:36:47.843246 523 hierarchical_allocator_process.hpp:393] Deactivated framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.843353 526 status_update_manager.cpp:360] Received status update acknowledgement cc9aea43-e0b6-4b61-87bb-bfe6c395975a for task 0 of framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.843330 527 slave.cpp:1140] Asked to shut down framework 201308031036-143311683-41746-417-0000 by [email protected]:41746 I0803 10:36:47.843175 417 master.hpp:321] Removing task 0 with resources cpus(*):1; mem(*):500 on slave 201308031036-143311683-41746-417-0 I0803 10:36:47.843579 527 slave.cpp:1165] Shutting down framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.843672 527 slave.cpp:2356] Shutting down executor 'default' of framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.843732 526 hierarchical_allocator_process.hpp:595] Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000]) on slave 201308031036-143311683-41746-417-0 from framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.844022 527 slave.cpp:1371] Status update manager successfully handled status update acknowledgement cc9aea43-e0b6-4b61-87bb-bfe6c395975a for task 0 of framework 201308031036-143311683-41746-417-0000 I0803 10:36:47.843973 525 exec.cpp:360] Executor asked to shutdown I0803 10:36:47.844156 525 exec.cpp:375] Executor::shutdown took 11.683us I0803 10:36:47.845118 528 master.cpp:230] Master started on 67.195.138.8:41746 I0803 10:36:47.845180 528 master.cpp:245] Master ID: 201308031036-143311683-41746-417 I0803 10:36:47.846669 527 detector.cpp:420] Master detector (slave(109)@67.195.138.8:41746) found 0 registered masters I0803 10:36:47.853771 527 detector.cpp:441] Master detector (slave(109)@67.195.138.8:41746) couldn't find any masters I0803 10:36:47.847244 522 detector.cpp:234] Master detector ([email protected]:41746) connected to ZooKeeper ... I0803 10:36:47.854109 524 slave.cpp:571] Lost master(s) ... waiting I0803 10:36:47.854264 521 hierarchical_allocator_process.hpp:287] Initializing hierarchical allocator process with master : [email protected]:41746 I0803 10:36:47.854092 522 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0803 10:36:47.847229 525 detector.cpp:420] Master detector (scheduler(100)@67.195.138.8:41746) found 0 registered masters I0803 10:36:47.854590 525 detector.cpp:441] Master detector (scheduler(100)@67.195.138.8:41746) couldn't find any masters W0803 10:36:47.854013 527 master.cpp:83] No whitelist given. Advertising offers for all slaves I0803 10:36:47.854676 524 sched.cpp:202] No master detected, waiting for another master I0803 10:36:47.855216 524 sched.cpp:214] Scheduler::disconnected took 16.413us I0803 10:36:47.856523 522 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000006' I0803 10:36:47.857436 522 detector.cpp:420] Master detector ([email protected]:41746) found 1 registered masters I0803 10:36:47.857470 525 detector.cpp:420] Master detector (slave(109)@67.195.138.8:41746) found 1 registered masters I0803 10:36:47.857529 524 detector.cpp:420] Master detector (scheduler(100)@67.195.138.8:41746) found 1 registered masters I0803 10:36:47.862545 522 detector.cpp:467] Master detector ([email protected]:41746) got new master pid: [email protected]:41746 I0803 10:36:47.862799 527 master.cpp:593] Elected as master! I0803 10:36:47.862853 525 detector.cpp:467] Master detector (slave(109)@67.195.138.8:41746) got new master pid: [email protected]:41746 I0803 10:36:47.863018 524 detector.cpp:467] Master detector (scheduler(100)@67.195.138.8:41746) got new master pid: [email protected]:41746 I0803 10:36:47.863041 525 slave.cpp:537] New master detected at [email protected]:41746 I0803 10:36:47.863152 524 sched.cpp:178] New master at [email protected]:41746 I0803 10:36:47.863221 525 status_update_manager.cpp:155] New master detected at [email protected]:41746 I0803 10:36:47.863342 524 master.cpp:1044] Attempting to re-register slave 201308031036-143311683-41746-417-0 at slave(109)@67.195.138.8:41746 (minerva.apache.org) I0803 10:36:47.864042 524 master.cpp:1951] Adding slave 201308031036-143311683-41746-417-0 at minerva.apache.org with cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000] I0803 10:36:47.864202 524 master.hpp:309] Adding task 0 with resources cpus(*):1; mem(*):500 on slave 201308031036-143311683-41746-417-0 W0803 10:36:47.864253 524 master.cpp:2043] Possibly orphaned task 0 of framework 201308031036-143311683-41746-417-0000 running on slave 201308031036-143311683-41746-417-0 (minerva.apache.org) I0803 10:36:47.864342 525 slave.cpp:638] Re-registered with master [email protected]:41746 I0803 10:36:47.864610 524 hierarchical_allocator_process.hpp:430] Added slave 201308031036-143311683-41746-417-0 (minerva.apache.org) with cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000] (and cpus(*):1; mem(*):524; disk(*):21415; ports(*):[31000-32000] available) I0803 10:36:47.865012 524 hierarchical_allocator_process.hpp:666] Performed allocation for slave 201308031036-143311683-41746-417-0 in 11.56us I0803 10:36:48.835788 522 master.cpp:685] Re-registering framework 201308031036-143311683-41746-417-0000 at scheduler(100)@67.195.138.8:41746 I0803 10:36:48.836300 524 sched.cpp:268] Framework re-registered with 201308031036-143311683-41746-417-0000 W0803 10:36:48.836345 522 slave.cpp:1301] Ignoring updating pid for framework 201308031036-143311683-41746-417-0000 because it is terminating I0803 10:36:48.836490 524 sched.cpp:282] Scheduler::reregistered took 36.824us I0803 10:36:48.836611 521 hierarchical_allocator_process.hpp:317] Added framework 201308031036-143311683-41746-417-0000 I0803 10:36:48.836803 521 hierarchical_allocator_process.hpp:709] Offering cpus(*):1; mem(*):524; disk(*):21415; ports(*):[31000-32000] on slave 201308031036-143311683-41746-417-0 to framework 201308031036-143311683-41746-417-0000 I0803 10:36:48.836969 521 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 230.18us I0803 10:36:48.837051 522 master.hpp:331] Adding offer 201308031036-143311683-41746-417-0 with resources cpus(*):1; mem(*):524; disk(*):21415; ports(*):[31000-32000] on slave 201308031036-143311683-41746-417-0 I0803 10:36:48.837170 522 master.cpp:1332] Sending 1 offers to framework 201308031036-143311683-41746-417-0000 I0803 10:36:48.837396 521 sched.cpp:340] Scheduler::resourceOffers took 32.427us I0803 10:36:48.837674 417 master.cpp:446] Master terminating I0803 10:36:48.837743 417 master.cpp:209] Shutting down master I0803 10:36:48.837786 521 slave.cpp:493] Slave asked to shut down by [email protected]:41746 I0803 10:36:48.837884 417 master.hpp:321] Removing task 0 with resources cpus(*):1; mem(*):500 on slave 201308031036-143311683-41746-417-0 I0803 10:36:48.838198 417 master.hpp:341] Removing offer 201308031036-143311683-41746-417-0 with resources cpus(*):1; mem(*):524; disk(*):21415; ports(*):[31000-32000] on slave 201308031036-143311683-41746-417-0 I0803 10:36:48.837904 528 hierarchical_allocator_process.hpp:393] Deactivated framework 201308031036-143311683-41746-417-0000 I0803 10:36:48.837764 525 sched.cpp:498] Stopping framework '201308031036-143311683-41746-417-0000' I0803 10:36:48.838690 528 hierarchical_allocator_process.hpp:595] Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):1; mem(*):500) on slave 201308031036-143311683-41746-417-0 from framework 201308031036-143311683-41746-417-0000 I0803 10:36:48.837975 521 slave.cpp:1140] Asked to shut down framework 201308031036-143311683-41746-417-0000 by [email protected]:41746 I0803 10:36:48.838821 528 hierarchical_allocator_process.hpp:595] Recovered cpus(*):1; mem(*):524; disk(*):21415; ports(*):[31000-32000] (total allocatable: cpus(*):2; mem(*):1024; disk(*):21415; ports(*):[31000-32000]) on slave 201308031036-143311683-41746-417-0 from framework 201308031036-143311683-41746-417-0000 I0803 10:36:48.838940 528 hierarchical_allocator_process.hpp:348] Removed framework 201308031036-143311683-41746-417-0000 I0803 10:36:48.839006 528 hierarchical_allocator_process.hpp:456] Removed slave 201308031036-143311683-41746-417-0 W0803 10:36:48.838858 521 slave.cpp:1161] Ignoring shutdown framework 201308031036-143311683-41746-417-0000 because it is terminating I0803 10:36:48.839146 521 slave.cpp:1912] [email protected]:41746 exited W0803 10:36:48.839205 521 slave.cpp:1915] Master disconnected! Waiting for a new master to be elected I0803 10:36:48.839269 521 slave.cpp:1140] Asked to shut down framework 201308031036-143311683-41746-417-0000 by [email protected]:41746 W0803 10:36:48.839345 521 slave.cpp:1161] Ignoring shutdown framework 201308031036-143311683-41746-417-0000 because it is terminating I0803 10:36:48.839599 417 slave.cpp:448] Slave terminating I0803 10:36:48.839745 417 slave.cpp:1140] Asked to shut down framework 201308031036-143311683-41746-417-0000 by @0.0.0.0:0 W0803 10:36:48.839820 417 slave.cpp:1161] Ignoring shutdown framework 201308031036-143311683-41746-417-0000 because it is terminating pure virtual method called terminate called without an active exception make[3]: *** [check-local] Aborted make[3]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/src'> make[2]: *** [check-am] Error 2 make[2]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/src'> make[1]: *** [check] Error 2 make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/src'> make: *** [check-recursive] Error 1 Build step 'Execute shell' marked build as failure
