See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/1415/>
------------------------------------------ [...truncated 16692 lines...] W0923 08:45:52.508075 8747 slave.cpp:1976] Master disconnected! Waiting for a new master to be elected I0923 08:45:52.410184 8746 hierarchical_allocator_process.hpp:795] Filtered cpus(*):1; mem(*):524; disk(*):23038; ports(*):[31000-32000] on slave 201309230845-143311683-46591-8696-0 for framework 201309230845-143311683-46591-8696-0000 I0923 08:45:52.283272 8748 status_update_manager.cpp:375] Received status update acknowledgement (UUID: 1c6c6610-b3f2-4839-8bbb-a2f6d036c113) for task 0 of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:52.508153 8696 master.cpp:237] Removing slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:52.550254 8749 master.cpp:80] No whitelist given. Advertising offers for all slaves I0923 08:45:52.613034 8746 hierarchical_allocator_process.hpp:649] Performed allocation for 1 slaves in 202.939952ms I0923 08:45:52.617588 8750 monitor.cpp:187] Publishing resource usage for executor 'default' of framework '201309230845-143311683-46591-8696-0000' I0923 08:45:52.718722 8748 slave.cpp:1386] Status update manager successfully handled status update acknowledgement (UUID: 1c6c6610-b3f2-4839-8bbb-a2f6d036c113) for task 0 of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:53.029387 8745 master.cpp:265] Master started on 67.195.138.8:46591 I0923 08:45:53.030822 8751 detector.cpp:420] Master detector (scheduler(113)@67.195.138.8:46591) found 0 registered masters I0923 08:45:53.031088 8752 detector.cpp:420] Master detector (slave(131)@67.195.138.8:46591) found 0 registered masters I0923 08:45:53.031883 8746 detector.cpp:234] Master detector ([email protected]:46591) connected to ZooKeeper ... I0923 08:45:53.334519 8745 master.cpp:280] Master ID: 201309230845-143311683-46591-8696 I0923 08:45:53.435017 8747 master.cpp:80] No whitelist given. Advertising offers for all slaves I0923 08:45:53.434532 8752 detector.cpp:441] Master detector (slave(131)@67.195.138.8:46591) couldn't find any masters I0923 08:45:53.434651 8746 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0923 08:45:53.434360 8751 detector.cpp:441] Master detector (scheduler(113)@67.195.138.8:46591) couldn't find any masters I0923 08:45:53.435122 8750 hierarchical_allocator_process.hpp:291] Initializing hierarchical allocator process with master : [email protected]:46591 I0923 08:45:53.537338 8752 slave.cpp:577] Lost master(s) ... waiting I0923 08:45:53.639896 8751 sched.cpp:202] No master detected, waiting for another master I0923 08:45:53.641970 8746 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000002' I0923 08:45:53.642385 8750 detector.cpp:420] Master detector (scheduler(113)@67.195.138.8:46591) found 1 registered masters I0923 08:45:53.642544 8749 detector.cpp:420] Master detector (slave(131)@67.195.138.8:46591) found 1 registered masters I0923 08:45:53.742812 8751 sched.cpp:214] Scheduler::disconnected took 12.363us I0923 08:45:53.851572 8746 detector.cpp:420] Master detector ([email protected]:46591) found 1 registered masters I0923 08:45:53.851785 8750 detector.cpp:467] Master detector (scheduler(113)@67.195.138.8:46591) got new master pid: [email protected]:46591 I0923 08:45:53.956995 8749 detector.cpp:467] Master detector (slave(131)@67.195.138.8:46591) got new master pid: [email protected]:46591 I0923 08:45:54.259474 8750 sched.cpp:178] New master at [email protected]:46591 I0923 08:45:54.154683 8746 detector.cpp:467] Master detector ([email protected]:46591) got new master pid: [email protected]:46591 I0923 08:45:54.134974 8748 monitor.cpp:187] Publishing resource usage for executor 'default' of framework '201309230845-143311683-46591-8696-0000' I0923 08:45:54.259567 8745 slave.cpp:543] New master detected at [email protected]:46591 W0923 08:45:54.358511 8750 master.cpp:716] Ignoring re-register framework message since not elected yet I0923 08:45:54.567224 8747 status_update_manager.cpp:157] New master detected at [email protected]:46591 I0923 08:45:54.640384 8751 hierarchical_allocator_process.hpp:687] No resources available to allocate! I0923 08:45:54.666934 8750 master.cpp:644] Elected as master! I0923 08:45:54.769155 8751 hierarchical_allocator_process.hpp:649] Performed allocation for 0 slaves in 128.782782ms I0923 08:45:55.359381 8750 master.cpp:736] Re-registering framework 201309230845-143311683-46591-8696-0000 at scheduler(113)@67.195.138.8:46591 I0923 08:45:55.359658 8751 sched.cpp:237] Framework registered with 201309230845-143311683-46591-8696-0000 I0923 08:45:55.359774 8749 hierarchical_allocator_process.hpp:321] Added framework 201309230845-143311683-46591-8696-0000 I0923 08:45:55.558708 8749 hierarchical_allocator_process.hpp:687] No resources available to allocate! I0923 08:45:55.467653 8745 monitor.cpp:187] Publishing resource usage for executor 'default' of framework '201309230845-143311683-46591-8696-0000' I0923 08:45:55.459558 8751 sched.cpp:251] Scheduler::registered took 11.037us I0923 08:45:55.567773 8750 master.cpp:1175] Attempting to re-register slave 201309230845-143311683-46591-8696-0 at slave(131)@67.195.138.8:46591 (minerva.apache.org) I0923 08:45:55.663570 8749 hierarchical_allocator_process.hpp:649] Performed allocation for 0 slaves in 104.862893ms I0923 08:45:55.869078 8750 master.cpp:2165] Adding slave 201309230845-143311683-46591-8696-0 at minerva.apache.org with cpus(*):2; mem(*):1024; disk(*):23038; ports(*):[31000-32000] I0923 08:45:56.072821 8750 master.hpp:321] Adding task 0 with resources cpus(*):1; mem(*):500 on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:56.072815 8746 slave.cpp:644] Re-registered with master [email protected]:46591 I0923 08:45:56.334023 8746 slave.cpp:1332] Updating framework 201309230845-143311683-46591-8696-0000 pid to scheduler(113)@67.195.138.8:46591 I0923 08:45:55.973088 8752 hierarchical_allocator_process.hpp:687] No resources available to allocate! I0923 08:45:56.441958 8752 hierarchical_allocator_process.hpp:649] Performed allocation for 0 slaves in 468.879709ms I0923 08:45:56.544045 8752 hierarchical_allocator_process.hpp:434] Added slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) with cpus(*):2; mem(*):1024; disk(*):23038; ports(*):[31000-32000] (and cpus(*):1; mem(*):524; disk(*):23038; ports(*):[31000-32000] available) I0923 08:45:56.643098 8752 hierarchical_allocator_process.hpp:712] Offering cpus(*):1; mem(*):524; disk(*):23038; ports(*):[31000-32000] on slave 201309230845-143311683-46591-8696-0 to framework 201309230845-143311683-46591-8696-0000 I0923 08:45:56.749024 8752 hierarchical_allocator_process.hpp:669] Performed allocation for slave 201309230845-143311683-46591-8696-0 in 105.981367ms I0923 08:45:56.749112 8745 master.hpp:347] Adding offer 201309230845-143311683-46591-8696-0 with resources cpus(*):1; mem(*):524; disk(*):23038; ports(*):[31000-32000] on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:56.763484 8751 monitor.cpp:187] Publishing resource usage for executor 'default' of framework '201309230845-143311683-46591-8696-0000' I0923 08:45:56.802074 8745 master.cpp:1462] Sending 1 offers to framework 201309230845-143311683-46591-8696-0000 I0923 08:45:56.802436 8747 sched.cpp:340] Scheduler::resourceOffers took 27.123us I0923 08:45:56.802701 8746 sched.cpp:498] Stopping framework '201309230845-143311683-46591-8696-0000' I0923 08:45:56.802736 8696 master.cpp:481] Master terminating I0923 08:45:56.802912 8696 master.cpp:206] Shutting down master I0923 08:45:56.802922 8749 slave.cpp:1973] [email protected]:46591 exited I0923 08:45:56.803045 8696 master.hpp:337] Removing task 0 with resources cpus(*):1; mem(*):500 on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:56.803262 8696 master.hpp:357] Removing offer 201309230845-143311683-46591-8696-0 with resources cpus(*):1; mem(*):524; disk(*):23038; ports(*):[31000-32000] on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:56.803443 8750 hierarchical_allocator_process.hpp:598] Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):1; mem(*):500) on slave 201309230845-143311683-46591-8696-0 from framework 201309230845-143311683-46591-8696-0000 I0923 08:45:56.803472 8696 master.cpp:237] Removing slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) W0923 08:45:56.803094 8749 slave.cpp:1976] Master disconnected! Waiting for a new master to be elected I0923 08:45:56.804303 8746 slave.cpp:454] Slave terminating I0923 08:45:56.804419 8746 slave.cpp:1167] Asked to shut down framework 201309230845-143311683-46591-8696-0000 by @0.0.0.0:0 I0923 08:45:56.849917 8746 slave.cpp:1192] Shutting down framework 201309230845-143311683-46591-8696-0000 I0923 08:45:56.850060 8746 slave.cpp:2426] Shutting down executor 'default' of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:56.805634 8747 detector.cpp:420] Master detector (slave(131)@67.195.138.8:46591) found 0 registered masters I0923 08:45:56.850291 8746 exec.cpp:371] Executor asked to shutdown I0923 08:45:56.850294 8747 detector.cpp:441] Master detector (slave(131)@67.195.138.8:46591) couldn't find any masters GMOCK WARNING: Uninteresting mock function call - returning directly. Function call: shutdown(0x2b757802a350) Stack trace: I0923 08:45:56.850553 8746 exec.cpp:386] Executor::shutdown took 146.457us [ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (10124 ms) [ RUN ] AllocatorZooKeeperTest/0.SlaveReregistersFirst I0923 08:45:56.851671 8752 master.cpp:265] Master started on 67.195.138.8:46591 2013-09-23 08:45:56,852:8696(0x2b766d577700):ZOO_INFO@check_events@1585: initiated connection to server [127.0.0.1:46202] 2013-09-23 08:45:56,852:8696(0x2b755e9be700):ZOO_INFO@log_env@658: Client environment:zookeeper.version=zookeeper C client 3.3.4 2013-09-23 08:45:56,852:8696(0x2b755e9be700):ZOO_INFO@log_env@662: Client environment:host.name=minerva 2013-09-23 08:45:56,852:8696(0x2b755e9be700):ZOO_INFO@log_env@669: Client environment:os.name=Linux 2013-09-23 08:45:56,852:8696(0x2b755e9be700):ZOO_INFO@log_env@670: Client environment:os.arch=3.2.0-51-generic 2013-09-23 08:45:56,852:8696(0x2b755e9be700):ZOO_INFO@log_env@671: Client environment:os.version=#77-Ubuntu SMP Wed Jul 24 20:18:19 UTC 2013 I0923 08:45:56.851791 8752 master.cpp:280] Master ID: 201309230845-143311683-46591-8696 I0923 08:45:56.852435 8748 slave.cpp:108] Slave started on 132)@67.195.138.8:46591 I0923 08:45:56.853907 8751 detector.cpp:234] Master detector ([email protected]:46591) connected to ZooKeeper ... I0923 08:45:56.862184 8749 master.cpp:80] No whitelist given. Advertising offers for all slaves I0923 08:45:56.855181 8746 detector.cpp:234] Master detector (scheduler(114)@67.195.138.8:46591) connected to ZooKeeper ... I0923 08:45:56.862109 8748 slave.cpp:208] Slave resources: cpus(*):2; mem(*):1024; disk(*):23038; ports(*):[31000-32000] I0923 08:45:56.854694 8745 detector.cpp:234] Master detector (slave(132)@67.195.138.8:46591) connected to ZooKeeper ... I0923 08:45:56.862197 8751 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0923 08:45:56.862259 8747 hierarchical_allocator_process.hpp:291] Initializing hierarchical allocator process with master : [email protected]:46591 I0923 08:45:56.862447 8746 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0923 08:45:56.862705 8745 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0923 08:45:56.863399 8750 slave.cpp:399] Finished recovery I0923 08:45:56.864497 8751 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000004' I0923 08:45:56.864840 8745 detector.cpp:420] Master detector (slave(132)@67.195.138.8:46591) found 1 registered masters I0923 08:45:56.865110 8751 detector.cpp:420] Master detector ([email protected]:46591) found 1 registered masters I0923 08:45:56.865284 8746 detector.cpp:420] Master detector (scheduler(114)@67.195.138.8:46591) found 1 registered masters I0923 08:45:56.966410 8745 detector.cpp:467] Master detector (slave(132)@67.195.138.8:46591) got new master pid: [email protected]:46591 I0923 08:45:56.966583 8745 slave.cpp:543] New master detected at [email protected]:46591 I0923 08:45:56.966725 8749 status_update_manager.cpp:157] New master detected at [email protected]:46591 I0923 08:45:56.966856 8751 detector.cpp:467] Master detector ([email protected]:46591) got new master pid: [email protected]:46591 I0923 08:45:56.966979 8746 detector.cpp:467] Master detector (scheduler(114)@67.195.138.8:46591) got new master pid: [email protected]:46591 W0923 08:45:56.966749 8745 master.cpp:1044] Ignoring register slave message from minerva.apache.org since not elected yet I0923 08:45:56.967242 8750 sched.cpp:178] New master at [email protected]:46591 I0923 08:45:56.967278 8745 master.cpp:644] Elected as master! I0923 08:45:56.967560 8745 master.cpp:694] Registering framework 201309230845-143311683-46591-8696-0000 at scheduler(114)@67.195.138.8:46591 I0923 08:45:56.967706 8746 sched.cpp:237] Framework registered with 201309230845-143311683-46591-8696-0000 I0923 08:45:56.967721 8745 hierarchical_allocator_process.hpp:321] Added framework 201309230845-143311683-46591-8696-0000 I0923 08:45:56.967844 8746 sched.cpp:251] Scheduler::registered took 13.804us I0923 08:45:56.967967 8745 hierarchical_allocator_process.hpp:687] No resources available to allocate! I0923 08:45:56.968215 8745 hierarchical_allocator_process.hpp:649] Performed allocation for 0 slaves in 249.481us I0923 08:45:57.863420 8749 hierarchical_allocator_process.hpp:687] No resources available to allocate! I0923 08:45:57.863625 8749 hierarchical_allocator_process.hpp:649] Performed allocation for 0 slaves in 214.565us I0923 08:45:57.967818 8748 master.cpp:1075] Attempting to register slave on minerva.apache.org at slave(132)@67.195.138.8:46591 I0923 08:45:57.968011 8748 master.cpp:2165] Adding slave 201309230845-143311683-46591-8696-0 at minerva.apache.org with cpus(*):2; mem(*):1024; disk(*):23038; ports(*):[31000-32000] I0923 08:45:57.968221 8749 slave.cpp:603] Registered with master [email protected]:46591; given slave ID 201309230845-143311683-46591-8696-0 I0923 08:45:57.968400 8750 hierarchical_allocator_process.hpp:434] Added slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) with cpus(*):2; mem(*):1024; disk(*):23038; ports(*):[31000-32000] (and cpus(*):2; mem(*):1024; disk(*):23038; ports(*):[31000-32000] available) I0923 08:45:57.968576 8750 hierarchical_allocator_process.hpp:712] Offering cpus(*):2; mem(*):1024; disk(*):23038; ports(*):[31000-32000] on slave 201309230845-143311683-46591-8696-0 to framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.968763 8750 hierarchical_allocator_process.hpp:669] Performed allocation for slave 201309230845-143311683-46591-8696-0 in 236.49us I0923 08:45:57.968822 8749 master.hpp:347] Adding offer 201309230845-143311683-46591-8696-0 with resources cpus(*):2; mem(*):1024; disk(*):23038; ports(*):[31000-32000] on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:57.969027 8749 master.cpp:1462] Sending 1 offers to framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.969410 8748 sched.cpp:340] Scheduler::resourceOffers took 178.852us I0923 08:45:57.969645 8749 master.cpp:1699] Processing reply for offer 201309230845-143311683-46591-8696-0 on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) for framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.969866 8749 master.hpp:321] Adding task 0 with resources cpus(*):1; mem(*):500 on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:57.969951 8749 master.cpp:1823] Launching task 0 of framework 201309230845-143311683-46591-8696-0000 with resources cpus(*):1; mem(*):500 on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:57.970116 8752 slave.cpp:772] Got assigned task 0 for framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.970172 8748 hierarchical_allocator_process.hpp:508] Framework 201309230845-143311683-46591-8696-0000 left cpus(*):1; mem(*):524; disk(*):23038; ports(*):[31000-32000] unused on slave 201309230845-143311683-46591-8696-0 I0923 08:45:57.970202 8749 master.hpp:357] Removing offer 201309230845-143311683-46591-8696-0 with resources cpus(*):2; mem(*):1024; disk(*):23038; ports(*):[31000-32000] on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:57.970448 8748 hierarchical_allocator_process.hpp:551] Framework 201309230845-143311683-46591-8696-0000 filtered slave 201309230845-143311683-46591-8696-0 for 5secs I0923 08:45:57.970509 8752 slave.cpp:883] Launching task 0 for framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.972251 8752 slave.cpp:994] Queuing task '0' for executor default of framework '201309230845-143311683-46591-8696-0000 I0923 08:45:57.972401 8745 slave.cpp:525] Successfully attached file '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_2MwvM9/slaves/201309230845-143311683-46591-8696-0/frameworks/201309230845-143311683-46591-8696-0000/executors/default/runs/c3f27520-50d9-470f-9be0-8d05236a54e1' I0923 08:45:57.973664 8752 exec.cpp:174] Executor started at: executor(41)@67.195.138.8:46591 with pid 8696 I0923 08:45:57.973891 8752 slave.cpp:1440] Got registration for executor 'default' of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.974123 8752 slave.cpp:1561] Flushing queued task 0 for executor 'default' of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.974144 8746 exec.cpp:198] Executor registered on slave 201309230845-143311683-46591-8696-0 I0923 08:45:57.975507 8746 exec.cpp:210] Executor::registered took 19.743us I0923 08:45:57.975661 8746 exec.cpp:285] Executor asked to run task '0' I0923 08:45:57.975759 8746 exec.cpp:294] Executor::launchTask took 28.124us I0923 08:45:57.976946 8746 exec.cpp:501] Executor sending status update TASK_RUNNING (UUID: 629a6cde-378e-4a62-b488-67323af7cb5e) for task 0 of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.977098 8746 slave.cpp:1773] Handling status update TASK_RUNNING (UUID: 629a6cde-378e-4a62-b488-67323af7cb5e) for task 0 of framework 201309230845-143311683-46591-8696-0000 from executor(41)@67.195.138.8:46591 I0923 08:45:57.977277 8746 status_update_manager.cpp:300] Received status update TASK_RUNNING (UUID: 629a6cde-378e-4a62-b488-67323af7cb5e) for task 0 of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.977390 8746 status_update_manager.cpp:471] Creating StatusUpdate stream for task 0 of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.977578 8746 status_update_manager.cpp:351] Forwarding status update TASK_RUNNING (UUID: 629a6cde-378e-4a62-b488-67323af7cb5e) for task 0 of framework 201309230845-143311683-46591-8696-0000 to [email protected]:46591 I0923 08:45:57.977823 8748 slave.cpp:1892] Status update manager successfully handled status update TASK_RUNNING (UUID: 629a6cde-378e-4a62-b488-67323af7cb5e) for task 0 of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.977814 8749 master.cpp:1274] Status update TASK_RUNNING (UUID: 629a6cde-378e-4a62-b488-67323af7cb5e) for task 0 of framework 201309230845-143311683-46591-8696-0000 from slave(132)@67.195.138.8:46591 I0923 08:45:57.977921 8745 sched.cpp:395] Scheduler::statusUpdate took 45.578us I0923 08:45:57.977973 8748 slave.cpp:1898] Sending acknowledgement for status update TASK_RUNNING (UUID: 629a6cde-378e-4a62-b488-67323af7cb5e) for task 0 of framework 201309230845-143311683-46591-8696-0000 to executor(41)@67.195.138.8:46591 I0923 08:45:57.978294 8746 master.cpp:481] Master terminating I0923 08:45:57.978296 8750 exec.cpp:331] Executor received status update acknowledgement 629a6cde-378e-4a62-b488-67323af7cb5e for task 0 of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.978409 8748 status_update_manager.cpp:375] Received status update acknowledgement (UUID: 629a6cde-378e-4a62-b488-67323af7cb5e) for task 0 of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.978425 8746 slave.cpp:1973] [email protected]:46591 exited I0923 08:45:57.978482 8696 master.cpp:206] Shutting down master W0923 08:45:57.978682 8746 slave.cpp:1976] Master disconnected! Waiting for a new master to be elected I0923 08:45:57.978929 8696 master.hpp:337] Removing task 0 with resources cpus(*):1; mem(*):500 on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:57.979038 8746 slave.cpp:1386] Status update manager successfully handled status update acknowledgement (UUID: 629a6cde-378e-4a62-b488-67323af7cb5e) for task 0 of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.979305 8696 master.cpp:237] Removing slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:57.979315 8748 hierarchical_allocator_process.hpp:598] Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):2; mem(*):1024; disk(*):23038; ports(*):[31000-32000]) on slave 201309230845-143311683-46591-8696-0 from framework 201309230845-143311683-46591-8696-0000 I0923 08:45:57.980429 8752 master.cpp:265] Master started on 67.195.138.8:46591 I0923 08:45:57.980545 8752 master.cpp:280] Master ID: 201309230845-143311683-46591-8696 I0923 08:45:57.981048 8752 master.cpp:80] No whitelist given. Advertising offers for all slaves I0923 08:45:57.981575 8749 hierarchical_allocator_process.hpp:291] Initializing hierarchical allocator process with master : [email protected]:46591 I0923 08:45:57.981808 8746 detector.cpp:420] Master detector (slave(132)@67.195.138.8:46591) found 0 registered masters I0923 08:45:57.981914 8751 detector.cpp:420] Master detector (scheduler(114)@67.195.138.8:46591) found 0 registered masters I0923 08:45:57.982938 8748 detector.cpp:234] Master detector ([email protected]:46591) connected to ZooKeeper ... I0923 08:45:57.989984 8746 detector.cpp:441] Master detector (slave(132)@67.195.138.8:46591) couldn't find any masters I0923 08:45:57.990103 8751 detector.cpp:441] Master detector (scheduler(114)@67.195.138.8:46591) couldn't find any masters I0923 08:45:57.990221 8748 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0923 08:45:57.990340 8746 slave.cpp:577] Lost master(s) ... waiting I0923 08:45:57.990461 8751 sched.cpp:202] No master detected, waiting for another master I0923 08:45:57.990731 8751 sched.cpp:214] Scheduler::disconnected took 10.282us I0923 08:45:57.992048 8748 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000006' I0923 08:45:57.992529 8750 detector.cpp:420] Master detector (scheduler(114)@67.195.138.8:46591) found 1 registered masters I0923 08:45:57.992655 8745 detector.cpp:420] Master detector (slave(132)@67.195.138.8:46591) found 1 registered masters I0923 08:45:57.992820 8748 detector.cpp:420] Master detector ([email protected]:46591) found 1 registered masters I0923 08:45:57.998621 8750 detector.cpp:467] Master detector (scheduler(114)@67.195.138.8:46591) got new master pid: [email protected]:46591 I0923 08:45:57.998790 8750 sched.cpp:178] New master at [email protected]:46591 I0923 08:45:58.006651 8745 detector.cpp:467] Master detector (slave(132)@67.195.138.8:46591) got new master pid: [email protected]:46591 I0923 08:45:58.006748 8748 detector.cpp:467] Master detector ([email protected]:46591) got new master pid: [email protected]:46591 I0923 08:45:58.006867 8745 slave.cpp:543] New master detected at [email protected]:46591 I0923 08:45:58.007128 8747 status_update_manager.cpp:157] New master detected at [email protected]:46591 I0923 08:45:58.007132 8748 master.cpp:644] Elected as master! I0923 08:45:58.007411 8748 master.cpp:1175] Attempting to re-register slave 201309230845-143311683-46591-8696-0 at slave(132)@67.195.138.8:46591 (minerva.apache.org) I0923 08:45:58.007486 8748 master.cpp:2165] Adding slave 201309230845-143311683-46591-8696-0 at minerva.apache.org with cpus(*):2; mem(*):1024; disk(*):23038; ports(*):[31000-32000] I0923 08:45:58.007632 8750 slave.cpp:644] Re-registered with master [email protected]:46591 I0923 08:45:58.007668 8748 master.hpp:321] Adding task 0 with resources cpus(*):1; mem(*):500 on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) W0923 08:45:58.007863 8748 master.cpp:2260] Possibly orphaned task 0 of framework 201309230845-143311683-46591-8696-0000 running on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:58.008270 8750 hierarchical_allocator_process.hpp:434] Added slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) with cpus(*):2; mem(*):1024; disk(*):23038; ports(*):[31000-32000] (and cpus(*):1; mem(*):524; disk(*):23038; ports(*):[31000-32000] available) I0923 08:45:58.008430 8750 hierarchical_allocator_process.hpp:669] Performed allocation for slave 201309230845-143311683-46591-8696-0 in 10.88us I0923 08:45:58.974123 8748 monitor.cpp:187] Publishing resource usage for executor 'default' of framework '201309230845-143311683-46591-8696-0000' I0923 08:45:58.990077 8745 hierarchical_allocator_process.hpp:649] Performed allocation for 1 slaves in 23.177us I0923 08:45:59.007256 8747 master.cpp:736] Re-registering framework 201309230845-143311683-46591-8696-0000 at scheduler(114)@67.195.138.8:46591 I0923 08:45:59.007573 8750 sched.cpp:237] Framework registered with 201309230845-143311683-46591-8696-0000 I0923 08:45:59.007601 8747 slave.cpp:1332] Updating framework 201309230845-143311683-46591-8696-0000 pid to scheduler(114)@67.195.138.8:46591 I0923 08:45:59.007685 8751 hierarchical_allocator_process.hpp:321] Added framework 201309230845-143311683-46591-8696-0000 I0923 08:45:59.007743 8750 sched.cpp:251] Scheduler::registered took 9.852us I0923 08:45:59.008045 8751 hierarchical_allocator_process.hpp:712] Offering cpus(*):1; mem(*):524; disk(*):23038; ports(*):[31000-32000] on slave 201309230845-143311683-46591-8696-0 to framework 201309230845-143311683-46591-8696-0000 I0923 08:45:59.008388 8751 hierarchical_allocator_process.hpp:649] Performed allocation for 1 slaves in 379.579us I0923 08:45:59.008484 8748 master.hpp:347] Adding offer 201309230845-143311683-46591-8696-0 with resources cpus(*):1; mem(*):524; disk(*):23038; ports(*):[31000-32000] on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:59.008626 8748 master.cpp:1462] Sending 1 offers to framework 201309230845-143311683-46591-8696-0000 I0923 08:45:59.008903 8748 sched.cpp:340] Scheduler::resourceOffers took 33.323us I0923 08:45:59.009194 8745 master.cpp:481] Master terminating I0923 08:45:59.009194 8752 sched.cpp:498] Stopping framework '201309230845-143311683-46591-8696-0000' I0923 08:45:59.009304 8745 slave.cpp:1973] [email protected]:46591 exited I0923 08:45:59.009346 8696 master.cpp:206] Shutting down master W0923 08:45:59.009517 8745 slave.cpp:1976] Master disconnected! Waiting for a new master to be elected I0923 08:45:59.009752 8696 master.hpp:337] Removing task 0 with resources cpus(*):1; mem(*):500 on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:59.010061 8696 master.hpp:357] Removing offer 201309230845-143311683-46591-8696-0 with resources cpus(*):1; mem(*):524; disk(*):23038; ports(*):[31000-32000] on slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:59.010162 8745 hierarchical_allocator_process.hpp:598] Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):1; mem(*):500) on slave 201309230845-143311683-46591-8696-0 from framework 201309230845-143311683-46591-8696-0000 I0923 08:45:59.010236 8696 master.cpp:237] Removing slave 201309230845-143311683-46591-8696-0 (minerva.apache.org) I0923 08:45:59.018611 8696 slave.cpp:454] Slave terminating I0923 08:45:59.018726 8696 slave.cpp:1167] Asked to shut down framework 201309230845-143311683-46591-8696-0000 by @0.0.0.0:0 I0923 08:45:59.018832 8696 slave.cpp:1192] Shutting down framework 201309230845-143311683-46591-8696-0000 I0923 08:45:59.018913 8696 slave.cpp:2426] Shutting down executor 'default' of framework 201309230845-143311683-46591-8696-0000 I0923 08:45:59.019767 8752 detector.cpp:420] Master detector (slave(132)@67.195.138.8:46591) found 0 registered masters I0923 08:45:59.025933 8751 exec.cpp:371] Executor asked to shutdown GMOCK WARNING: Uninteresting mock function call - returning directly. Function call: shutdown(0x2b757c034e10) Stack trace: I0923 08:45:59.026016 8752 detector.cpp:441] Master detector (slave(132)@67.195.138.8:46591) couldn't find any masters I0923 08:45:59.026128 8751 exec.cpp:386] Executor::shutdown took 22.518us [ OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (2176 ms) I0923 08:45:59.028117 8696 zookeeper_test_server.cpp:93] Shutdown ZooKeeperTestServer on port 46202 [----------] 2 tests from AllocatorZooKeeperTest/0 (12300 ms total) [----------] Global test environment tear-down [==========] 220 tests from 39 test cases ran. (129805 ms total) [ PASSED ] 219 tests. [ FAILED ] 1 test, listed below: [ FAILED ] CoordinatorTest.MultipleAppendsNotLearnedFill 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
