See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/1069/>
------------------------------------------ [...truncated 14374 lines...] I0608 13:18:47.526329 24158 slave.cpp:1877] [email protected]:36500 exited W0608 13:18:47.526396 24158 slave.cpp:1880] Master disconnected! Waiting for a new master to be elected I0608 13:18:47.526444 24136 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306081318-143311683-36500-24136-0 I0608 13:18:47.526417 24160 hierarchical_allocator_process.hpp:412] Deactivated framework 201306081318-143311683-36500-24136-0000 I0608 13:18:47.526505 24158 slave.cpp:1110] Asked to shut down framework 201306081318-143311683-36500-24136-0000 by [email protected]:36500 I0608 13:18:47.526681 24158 slave.cpp:1135] Shutting down framework 201306081318-143311683-36500-24136-0000 I0608 13:18:47.526744 24158 slave.cpp:2312] Shutting down executor 'default' of framework 201306081318-143311683-36500-24136-0000 I0608 13:18:47.526757 24160 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=19715) on slave 201306081318-143311683-36500-24136-0 from framework 201306081318-143311683-36500-24136-0000 I0608 13:18:47.526840 24159 exec.cpp:323] Executor asked to shutdown I0608 13:18:47.527650 24157 master.cpp:228] Master started on 67.195.138.8:36500 I0608 13:18:47.527716 24157 master.cpp:243] Master ID: 201306081318-143311683-36500-24136 I0608 13:18:47.528846 24162 detector.cpp:420] Master detector (slave(97)@67.195.138.8:36500) found 0 registered masters I0608 13:18:47.529000 24159 detector.cpp:420] Master detector (scheduler(88)@67.195.138.8:36500) found 0 registered masters I0608 13:18:47.529635 24160 detector.cpp:234] Master detector ([email protected]:36500) connected to ZooKeeper ... W0608 13:18:47.533725 24158 master.cpp:83] No whitelist given. Advertising offers for all slaves I0608 13:18:47.533711 24162 detector.cpp:441] Master detector (slave(97)@67.195.138.8:36500) couldn't find any masters I0608 13:18:47.533800 24159 detector.cpp:441] Master detector (scheduler(88)@67.195.138.8:36500) couldn't find any masters I0608 13:18:47.533846 24160 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0608 13:18:47.534158 24159 sched.cpp:194] No master detected, waiting for another master I0608 13:18:47.534102 24162 slave.cpp:571] Lost master(s) ... waiting I0608 13:18:47.533844 24156 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:36500 I0608 13:18:47.535989 24160 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000002' I0608 13:18:47.536172 24161 detector.cpp:420] Master detector (slave(97)@67.195.138.8:36500) found 1 registered masters I0608 13:18:47.536295 24157 detector.cpp:420] Master detector (scheduler(88)@67.195.138.8:36500) found 1 registered masters I0608 13:18:47.536624 24160 detector.cpp:420] Master detector ([email protected]:36500) found 1 registered masters I0608 13:18:47.542150 24161 detector.cpp:467] Master detector (slave(97)@67.195.138.8:36500) got new master pid: [email protected]:36500 I0608 13:18:47.542263 24161 slave.cpp:537] New master detected at [email protected]:36500 I0608 13:18:47.542377 24161 status_update_manager.cpp:155] New master detected at [email protected]:36500 I0608 13:18:47.542388 24157 detector.cpp:467] Master detector (scheduler(88)@67.195.138.8:36500) got new master pid: [email protected]:36500 I0608 13:18:47.542500 24160 detector.cpp:467] Master detector ([email protected]:36500) got new master pid: [email protected]:36500 I0608 13:18:47.542608 24157 sched.cpp:177] New master at [email protected]:36500 I0608 13:18:47.542687 24160 master.cpp:526] Elected as master! I0608 13:18:47.542739 24160 master.cpp:604] Re-registering framework 201306081318-143311683-36500-24136-0000 at scheduler(88)@67.195.138.8:36500 I0608 13:18:47.542920 24157 sched.cpp:246] Framework re-registered with 201306081318-143311683-36500-24136-0000 I0608 13:18:47.542981 24160 hierarchical_allocator_process.hpp:327] Added framework 201306081318-143311683-36500-24136-0000 I0608 13:18:47.543015 24160 hierarchical_allocator_process.hpp:705] No resources available to allocate! I0608 13:18:47.543076 24160 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 63.285us I0608 13:18:48.519882 24158 master.cpp:963] Attempting to re-register slave 201306081318-143311683-36500-24136-0 at slave(97)@67.195.138.8:36500 (minerva.apache.org) I0608 13:18:48.519925 24158 master.cpp:1851] Adding slave 201306081318-143311683-36500-24136-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=19715 I0608 13:18:48.520117 24156 slave.cpp:633] Re-registered with master [email protected]:36500 I0608 13:18:48.520139 24158 master.hpp:291] Adding task 0 with resources cpus=1; mem=500 on slave 201306081318-143311683-36500-24136-0 W0608 13:18:48.520417 24161 slave.cpp:1271] Ignoring updating pid for framework 201306081318-143311683-36500-24136-0000 because it is terminating I0608 13:18:48.520560 24159 hierarchical_allocator_process.hpp:449] Added slave 201306081318-143311683-36500-24136-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=19715 (and cpus=1; mem=524; ports=[31000-32000]; disk=19715 available) I0608 13:18:48.520670 24159 hierarchical_allocator_process.hpp:727] Offering cpus=1; mem=524; ports=[31000-32000]; disk=19715 on slave 201306081318-143311683-36500-24136-0 to framework 201306081318-143311683-36500-24136-0000 I0608 13:18:48.520823 24159 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306081318-143311683-36500-24136-0 in 169.888us I0608 13:18:48.520927 24157 master.hpp:313] Adding offer 201306081318-143311683-36500-24136-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=19715 on slave 201306081318-143311683-36500-24136-0 I0608 13:18:48.520998 24157 master.cpp:1239] Sending 1 offers to framework 201306081318-143311683-36500-24136-0000 I0608 13:18:48.521106 24156 sched.cpp:287] Received 1 offers I0608 13:18:48.521469 24156 sched.cpp:427] Stopping framework '201306081318-143311683-36500-24136-0000' I0608 13:18:48.521481 24136 master.cpp:385] Master terminating I0608 13:18:48.521713 24136 master.cpp:207] Shutting down master I0608 13:18:48.521783 24136 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306081318-143311683-36500-24136-0 I0608 13:18:48.521821 24162 slave.cpp:493] Slave asked to shut down by [email protected]:36500 I0608 13:18:48.521893 24136 master.hpp:323] Removing offer 201306081318-143311683-36500-24136-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=19715 on slave 201306081318-143311683-36500-24136-0 I0608 13:18:48.522002 24162 slave.cpp:1110] Asked to shut down framework 201306081318-143311683-36500-24136-0000 by [email protected]:36500 W0608 13:18:48.522119 24162 slave.cpp:1131] Ignoring shutdown framework 201306081318-143311683-36500-24136-0000 because it is terminating I0608 13:18:48.522181 24163 hierarchical_allocator_process.hpp:412] Deactivated framework 201306081318-143311683-36500-24136-0000 I0608 13:18:48.527122 24160 detector.cpp:420] Master detector (slave(97)@67.195.138.8:36500) found 0 registered masters I0608 13:18:48.533745 24160 detector.cpp:441] Master detector (slave(97)@67.195.138.8:36500) couldn't find any masters I0608 13:18:48.533807 24163 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201306081318-143311683-36500-24136-0 from framework 201306081318-143311683-36500-24136-0000 I0608 13:18:48.533640 24162 slave.cpp:448] Slave terminating I0608 13:18:48.533943 24162 slave.cpp:1110] Asked to shut down framework 201306081318-143311683-36500-24136-0000 by @0.0.0.0:0 W0608 13:18:48.534004 24162 slave.cpp:1131] Ignoring shutdown framework 201306081318-143311683-36500-24136-0000 because it is terminating I0608 13:18:48.534003 24163 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=19715 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=19715) on slave 201306081318-143311683-36500-24136-0 from framework 201306081318-143311683-36500-24136-0000 I0608 13:18:48.534204 24163 hierarchical_allocator_process.hpp:367] Removed framework 201306081318-143311683-36500-24136-0000 I0608 13:18:48.534291 24163 hierarchical_allocator_process.hpp:477] Removed slave 201306081318-143311683-36500-24136-0 [ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (2041 ms) [ RUN ] AllocatorZooKeeperTest/0.SlaveReregistersFirst I0608 13:18:48.535193 24163 master.cpp:228] Master started on 67.195.138.8:36500 2013-06-08 13:18:48,536:24136(0x2b9b45be4700):ZOO_INFO@log_env@658: Client environment:zookeeper.version=zookeeper C client 3.3.4 2013-06-08 13:18:48,536:24136(0x2b9b45be4700):ZOO_INFO@log_env@662: Client environment:host.name=minerva 2013-06-08 13:18:48,536:24136(0x2b9b45be4700):ZOO_INFO@log_env@669: Client environment:os.name=Linux 2013-06-08 13:18:48,536:24136(0x2b9b45be4700):ZOO_INFO@log_env@670: Client environment:os.arch=3.2.0-38-generic 2013-06-08 13:18:48,536:24136(0x2b9b45be4700):ZOO_INFO@log_env@671: Client environment:os.version=#61-Ubuntu SMP Tue Feb 19 12:18:21 UTC 2013 2013-06-08 13:18:48,536:24136(0x2b9b45be4700):ZOO_INFO@log_env@679: Client environment:user.name=(null) 2013-06-08 13:18:48,536:24136(0x2b9b45be4700):ZOO_INFO@log_env@687: Client environment:user.home=/home/jenkins 2013-06-08 13:18:48,536:24136(0x2b9b45be4700):ZOO_INFO@log_env@699: Client environment:user.dir=<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/src> I0608 13:18:48.535259 24163 master.cpp:243] Master ID: 201306081318-143311683-36500-24136 I0608 13:18:48.535971 24161 slave.cpp:216] Slave started on 98)@67.195.138.8:36500 I0608 13:18:48.536942 24156 detector.cpp:234] Master detector ([email protected]:36500) connected to ZooKeeper ... I0608 13:18:48.537940 24157 detector.cpp:234] Master detector (scheduler(89)@67.195.138.8:36500) connected to ZooKeeper ... I0608 13:18:48.538444 24160 detector.cpp:234] Master detector (slave(98)@67.195.138.8:36500) connected to ZooKeeper ... I0608 13:18:48.545900 24160 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0608 13:18:48.545737 24156 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0608 13:18:48.545801 24162 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:36500 W0608 13:18:48.545809 24158 master.cpp:83] No whitelist given. Advertising offers for all slaves I0608 13:18:48.545860 24157 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0608 13:18:48.545658 24161 slave.cpp:217] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=19715 I0608 13:18:48.547036 24161 slave.cpp:398] Finished recovery I0608 13:18:48.547915 24160 detector.cpp:420] Master detector (slave(98)@67.195.138.8:36500) found 0 registered masters I0608 13:18:48.547967 24160 detector.cpp:441] Master detector (slave(98)@67.195.138.8:36500) couldn't find any masters I0608 13:18:48.548045 24160 slave.cpp:571] Lost master(s) ... waiting I0608 13:18:48.548744 24156 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000004' I0608 13:18:48.548821 24157 detector.cpp:420] Master detector (scheduler(89)@67.195.138.8:36500) found 1 registered masters I0608 13:18:48.548923 24159 detector.cpp:420] Master detector (slave(98)@67.195.138.8:36500) found 1 registered masters I0608 13:18:48.549345 24156 detector.cpp:420] Master detector ([email protected]:36500) found 1 registered masters I0608 13:18:48.554219 24159 detector.cpp:467] Master detector (slave(98)@67.195.138.8:36500) got new master pid: [email protected]:36500 I0608 13:18:48.554306 24159 slave.cpp:537] New master detected at [email protected]:36500 I0608 13:18:48.554378 24159 status_update_manager.cpp:155] New master detected at [email protected]:36500 W0608 13:18:48.554440 24161 master.cpp:872] Ignoring register slave message from minerva.apache.org since not elected yet I0608 13:18:48.554440 24157 detector.cpp:467] Master detector (scheduler(89)@67.195.138.8:36500) got new master pid: [email protected]:36500 I0608 13:18:48.554633 24156 detector.cpp:467] Master detector ([email protected]:36500) got new master pid: [email protected]:36500 I0608 13:18:48.554721 24156 master.cpp:526] Elected as master! I0608 13:18:48.554747 24157 sched.cpp:177] New master at [email protected]:36500 I0608 13:18:48.554913 24156 master.cpp:569] Registering framework 201306081318-143311683-36500-24136-0000 at scheduler(89)@67.195.138.8:36500 I0608 13:18:48.554981 24156 sched.cpp:222] Framework registered with 201306081318-143311683-36500-24136-0000 I0608 13:18:48.555016 24157 hierarchical_allocator_process.hpp:327] Added framework 201306081318-143311683-36500-24136-0000 I0608 13:18:48.555078 24157 hierarchical_allocator_process.hpp:705] No resources available to allocate! I0608 13:18:48.555140 24157 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 62.103us I0608 13:18:49.547178 24160 hierarchical_allocator_process.hpp:705] No resources available to allocate! I0608 13:18:49.547247 24160 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 78.237us I0608 13:18:49.555389 24158 master.cpp:891] Attempting to register slave on minerva.apache.org at slave(98)@67.195.138.8:36500 I0608 13:18:49.555425 24158 master.cpp:1851] Adding slave 201306081318-143311683-36500-24136-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=19715 I0608 13:18:49.555529 24161 slave.cpp:597] Registered with master [email protected]:36500; given slave ID 201306081318-143311683-36500-24136-0 I0608 13:18:49.555701 24162 hierarchical_allocator_process.hpp:449] Added slave 201306081318-143311683-36500-24136-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=19715 (and cpus=2; mem=1024; ports=[31000-32000]; disk=19715 available) I0608 13:18:49.555766 24162 hierarchical_allocator_process.hpp:727] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=19715 on slave 201306081318-143311683-36500-24136-0 to framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.555901 24162 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306081318-143311683-36500-24136-0 in 139.164us I0608 13:18:49.555949 24158 master.hpp:313] Adding offer 201306081318-143311683-36500-24136-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=19715 on slave 201306081318-143311683-36500-24136-0 I0608 13:18:49.556047 24158 master.cpp:1239] Sending 1 offers to framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.556141 24158 sched.cpp:287] Received 1 offers I0608 13:18:49.556362 24158 master.cpp:1472] Processing reply for offer 201306081318-143311683-36500-24136-0 on slave 201306081318-143311683-36500-24136-0 (minerva.apache.org) for framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.556473 24158 master.hpp:291] Adding task 0 with resources cpus=1; mem=500 on slave 201306081318-143311683-36500-24136-0 I0608 13:18:49.556526 24158 master.cpp:1591] Launching task 0 of framework 201306081318-143311683-36500-24136-0000 with resources cpus=1; mem=500 on slave 201306081318-143311683-36500-24136-0 (minerva.apache.org) I0608 13:18:49.556659 24159 slave.cpp:737] Got assigned task 0 for framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.556715 24158 master.hpp:323] Removing offer 201306081318-143311683-36500-24136-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=19715 on slave 201306081318-143311683-36500-24136-0 I0608 13:18:49.556722 24156 hierarchical_allocator_process.hpp:526] Framework 201306081318-143311683-36500-24136-0000 left cpus=1; mem=524; ports=[31000-32000]; disk=19715 unused on slave 201306081318-143311683-36500-24136-0 I0608 13:18:49.556921 24159 slave.cpp:835] Launching task 0 for framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.556921 24156 hierarchical_allocator_process.hpp:569] Framework 201306081318-143311683-36500-24136-0000 filtered slave 201306081318-143311683-36500-24136-0 for 5secs I0608 13:18:49.558322 24159 paths.hpp:303] Created executor directory '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_hK55Jd/slaves/201306081318-143311683-36500-24136-0/frameworks/201306081318-143311683-36500-24136-0000/executors/default/runs/22d6b01a-f63f-4e28-8da5-f59040ff41b4' I0608 13:18:49.558501 24159 slave.cpp:946] Queuing task '0' for executor default of framework '201306081318-143311683-36500-24136-0000 I0608 13:18:49.558589 24159 slave.cpp:519] Successfully attached file '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_hK55Jd/slaves/201306081318-143311683-36500-24136-0/frameworks/201306081318-143311683-36500-24136-0000/executors/default/runs/22d6b01a-f63f-4e28-8da5-f59040ff41b4' I0608 13:18:49.558626 24161 exec.cpp:170] Executor started at: executor(36)@67.195.138.8:36500 with pid 24136 I0608 13:18:49.558737 24159 slave.cpp:1393] Got registration for executor 'default' of framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.558835 24159 slave.cpp:1508] Flushing queued task 0 for executor 'default' of framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.558938 24159 exec.cpp:194] Executor registered on slave 201306081318-143311683-36500-24136-0 I0608 13:18:49.558998 24159 exec.cpp:258] Executor asked to run task '0' I0608 13:18:49.560175 24159 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 8cf27768-f03f-441f-9e27-23ee095618fb) for task 0 of framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.560235 24159 slave.cpp:1740] Handling status update TASK_RUNNING (UUID: 8cf27768-f03f-441f-9e27-23ee095618fb) for task 0 of framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.560340 24159 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 8cf27768-f03f-441f-9e27-23ee095618fb) for task 0 of framework 201306081318-143311683-36500-24136-0000 with checkpoint=false I0608 13:18:49.560384 24159 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.560508 24159 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 8cf27768-f03f-441f-9e27-23ee095618fb) for task 0 of framework 201306081318-143311683-36500-24136-0000 to [email protected]:36500 I0608 13:18:49.560598 24159 master.cpp:1022] Status update from slave(98)@67.195.138.8:36500: task 0 of framework 201306081318-143311683-36500-24136-0000 is now in state TASK_RUNNING I0608 13:18:49.560652 24159 slave.cpp:1796] Status update manager successfully handled status update TASK_RUNNING (UUID: 8cf27768-f03f-441f-9e27-23ee095618fb) for task 0 of framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.560678 24159 slave.cpp:1802] Sending acknowledgement for status update TASK_RUNNING (UUID: 8cf27768-f03f-441f-9e27-23ee095618fb) for task 0 of framework 201306081318-143311683-36500-24136-0000 to executor(36)@67.195.138.8:36500 I0608 13:18:49.560720 24163 sched.cpp:332] Received status update TASK_RUNNING (UUID: 8cf27768-f03f-441f-9e27-23ee095618fb) for task 0 of framework 201306081318-143311683-36500-24136-0000 from slave(98)@67.195.138.8:36500 I0608 13:18:49.560821 24158 exec.cpp:290] Executor received status update acknowledgement 8cf27768-f03f-441f-9e27-23ee095618fb for task 0 of framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.560873 24163 sched.cpp:365] Sending ACK for status update TASK_RUNNING (UUID: 8cf27768-f03f-441f-9e27-23ee095618fb) for task 0 of framework 201306081318-143311683-36500-24136-0000 to slave(98)@67.195.138.8:36500 I0608 13:18:49.561302 24156 master.cpp:385] Master terminating I0608 13:18:49.561435 24136 master.cpp:207] Shutting down master I0608 13:18:49.561447 24163 slave.cpp:1877] [email protected]:36500 exited W0608 13:18:49.561591 24163 slave.cpp:1880] Master disconnected! Waiting for a new master to be elected I0608 13:18:49.561570 24162 hierarchical_allocator_process.hpp:412] Deactivated framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.561614 24136 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306081318-143311683-36500-24136-0 I0608 13:18:49.561663 24163 slave.cpp:1110] Asked to shut down framework 201306081318-143311683-36500-24136-0000 by [email protected]:36500 I0608 13:18:49.561858 24163 slave.cpp:1135] Shutting down framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.561913 24163 slave.cpp:2312] Shutting down executor 'default' of framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.561467 24160 status_update_manager.cpp:360] Received status update acknowledgement 8cf27768-f03f-441f-9e27-23ee095618fb for task 0 of framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.561966 24159 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=19715) on slave 201306081318-143311683-36500-24136-0 from framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.562150 24159 hierarchical_allocator_process.hpp:367] Removed framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.562223 24159 hierarchical_allocator_process.hpp:477] Removed slave 201306081318-143311683-36500-24136-0 I0608 13:18:49.565565 24163 slave.cpp:1341] Status update manager successfully handled status update acknowledgement 8cf27768-f03f-441f-9e27-23ee095618fb for task 0 of framework 201306081318-143311683-36500-24136-0000 I0608 13:18:49.565608 24160 exec.cpp:323] Executor asked to shutdown I0608 13:18:49.566444 24162 master.cpp:228] Master started on 67.195.138.8:36500 I0608 13:18:49.566493 24162 master.cpp:243] Master ID: 201306081318-143311683-36500-24136 I0608 13:18:49.567405 24160 detector.cpp:420] Master detector (slave(98)@67.195.138.8:36500) found 0 registered masters I0608 13:18:49.567644 24156 detector.cpp:420] Master detector (scheduler(89)@67.195.138.8:36500) found 0 registered masters I0608 13:18:49.568169 24159 detector.cpp:234] Master detector ([email protected]:36500) connected to ZooKeeper ... I0608 13:18:49.573864 24159 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0608 13:18:49.573742 24160 detector.cpp:441] Master detector (slave(98)@67.195.138.8:36500) couldn't find any masters W0608 13:18:49.573825 24158 master.cpp:83] No whitelist given. Advertising offers for all slaves I0608 13:18:49.573904 24157 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:36500 I0608 13:18:49.573807 24156 detector.cpp:441] Master detector (scheduler(89)@67.195.138.8:36500) couldn't find any masters I0608 13:18:49.574029 24162 slave.cpp:571] Lost master(s) ... waiting I0608 13:18:49.574269 24156 sched.cpp:194] No master detected, waiting for another master I0608 13:18:49.575551 24159 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000006' I0608 13:18:49.576042 24163 detector.cpp:420] Master detector (scheduler(89)@67.195.138.8:36500) found 1 registered masters I0608 13:18:49.576222 24161 detector.cpp:420] Master detector (slave(98)@67.195.138.8:36500) found 1 registered masters I0608 13:18:49.576410 24159 detector.cpp:420] Master detector ([email protected]:36500) found 1 registered masters I0608 13:18:49.582300 24163 detector.cpp:467] Master detector (scheduler(89)@67.195.138.8:36500) got new master pid: [email protected]:36500 I0608 13:18:49.582443 24163 sched.cpp:177] New master at [email protected]:36500 I0608 13:18:49.582541 24159 detector.cpp:467] Master detector ([email protected]:36500) got new master pid: [email protected]:36500 I0608 13:18:49.582630 24159 master.cpp:526] Elected as master! I0608 13:18:49.582684 24161 detector.cpp:467] Master detector (slave(98)@67.195.138.8:36500) got new master pid: [email protected]:36500 I0608 13:18:49.582859 24163 slave.cpp:537] New master detected at [email protected]:36500 I0608 13:18:49.582962 24157 status_update_manager.cpp:155] New master detected at [email protected]:36500 I0608 13:18:49.583086 24158 master.cpp:963] Attempting to re-register slave 201306081318-143311683-36500-24136-0 at slave(98)@67.195.138.8:36500 (minerva.apache.org) I0608 13:18:49.583171 24158 master.cpp:1851] Adding slave 201306081318-143311683-36500-24136-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=19715 I0608 13:18:49.583305 24163 slave.cpp:633] Re-registered with master [email protected]:36500 I0608 13:18:49.583323 24158 master.hpp:291] Adding task 0 with resources cpus=1; mem=500 on slave 201306081318-143311683-36500-24136-0 W0608 13:18:49.583482 24158 master.cpp:1943] Possibly orphaned task 0 of framework 201306081318-143311683-36500-24136-0000 running on slave 201306081318-143311683-36500-24136-0 (minerva.apache.org) I0608 13:18:49.583811 24163 hierarchical_allocator_process.hpp:449] Added slave 201306081318-143311683-36500-24136-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=19715 (and cpus=1; mem=524; ports=[31000-32000]; disk=19715 available) I0608 13:18:49.583878 24163 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0608 13:18:49.583940 24163 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306081318-143311683-36500-24136-0 in 61.847us I0608 13:18:50.574471 24159 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0608 13:18:50.574524 24159 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 50.73us I0608 13:18:50.583634 24160 master.cpp:604] Re-registering framework 201306081318-143311683-36500-24136-0000 at scheduler(89)@67.195.138.8:36500 I0608 13:18:50.583842 24157 sched.cpp:246] Framework re-registered with 201306081318-143311683-36500-24136-0000 W0608 13:18:50.583889 24157 slave.cpp:1271] Ignoring updating pid for framework 201306081318-143311683-36500-24136-0000 because it is terminating I0608 13:18:50.583925 24160 hierarchical_allocator_process.hpp:327] Added framework 201306081318-143311683-36500-24136-0000 I0608 13:18:50.584027 24160 hierarchical_allocator_process.hpp:727] Offering cpus=1; mem=524; ports=[31000-32000]; disk=19715 on slave 201306081318-143311683-36500-24136-0 to framework 201306081318-143311683-36500-24136-0000 I0608 13:18:50.584188 24160 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 181.98us I0608 13:18:50.584225 24157 master.hpp:313] Adding offer 201306081318-143311683-36500-24136-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=19715 on slave 201306081318-143311683-36500-24136-0 I0608 13:18:50.584297 24157 master.cpp:1239] Sending 1 offers to framework 201306081318-143311683-36500-24136-0000 I0608 13:18:50.584386 24157 sched.cpp:287] Received 1 offers I0608 13:18:50.584656 24159 sched.cpp:427] Stopping framework '201306081318-143311683-36500-24136-0000' I0608 13:18:50.584668 24160 master.cpp:385] Master terminating I0608 13:18:50.584822 24163 slave.cpp:493] Slave asked to shut down by [email protected]:36500 I0608 13:18:50.584882 24163 slave.cpp:1110] Asked to shut down framework 201306081318-143311683-36500-24136-0000 by [email protected]:36500 I0608 13:18:50.584894 24136 master.cpp:207] Shutting down master W0608 13:18:50.584939 24163 slave.cpp:1131] Ignoring shutdown framework 201306081318-143311683-36500-24136-0000 because it is terminating I0608 13:18:50.585120 24163 slave.cpp:1877] [email protected]:36500 exited I0608 13:18:50.585196 24161 hierarchical_allocator_process.hpp:412] Deactivated framework 201306081318-143311683-36500-24136-0000 I0608 13:18:50.585180 24136 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306081318-143311683-36500-24136-0 W0608 13:18:50.585201 24163 slave.cpp:1880] Master disconnected! Waiting for a new master to be elected I0608 13:18:50.585547 24161 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201306081318-143311683-36500-24136-0 from framework 201306081318-143311683-36500-24136-0000 I0608 13:18:50.585572 24136 master.hpp:323] Removing offer 201306081318-143311683-36500-24136-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=19715 on slave 201306081318-143311683-36500-24136-0 I0608 13:18:50.589658 24163 slave.cpp:1110] Asked to shut down framework 201306081318-143311683-36500-24136-0000 by [email protected]:36500 W0608 13:18:50.589828 24163 slave.cpp:1131] Ignoring shutdown framework 201306081318-143311683-36500-24136-0000 because it is terminating I0608 13:18:50.589764 24161 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=19715 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=19715) on slave 201306081318-143311683-36500-24136-0 from framework 201306081318-143311683-36500-24136-0000 I0608 13:18:50.590134 24159 hierarchical_allocator_process.hpp:367] Removed framework 201306081318-143311683-36500-24136-0000 I0608 13:18:50.590268 24159 hierarchical_allocator_process.hpp:477] Removed slave 201306081318-143311683-36500-24136-0 I0608 13:18:50.590600 24156 slave.cpp:448] Slave terminating I0608 13:18:50.590658 24156 slave.cpp:1110] Asked to shut down framework 201306081318-143311683-36500-24136-0000 by @0.0.0.0:0 W0608 13:18:50.590713 24156 slave.cpp:1131] Ignoring shutdown framework 201306081318-143311683-36500-24136-0000 because it is terminating I0608 13:18:50.591557 24161 detector.cpp:420] Master detector (slave(98)@67.195.138.8:36500) found 0 registered masters I0608 13:18:50.597671 24161 detector.cpp:441] Master detector (slave(98)@67.195.138.8:36500) couldn't find any masters [ OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (2063 ms) I0608 13:18:50.599745 24136 zookeeper_test_server.cpp:93] Shutdown ZooKeeperTestServer on port 51880 [----------] 2 tests from AllocatorZooKeeperTest/0 (4105 ms total) [----------] Global test environment tear-down [==========] 193 tests from 38 test cases ran. (70326 ms total) [ PASSED ] 192 tests. [ FAILED ] 1 test, listed below: [ FAILED ] FaultToleranceTest.ReconcileIncompleteTasks 1 FAILED TEST FAIL: mesos-tests ================== 1 of 1 test failed ================== make[3]: *** [check-TESTS] Error 1 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
