See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/1078/>
------------------------------------------ [...truncated 65601 lines...] I0627 21:23:43.674214 14195 slave.cpp:1802] Status update manager successfully handled status update TASK_RUNNING (UUID: e45b8bed-aa70-4202-90e4-19098147ef17) for task 0 of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:43.674355 14195 slave.cpp:1808] Sending acknowledgement for status update TASK_RUNNING (UUID: e45b8bed-aa70-4202-90e4-19098147ef17) for task 0 of framework 201306272123-143311683-55229-13947-0000 to executor(189)@67.195.138.8:55229 I0627 21:23:43.674494 14198 exec.cpp:290] Executor received status update acknowledgement e45b8bed-aa70-4202-90e4-19098147ef17 for task 0 of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:43.674682 13947 master.cpp:385] Master terminating I0627 21:23:43.674754 14200 status_update_manager.cpp:360] Received status update acknowledgement e45b8bed-aa70-4202-90e4-19098147ef17 for task 0 of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:43.674937 13947 master.cpp:207] Shutting down master I0627 21:23:43.675036 14199 slave.cpp:1883] [email protected]:55229 exited W0627 21:23:43.675076 14199 slave.cpp:1886] Master disconnected! Waiting for a new master to be elected I0627 21:23:43.675087 14198 hierarchical_allocator_process.hpp:412] Deactivated framework 201306272123-143311683-55229-13947-0000 I0627 21:23:43.675030 13947 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306272123-143311683-55229-13947-0 I0627 21:23:43.675216 14199 slave.cpp:1342] Status update manager successfully handled status update acknowledgement e45b8bed-aa70-4202-90e4-19098147ef17 for task 0 of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:43.675498 14195 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20186) on slave 201306272123-143311683-55229-13947-0 from framework 201306272123-143311683-55229-13947-0000 I0627 21:23:43.675525 14199 slave.cpp:1111] Asked to shut down framework 201306272123-143311683-55229-13947-0000 by [email protected]:55229 I0627 21:23:43.675640 14199 slave.cpp:1136] Shutting down framework 201306272123-143311683-55229-13947-0000 I0627 21:23:43.675659 14195 hierarchical_allocator_process.hpp:367] Removed framework 201306272123-143311683-55229-13947-0000 I0627 21:23:43.675734 14199 slave.cpp:2327] Shutting down executor 'default' of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:43.675966 14199 exec.cpp:323] Executor asked to shutdown I0627 21:23:43.676902 14202 master.cpp:228] Master started on 67.195.138.8:55229 I0627 21:23:43.676964 14202 master.cpp:243] Master ID: 201306272123-143311683-55229-13947 W0627 21:23:43.677116 14201 master.cpp:83] No whitelist given. Advertising offers for all slaves I0627 21:23:43.677322 14201 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:55229 I0627 21:23:43.678779 14199 detector.cpp:234] Master detector ([email protected]:55229) connected to ZooKeeper ... I0627 21:23:43.678992 14202 detector.cpp:420] Master detector (scheduler(454)@67.195.138.8:55229) found 0 registered masters I0627 21:23:43.679111 14195 detector.cpp:420] Master detector (slave(499)@67.195.138.8:55229) found 0 registered masters I0627 21:23:43.685632 14199 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0627 21:23:43.685710 14202 detector.cpp:441] Master detector (scheduler(454)@67.195.138.8:55229) couldn't find any masters I0627 21:23:43.685946 14197 sched.cpp:194] No master detected, waiting for another master I0627 21:23:43.685777 14195 detector.cpp:441] Master detector (slave(499)@67.195.138.8:55229) couldn't find any masters I0627 21:23:43.686099 14196 slave.cpp:562] Lost master(s) ... waiting I0627 21:23:43.687295 14199 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000002' I0627 21:23:43.687620 14196 detector.cpp:420] Master detector (slave(499)@67.195.138.8:55229) found 1 registered masters I0627 21:23:43.687755 14199 detector.cpp:420] Master detector ([email protected]:55229) found 1 registered masters I0627 21:23:43.687932 14198 detector.cpp:420] Master detector (scheduler(454)@67.195.138.8:55229) found 1 registered masters I0627 21:23:43.694119 14196 detector.cpp:467] Master detector (slave(499)@67.195.138.8:55229) got new master pid: [email protected]:55229 I0627 21:23:43.694277 14196 slave.cpp:528] New master detected at [email protected]:55229 I0627 21:23:43.694309 14199 detector.cpp:467] Master detector ([email protected]:55229) got new master pid: [email protected]:55229 I0627 21:23:43.694368 14200 status_update_manager.cpp:155] New master detected at [email protected]:55229 I0627 21:23:43.694386 14198 detector.cpp:467] Master detector (scheduler(454)@67.195.138.8:55229) got new master pid: [email protected]:55229 I0627 21:23:43.694507 14195 master.cpp:526] Elected as master! I0627 21:23:43.694758 14198 sched.cpp:177] New master at [email protected]:55229 I0627 21:23:43.694850 14195 master.cpp:604] Re-registering framework 201306272123-143311683-55229-13947-0000 at scheduler(454)@67.195.138.8:55229 I0627 21:23:43.695003 14199 sched.cpp:246] Framework re-registered with 201306272123-143311683-55229-13947-0000 I0627 21:23:43.695121 14195 hierarchical_allocator_process.hpp:327] Added framework 201306272123-143311683-55229-13947-0000 I0627 21:23:43.695160 14195 hierarchical_allocator_process.hpp:705] No resources available to allocate! I0627 21:23:43.695225 14195 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 65.396us I0627 21:23:44.678148 14197 hierarchical_allocator_process.hpp:705] No resources available to allocate! I0627 21:23:44.678316 14197 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 196.08us I0627 21:23:44.695523 14195 master.cpp:963] Attempting to re-register slave 201306272123-143311683-55229-13947-0 at slave(499)@67.195.138.8:55229 (minerva.apache.org) I0627 21:23:44.695654 14195 master.cpp:1851] Adding slave 201306272123-143311683-55229-13947-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=20186 I0627 21:23:44.695842 14202 slave.cpp:629] Re-registered with master [email protected]:55229 I0627 21:23:44.695868 14195 master.hpp:291] Adding task 0 with resources cpus=1; mem=500 on slave 201306272123-143311683-55229-13947-0 W0627 21:23:44.696264 14199 slave.cpp:1272] Ignoring updating pid for framework 201306272123-143311683-55229-13947-0000 because it is terminating I0627 21:23:44.696389 14195 hierarchical_allocator_process.hpp:449] Added slave 201306272123-143311683-55229-13947-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=20186 (and cpus=1; mem=524; ports=[31000-32000]; disk=20186 available) I0627 21:23:44.696542 14195 hierarchical_allocator_process.hpp:727] Offering cpus=1; mem=524; ports=[31000-32000]; disk=20186 on slave 201306272123-143311683-55229-13947-0 to framework 201306272123-143311683-55229-13947-0000 I0627 21:23:44.696725 14195 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306272123-143311683-55229-13947-0 in 196.354us I0627 21:23:44.696805 14200 master.hpp:313] Adding offer 201306272123-143311683-55229-13947-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20186 on slave 201306272123-143311683-55229-13947-0 I0627 21:23:44.696888 14200 master.cpp:1239] Sending 1 offers to framework 201306272123-143311683-55229-13947-0000 I0627 21:23:44.697396 14195 sched.cpp:427] Stopping framework '201306272123-143311683-55229-13947-0000' I0627 21:23:44.697417 13947 master.cpp:385] Master terminating I0627 21:23:44.697765 13947 master.cpp:207] Shutting down master I0627 21:23:44.697762 14201 slave.cpp:484] Slave asked to shut down by [email protected]:55229 I0627 21:23:44.697916 13947 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306272123-143311683-55229-13947-0 I0627 21:23:44.697947 14198 hierarchical_allocator_process.hpp:412] Deactivated framework 201306272123-143311683-55229-13947-0000 I0627 21:23:44.697949 14201 slave.cpp:1111] Asked to shut down framework 201306272123-143311683-55229-13947-0000 by [email protected]:55229 I0627 21:23:44.698444 13947 master.hpp:323] Removing offer 201306272123-143311683-55229-13947-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20186 on slave 201306272123-143311683-55229-13947-0 I0627 21:23:44.698590 14198 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201306272123-143311683-55229-13947-0 from framework 201306272123-143311683-55229-13947-0000 W0627 21:23:44.698545 14201 slave.cpp:1132] Ignoring shutdown framework 201306272123-143311683-55229-13947-0000 because it is terminating I0627 21:23:44.705670 14201 slave.cpp:439] Slave terminating I0627 21:23:44.700316 14202 detector.cpp:420] Master detector (slave(499)@67.195.138.8:55229) found 0 registered masters I0627 21:23:44.705796 14202 detector.cpp:441] Master detector (slave(499)@67.195.138.8:55229) couldn't find any masters I0627 21:23:44.705721 14201 slave.cpp:1111] Asked to shut down framework 201306272123-143311683-55229-13947-0000 by @0.0.0.0:0 W0627 21:23:44.705895 14201 slave.cpp:1132] Ignoring shutdown framework 201306272123-143311683-55229-13947-0000 because it is terminating I0627 21:23:44.698926 14198 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=20186 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20186) on slave 201306272123-143311683-55229-13947-0 from framework 201306272123-143311683-55229-13947-0000 [ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (2096 ms) [ RUN ] AllocatorZooKeeperTest/0.SlaveReregistersFirst I0627 21:23:44.707245 14201 master.cpp:228] Master started on 67.195.138.8:55229 2013-06-27 21:23:44,708:13947(0x2b82cd56b700):ZOO_INFO@log_env@658: Client environment:zookeeper.version=zookeeper C client 3.3.4 2013-06-27 21:23:44,708:13947(0x2b82cd56b700):ZOO_INFO@log_env@662: Client environment:host.name=minerva 2013-06-27 21:23:44,708:13947(0x2b82cd56b700):ZOO_INFO@log_env@669: Client environment:os.name=Linux 2013-06-27 21:23:44,708:13947(0x2b82cd56b700):ZOO_INFO@log_env@670: Client environment:os.arch=3.2.0-38-generic 2013-06-27 21:23:44,708:13947(0x2b82cd56b700):ZOO_INFO@log_env@671: Client environment:os.version=#61-Ubuntu SMP Tue Feb 19 12:18:21 UTC 2013 2013-06-27 21:23:44,708:13947(0x2b82cd56b700):ZOO_INFO@log_env@679: Client environment:user.name=(null) I0627 21:23:44.707295 14201 master.cpp:243] Master ID: 201306272123-143311683-55229-13947 I0627 21:23:44.707849 14200 slave.cpp:112] Slave started on 500)@67.195.138.8:55229 I0627 21:23:44.713786 14197 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:55229 W0627 21:23:44.713868 14196 master.cpp:83] No whitelist given. Advertising offers for all slaves I0627 21:23:44.709864 14199 detector.cpp:234] Master detector (scheduler(455)@67.195.138.8:55229) connected to ZooKeeper ... I0627 21:23:44.709064 14195 detector.cpp:234] Master detector ([email protected]:55229) connected to ZooKeeper ... I0627 21:23:44.714112 14195 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0627 21:23:44.713891 14200 slave.cpp:204] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=20186 I0627 21:23:44.714037 14199 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0627 21:23:44.709538 14202 detector.cpp:234] Master detector (slave(500)@67.195.138.8:55229) connected to ZooKeeper ... I0627 21:23:44.714426 14202 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0627 21:23:44.714977 14201 slave.cpp:389] Finished recovery I0627 21:23:44.715728 14199 detector.cpp:420] Master detector (scheduler(455)@67.195.138.8:55229) found 0 registered masters I0627 21:23:44.715764 14199 detector.cpp:441] Master detector (scheduler(455)@67.195.138.8:55229) couldn't find any masters I0627 21:23:44.715889 14199 sched.cpp:194] No master detected, waiting for another master I0627 21:23:44.716433 14195 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000004' I0627 21:23:44.716495 14202 detector.cpp:420] Master detector (slave(500)@67.195.138.8:55229) found 1 registered masters I0627 21:23:44.716589 14200 detector.cpp:420] Master detector (scheduler(455)@67.195.138.8:55229) found 1 registered masters I0627 21:23:44.722470 14195 detector.cpp:420] Master detector ([email protected]:55229) found 1 registered masters I0627 21:23:44.722633 14202 detector.cpp:467] Master detector (slave(500)@67.195.138.8:55229) got new master pid: [email protected]:55229 I0627 21:23:44.722750 14200 detector.cpp:467] Master detector (scheduler(455)@67.195.138.8:55229) got new master pid: [email protected]:55229 I0627 21:23:44.722754 14202 slave.cpp:528] New master detected at [email protected]:55229 I0627 21:23:44.722901 14200 sched.cpp:177] New master at [email protected]:55229 I0627 21:23:44.722911 14199 status_update_manager.cpp:155] New master detected at [email protected]:55229 W0627 21:23:44.722959 14202 master.cpp:872] Ignoring register slave message from minerva.apache.org since not elected yet I0627 21:23:44.723074 14195 detector.cpp:467] Master detector ([email protected]:55229) got new master pid: [email protected]:55229 W0627 21:23:44.723120 14202 master.cpp:549] Ignoring register framework message since not elected yet I0627 21:23:44.723237 14202 master.cpp:526] Elected as master! I0627 21:23:45.713968 14197 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0627 21:23:45.714092 14197 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 164.396us I0627 21:23:45.723145 14202 master.cpp:891] Attempting to register slave on minerva.apache.org at slave(500)@67.195.138.8:55229 I0627 21:23:45.723273 14202 master.cpp:1851] Adding slave 201306272123-143311683-55229-13947-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=20186 I0627 21:23:45.723420 14200 slave.cpp:588] Registered with master [email protected]:55229; given slave ID 201306272123-143311683-55229-13947-0 I0627 21:23:45.723510 14202 hierarchical_allocator_process.hpp:449] Added slave 201306272123-143311683-55229-13947-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=20186 (and cpus=2; mem=1024; ports=[31000-32000]; disk=20186 available) I0627 21:23:45.723640 14202 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0627 21:23:45.723705 14202 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306272123-143311683-55229-13947-0 in 63.976us I0627 21:23:45.724194 14199 master.cpp:569] Registering framework 201306272123-143311683-55229-13947-0000 at scheduler(455)@67.195.138.8:55229 I0627 21:23:45.724320 14199 sched.cpp:222] Framework registered with 201306272123-143311683-55229-13947-0000 I0627 21:23:45.724395 14199 hierarchical_allocator_process.hpp:327] Added framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.724452 14199 hierarchical_allocator_process.hpp:727] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=20186 on slave 201306272123-143311683-55229-13947-0 to framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.724585 14199 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 153.663us I0627 21:23:45.724658 14199 master.hpp:313] Adding offer 201306272123-143311683-55229-13947-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=20186 on slave 201306272123-143311683-55229-13947-0 I0627 21:23:45.724720 14199 master.cpp:1239] Sending 1 offers to framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.724962 14199 master.cpp:1472] Processing reply for offer 201306272123-143311683-55229-13947-0 on slave 201306272123-143311683-55229-13947-0 (minerva.apache.org) for framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.725065 14199 master.hpp:291] Adding task 0 with resources cpus=1; mem=500 on slave 201306272123-143311683-55229-13947-0 I0627 21:23:45.725121 14199 master.cpp:1591] Launching task 0 of framework 201306272123-143311683-55229-13947-0000 with resources cpus=1; mem=500 on slave 201306272123-143311683-55229-13947-0 (minerva.apache.org) I0627 21:23:45.725246 14199 master.hpp:323] Removing offer 201306272123-143311683-55229-13947-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=20186 on slave 201306272123-143311683-55229-13947-0 I0627 21:23:45.725324 14199 slave.cpp:738] Got assigned task 0 for framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.725527 14199 slave.cpp:836] Launching task 0 for framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.726944 14199 paths.hpp:303] Created executor directory '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_JV1U60/slaves/201306272123-143311683-55229-13947-0/frameworks/201306272123-143311683-55229-13947-0000/executors/default/runs/ea0e732b-1ffe-495b-8426-0c57ec4d4917' I0627 21:23:45.727057 14201 hierarchical_allocator_process.hpp:526] Framework 201306272123-143311683-55229-13947-0000 left cpus=1; mem=524; ports=[31000-32000]; disk=20186 unused on slave 201306272123-143311683-55229-13947-0 I0627 21:23:45.727179 14199 slave.cpp:947] Queuing task '0' for executor default of framework '201306272123-143311683-55229-13947-0000 I0627 21:23:45.727227 14201 hierarchical_allocator_process.hpp:569] Framework 201306272123-143311683-55229-13947-0000 filtered slave 201306272123-143311683-55229-13947-0 for 5secs I0627 21:23:45.727320 14195 slave.cpp:510] Successfully attached file '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_JV1U60/slaves/201306272123-143311683-55229-13947-0/frameworks/201306272123-143311683-55229-13947-0000/executors/default/runs/ea0e732b-1ffe-495b-8426-0c57ec4d4917' I0627 21:23:45.727548 14201 exec.cpp:170] Executor started at: executor(190)@67.195.138.8:55229 with pid 13947 I0627 21:23:45.727710 14200 slave.cpp:1394] Got registration for executor 'default' of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.728168 14200 slave.cpp:1509] Flushing queued task 0 for executor 'default' of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.728217 14199 exec.cpp:194] Executor registered on slave 201306272123-143311683-55229-13947-0 I0627 21:23:45.728394 14199 exec.cpp:258] Executor asked to run task '0' I0627 21:23:45.729609 14199 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 0e0d46e7-e0f9-48c9-9b43-dcd968716554) for task 0 of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.729689 14199 slave.cpp:1691] Handling status update TASK_RUNNING (UUID: 0e0d46e7-e0f9-48c9-9b43-dcd968716554) for task 0 of framework 201306272123-143311683-55229-13947-0000 from executor(190)@67.195.138.8:55229 I0627 21:23:45.729838 14195 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 0e0d46e7-e0f9-48c9-9b43-dcd968716554) for task 0 of framework 201306272123-143311683-55229-13947-0000 with checkpoint=false I0627 21:23:45.729917 14195 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.730032 14195 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 0e0d46e7-e0f9-48c9-9b43-dcd968716554) for task 0 of framework 201306272123-143311683-55229-13947-0000 to [email protected]:55229 I0627 21:23:45.730188 14197 master.cpp:1022] Status update from slave(500)@67.195.138.8:55229: task 0 of framework 201306272123-143311683-55229-13947-0000 is now in state TASK_RUNNING I0627 21:23:45.730242 14202 slave.cpp:1802] Status update manager successfully handled status update TASK_RUNNING (UUID: 0e0d46e7-e0f9-48c9-9b43-dcd968716554) for task 0 of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.730358 14202 slave.cpp:1808] Sending acknowledgement for status update TASK_RUNNING (UUID: 0e0d46e7-e0f9-48c9-9b43-dcd968716554) for task 0 of framework 201306272123-143311683-55229-13947-0000 to executor(190)@67.195.138.8:55229 I0627 21:23:45.730770 14200 master.cpp:385] Master terminating I0627 21:23:45.730877 14202 exec.cpp:290] Executor received status update acknowledgement 0e0d46e7-e0f9-48c9-9b43-dcd968716554 for task 0 of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.730911 13947 master.cpp:207] Shutting down master I0627 21:23:45.731107 14199 slave.cpp:1883] [email protected]:55229 exited I0627 21:23:45.731123 14195 status_update_manager.cpp:360] Received status update acknowledgement 0e0d46e7-e0f9-48c9-9b43-dcd968716554 for task 0 of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.731142 14196 hierarchical_allocator_process.hpp:412] Deactivated framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.731143 13947 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306272123-143311683-55229-13947-0 W0627 21:23:45.731169 14199 slave.cpp:1886] Master disconnected! Waiting for a new master to be elected I0627 21:23:45.731564 14199 slave.cpp:1111] Asked to shut down framework 201306272123-143311683-55229-13947-0000 by [email protected]:55229 I0627 21:23:45.731611 14199 slave.cpp:1136] Shutting down framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.731613 14197 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20186) on slave 201306272123-143311683-55229-13947-0 from framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.731675 14199 slave.cpp:2327] Shutting down executor 'default' of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.731811 14197 hierarchical_allocator_process.hpp:367] Removed framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.731812 14202 exec.cpp:323] Executor asked to shutdown I0627 21:23:45.731828 14199 slave.cpp:1342] Status update manager successfully handled status update acknowledgement 0e0d46e7-e0f9-48c9-9b43-dcd968716554 for task 0 of framework 201306272123-143311683-55229-13947-0000 I0627 21:23:45.732542 14199 master.cpp:228] Master started on 67.195.138.8:55229 I0627 21:23:45.732652 14199 master.cpp:243] Master ID: 201306272123-143311683-55229-13947 W0627 21:23:45.732875 14202 master.cpp:83] No whitelist given. Advertising offers for all slaves I0627 21:23:45.732972 14196 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:55229 I0627 21:23:45.733810 14201 detector.cpp:420] Master detector (scheduler(455)@67.195.138.8:55229) found 0 registered masters I0627 21:23:45.733898 14199 detector.cpp:420] Master detector (slave(500)@67.195.138.8:55229) found 0 registered masters I0627 21:23:45.741757 14199 detector.cpp:441] Master detector (slave(500)@67.195.138.8:55229) couldn't find any masters I0627 21:23:45.741698 14201 detector.cpp:441] Master detector (scheduler(455)@67.195.138.8:55229) couldn't find any masters I0627 21:23:45.734776 14202 detector.cpp:234] Master detector ([email protected]:55229) connected to ZooKeeper ... I0627 21:23:45.741933 14199 slave.cpp:562] Lost master(s) ... waiting I0627 21:23:45.741961 14201 sched.cpp:194] No master detected, waiting for another master I0627 21:23:45.742001 14202 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0627 21:23:45.743855 14202 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000006' I0627 21:23:45.744185 14195 detector.cpp:420] Master detector (slave(500)@67.195.138.8:55229) found 1 registered masters I0627 21:23:45.744305 14199 detector.cpp:420] Master detector (scheduler(455)@67.195.138.8:55229) found 1 registered masters I0627 21:23:45.744465 14202 detector.cpp:420] Master detector ([email protected]:55229) found 1 registered masters I0627 21:23:45.750238 14199 detector.cpp:467] Master detector (scheduler(455)@67.195.138.8:55229) got new master pid: [email protected]:55229 I0627 21:23:45.750370 14199 sched.cpp:177] New master at [email protected]:55229 I0627 21:23:45.750480 14195 detector.cpp:467] Master detector (slave(500)@67.195.138.8:55229) got new master pid: [email protected]:55229 I0627 21:23:45.750490 14202 detector.cpp:467] Master detector ([email protected]:55229) got new master pid: [email protected]:55229 I0627 21:23:45.750593 14195 slave.cpp:528] New master detected at [email protected]:55229 I0627 21:23:45.750705 14202 master.cpp:526] Elected as master! I0627 21:23:45.750712 14200 status_update_manager.cpp:155] New master detected at [email protected]:55229 I0627 21:23:45.750823 14202 master.cpp:963] Attempting to re-register slave 201306272123-143311683-55229-13947-0 at slave(500)@67.195.138.8:55229 (minerva.apache.org) I0627 21:23:45.750879 14202 master.cpp:1851] Adding slave 201306272123-143311683-55229-13947-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=20186 I0627 21:23:45.750994 14199 slave.cpp:629] Re-registered with master [email protected]:55229 I0627 21:23:45.751019 14202 master.hpp:291] Adding task 0 with resources cpus=1; mem=500 on slave 201306272123-143311683-55229-13947-0 W0627 21:23:45.751114 14202 master.cpp:1943] Possibly orphaned task 0 of framework 201306272123-143311683-55229-13947-0000 running on slave 201306272123-143311683-55229-13947-0 (minerva.apache.org) I0627 21:23:45.751384 14197 hierarchical_allocator_process.hpp:449] Added slave 201306272123-143311683-55229-13947-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=20186 (and cpus=1; mem=524; ports=[31000-32000]; disk=20186 available) I0627 21:23:45.751466 14197 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0627 21:23:45.751516 14197 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306272123-143311683-55229-13947-0 in 49.247us I0627 21:23:46.724534 14200 master.cpp:604] Re-registering framework 201306272123-143311683-55229-13947-0000 at scheduler(455)@67.195.138.8:55229 W0627 21:23:46.724944 14200 slave.cpp:1272] Ignoring updating pid for framework 201306272123-143311683-55229-13947-0000 because it is terminating I0627 21:23:46.724944 14197 sched.cpp:246] Framework re-registered with 201306272123-143311683-55229-13947-0000 I0627 21:23:46.725082 14196 hierarchical_allocator_process.hpp:327] Added framework 201306272123-143311683-55229-13947-0000 I0627 21:23:46.725291 14196 hierarchical_allocator_process.hpp:727] Offering cpus=1; mem=524; ports=[31000-32000]; disk=20186 on slave 201306272123-143311683-55229-13947-0 to framework 201306272123-143311683-55229-13947-0000 I0627 21:23:46.725472 14196 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 199.049us I0627 21:23:46.725601 14195 master.hpp:313] Adding offer 201306272123-143311683-55229-13947-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20186 on slave 201306272123-143311683-55229-13947-0 I0627 21:23:46.725709 14195 master.cpp:1239] Sending 1 offers to framework 201306272123-143311683-55229-13947-0000 I0627 21:23:46.726129 14201 sched.cpp:427] Stopping framework '201306272123-143311683-55229-13947-0000' I0627 21:23:46.726143 13947 master.cpp:385] Master terminating I0627 21:23:46.726348 14198 slave.cpp:484] Slave asked to shut down by [email protected]:55229 I0627 21:23:46.726397 14198 slave.cpp:1111] Asked to shut down framework 201306272123-143311683-55229-13947-0000 by [email protected]:55229 W0627 21:23:46.726455 14198 slave.cpp:1132] Ignoring shutdown framework 201306272123-143311683-55229-13947-0000 because it is terminating I0627 21:23:46.726544 14198 slave.cpp:1883] [email protected]:55229 exited W0627 21:23:46.726603 14198 slave.cpp:1886] Master disconnected! Waiting for a new master to be elected I0627 21:23:46.726567 13947 master.cpp:207] Shutting down master I0627 21:23:46.726809 13947 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306272123-143311683-55229-13947-0 I0627 21:23:46.726958 14198 hierarchical_allocator_process.hpp:412] Deactivated framework 201306272123-143311683-55229-13947-0000 I0627 21:23:46.726958 14199 slave.cpp:1111] Asked to shut down framework 201306272123-143311683-55229-13947-0000 by [email protected]:55229 W0627 21:23:46.727119 14199 slave.cpp:1132] Ignoring shutdown framework 201306272123-143311683-55229-13947-0000 because it is terminating I0627 21:23:46.727129 13947 master.hpp:323] Removing offer 201306272123-143311683-55229-13947-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20186 on slave 201306272123-143311683-55229-13947-0 I0627 21:23:46.727053 14198 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201306272123-143311683-55229-13947-0 from framework 201306272123-143311683-55229-13947-0000 I0627 21:23:46.727506 14198 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=20186 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20186) on slave 201306272123-143311683-55229-13947-0 from framework 201306272123-143311683-55229-13947-0000 I0627 21:23:46.727607 14198 hierarchical_allocator_process.hpp:367] Removed framework 201306272123-143311683-55229-13947-0000 I0627 21:23:46.728123 13947 slave.cpp:439] Slave terminating I0627 21:23:46.729017 14202 detector.cpp:420] Master detector (slave(500)@67.195.138.8:55229) found 0 registered masters I0627 21:23:46.733708 14198 hierarchical_allocator_process.hpp:477] Removed slave 201306272123-143311683-55229-13947-0 I0627 21:23:46.733724 13947 slave.cpp:1111] Asked to shut down framework 201306272123-143311683-55229-13947-0000 by @0.0.0.0:0 I0627 21:23:46.733795 14202 detector.cpp:441] Master detector (slave(500)@67.195.138.8:55229) couldn't find any masters W0627 21:23:46.733917 13947 slave.cpp:1132] Ignoring shutdown framework 201306272123-143311683-55229-13947-0000 because it is terminating [ OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (2028 ms) I0627 21:23:46.735704 13947 zookeeper_test_server.cpp:93] Shutdown ZooKeeperTestServer on port 54330 [----------] 2 tests from AllocatorZooKeeperTest/0 (4125 ms total) [----------] Global test environment tear-down [==========] 196 tests from 37 test cases ran. (65384 ms total) [ PASSED ] 196 tests. make[3]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'> make[2]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'> make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'> Making check in ec2 make[1]: Entering directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/ec2'> make[1]: Nothing to be done for `check'. make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/ec2'> Making check in hadoop make[1]: Entering directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/hadoop'> make[1]: Nothing to be done for `check'. make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/hadoop'> Making check in jenkins make[1]: Entering directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/jenkins'> make[1]: Nothing to be done for `check'. make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/jenkins'> make: *** No rule to make target `GTEST_BREAK_ON_FAILURE'. Stop. Build step 'Execute shell' marked build as failure
