See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/1614/changes>
Changes: [bmahler] Updated support/release.sh to reflect graduation. ------------------------------------------ [...truncated 17045 lines...] I0902 05:02:50.807962 11955 exec.cpp:501] Executor sending status update TASK_RUNNING (UUID: 8f808342-43d7-4913-b661-5f6f48002ae5) for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:50.814856 11956 slave.cpp:1766] Handling status update TASK_RUNNING (UUID: 8f808342-43d7-4913-b661-5f6f48002ae5) for task 0 of framework 201309020502-160088899-54097-11902-0000 from executor(40)@67.195.138.9:54097 I0902 05:02:50.822826 11951 status_update_manager.cpp:300] Received status update TASK_RUNNING (UUID: 8f808342-43d7-4913-b661-5f6f48002ae5) for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:50.830714 11951 status_update_manager.cpp:471] Creating StatusUpdate stream for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:50.838716 11951 status_update_manager.cpp:351] Forwarding status update TASK_RUNNING (UUID: 8f808342-43d7-4913-b661-5f6f48002ae5) for task 0 of framework 201309020502-160088899-54097-11902-0000 to [email protected]:54097 I0902 05:02:50.846688 11954 master.cpp:1205] Status update TASK_RUNNING (UUID: 8f808342-43d7-4913-b661-5f6f48002ae5) for task 0 of framework 201309020502-160088899-54097-11902-0000 from slave(131)@67.195.138.9:54097 I0902 05:02:50.846806 11956 slave.cpp:1885] Status update manager successfully handled status update TASK_RUNNING (UUID: 8f808342-43d7-4913-b661-5f6f48002ae5) for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:50.854698 11952 sched.cpp:395] Scheduler::statusUpdate took 32.497us I0902 05:02:50.854882 11902 master.cpp:478] Master terminating I0902 05:02:50.862531 11956 slave.cpp:1891] Sending acknowledgement for status update TASK_RUNNING (UUID: 8f808342-43d7-4913-b661-5f6f48002ae5) for task 0 of framework 201309020502-160088899-54097-11902-0000 to executor(40)@67.195.138.9:54097 I0902 05:02:50.878494 11902 master.cpp:206] Shutting down master I0902 05:02:50.886510 11954 exec.cpp:331] Executor received status update acknowledgement 8f808342-43d7-4913-b661-5f6f48002ae5 for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:50.886519 11956 slave.cpp:1966] [email protected]:54097 exited I0902 05:02:50.886617 11958 status_update_manager.cpp:375] Received status update acknowledgement (UUID: 8f808342-43d7-4913-b661-5f6f48002ae5) for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:50.894465 11902 master.hpp:329] Removing task 0 with resources cpus(*):1; mem(*):500 on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) W0902 05:02:50.910331 11956 slave.cpp:1969] Master disconnected! Waiting for a new master to be elected I0902 05:02:50.942159 11956 slave.cpp:1381] Status update manager successfully handled status update acknowledgement (UUID: 8f808342-43d7-4913-b661-5f6f48002ae5) for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:50.926374 11957 hierarchical_allocator_process.hpp:598] Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000]) on slave 201309020502-160088899-54097-11902-0 from framework 201309020502-160088899-54097-11902-0000 I0902 05:02:50.926334 11902 master.cpp:234] Removing slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:50.966946 11952 master.cpp:262] Master started on 67.195.138.9:54097 I0902 05:02:50.974011 11952 master.cpp:277] Master ID: 201309020502-160088899-54097-11902 W0902 05:02:51.008215 11952 master.cpp:80] No whitelist given. Advertising offers for all slaves I0902 05:02:50.989840 11953 detector.cpp:420] Master detector (scheduler(113)@67.195.138.9:54097) found 0 registered masters I0902 05:02:50.989984 11954 detector.cpp:420] Master detector (slave(131)@67.195.138.9:54097) found 0 registered masters I0902 05:02:50.989702 11955 detector.cpp:234] Master detector ([email protected]:54097) connected to ZooKeeper ... I0902 05:02:51.008452 11957 hierarchical_allocator_process.hpp:291] Initializing hierarchical allocator process with master : [email protected]:54097 I0902 05:02:51.037647 11953 detector.cpp:441] Master detector (scheduler(113)@67.195.138.9:54097) couldn't find any masters I0902 05:02:51.069509 11953 sched.cpp:202] No master detected, waiting for another master I0902 05:02:51.053560 11955 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0902 05:02:51.045614 11954 detector.cpp:441] Master detector (slave(131)@67.195.138.9:54097) couldn't find any masters I0902 05:02:51.093379 11954 slave.cpp:578] Lost master(s) ... waiting I0902 05:02:51.077445 11953 sched.cpp:214] Scheduler::disconnected took 10.418us I0902 05:02:51.097089 11955 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000002' I0902 05:02:51.097573 11951 detector.cpp:420] Master detector (scheduler(113)@67.195.138.9:54097) found 1 registered masters I0902 05:02:51.097718 11952 detector.cpp:420] Master detector (slave(131)@67.195.138.9:54097) found 1 registered masters I0902 05:02:51.125797 11955 detector.cpp:420] Master detector ([email protected]:54097) found 1 registered masters I0902 05:02:51.133623 11951 detector.cpp:467] Master detector (scheduler(113)@67.195.138.9:54097) got new master pid: [email protected]:54097 I0902 05:02:51.141621 11952 detector.cpp:467] Master detector (slave(131)@67.195.138.9:54097) got new master pid: [email protected]:54097 I0902 05:02:51.149658 11955 detector.cpp:467] Master detector ([email protected]:54097) got new master pid: [email protected]:54097 I0902 05:02:51.157070 11951 sched.cpp:178] New master at [email protected]:54097 I0902 05:02:51.165024 11952 slave.cpp:544] New master detected at [email protected]:54097 I0902 05:02:51.188904 11954 status_update_manager.cpp:157] New master detected at [email protected]:54097 I0902 05:02:51.172973 11955 master.cpp:642] Elected as master! I0902 05:02:51.221071 11955 master.cpp:734] Re-registering framework 201309020502-160088899-54097-11902-0000 at scheduler(113)@67.195.138.9:54097 I0902 05:02:51.237131 11958 sched.cpp:237] Framework registered with 201309020502-160088899-54097-11902-0000 I0902 05:02:51.252931 11958 sched.cpp:251] Scheduler::registered took 10.705us I0902 05:02:51.237234 11957 hierarchical_allocator_process.hpp:321] Added framework 201309020502-160088899-54097-11902-0000 I0902 05:02:51.284750 11957 hierarchical_allocator_process.hpp:687] No resources available to allocate! I0902 05:02:51.300686 11957 hierarchical_allocator_process.hpp:649] Performed allocation for 0 slaves in 15.935852ms I0902 05:02:51.540693 11952 master.cpp:1159] Attempting to re-register slave 201309020502-160088899-54097-11902-0 at slave(131)@67.195.138.9:54097 (vesta.apache.org) I0902 05:02:51.540788 11952 master.cpp:2078] Adding slave 201309020502-160088899-54097-11902-0 at vesta.apache.org with cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] I0902 05:02:51.571506 11952 master.hpp:316] Adding task 0 with resources cpus(*):1; mem(*):500 on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:51.571537 11954 slave.cpp:645] Re-registered with master [email protected]:54097 I0902 05:02:51.587642 11952 hierarchical_allocator_process.hpp:434] Added slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) with cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] (and cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] available) I0902 05:02:51.619290 11952 hierarchical_allocator_process.hpp:712] Offering cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] on slave 201309020502-160088899-54097-11902-0 to framework 201309020502-160088899-54097-11902-0000 I0902 05:02:51.635270 11952 hierarchical_allocator_process.hpp:669] Performed allocation for slave 201309020502-160088899-54097-11902-0 in 16.012853ms I0902 05:02:51.603319 11954 slave.cpp:1327] Updating framework 201309020502-160088899-54097-11902-0000 pid to scheduler(113)@67.195.138.9:54097 I0902 05:02:51.635341 11956 master.hpp:339] Adding offer 201309020502-160088899-54097-11902-0 with resources cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:51.682986 11956 master.cpp:1439] Sending 1 offers to framework 201309020502-160088899-54097-11902-0000 I0902 05:02:51.699007 11953 sched.cpp:340] Scheduler::resourceOffers took 29.111us I0902 05:02:51.699208 11902 master.cpp:478] Master terminating I0902 05:02:51.714823 11953 sched.cpp:498] Stopping framework '201309020502-160088899-54097-11902-0000' I0902 05:02:51.730751 11957 slave.cpp:1966] [email protected]:54097 exited W0902 05:02:51.762567 11957 slave.cpp:1969] Master disconnected! Waiting for a new master to be elected I0902 05:02:51.730763 11902 master.cpp:206] Shutting down master I0902 05:02:51.802448 11902 master.hpp:329] Removing task 0 with resources cpus(*):1; mem(*):500 on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:51.814451 11956 hierarchical_allocator_process.hpp:598] Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):1; mem(*):500) on slave 201309020502-160088899-54097-11902-0 from framework 201309020502-160088899-54097-11902-0000 I0902 05:02:51.814513 11902 master.hpp:349] Removing offer 201309020502-160088899-54097-11902-0 with resources cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:51.838256 11902 master.cpp:234] Removing slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:51.856341 11958 slave.cpp:454] Slave terminating I0902 05:02:51.862115 11958 slave.cpp:1162] Asked to shut down framework 201309020502-160088899-54097-11902-0000 by @0.0.0.0:0 I0902 05:02:51.866302 11957 detector.cpp:420] Master detector (slave(131)@67.195.138.9:54097) found 0 registered masters I0902 05:02:51.899274 11957 detector.cpp:441] Master detector (slave(131)@67.195.138.9:54097) couldn't find any masters I0902 05:02:51.886031 11958 slave.cpp:1187] Shutting down framework 201309020502-160088899-54097-11902-0000 I0902 05:02:51.915199 11958 slave.cpp:2417] Shutting down executor 'default' of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:51.923192 11951 exec.cpp:371] Executor asked to shutdown GMOCK WARNING: Uninteresting mock function call - returning directly. Function call: shutdown(0x2b6e8001b080) Stack trace: I0902 05:02:51.931128 11951 exec.cpp:386] Executor::shutdown took 22.145us [ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (1720 ms) [ RUN ] AllocatorZooKeeperTest/0.SlaveReregistersFirst 2013-09-02 05:02:51,940:11902(0x2b6e74c9f700):ZOO_INFO@log_env@658: Client environment:zookeeper.version=zookeeper C client 3.3.4 2013-09-02 05:02:51,940:11902(0x2b6e74c9f700):ZOO_INFO@log_env@662: Client environment:host.name=vesta.apache.org 2013-09-02 05:02:51,940:11902(0x2b6e74c9f700):ZOO_INFO@log_env@669: Client environment:os.name=Linux 2013-09-02 05:02:51,940:11902(0x2b6e74c9f700):ZOO_INFO@log_env@670: Client environment:os.arch=3.2.0-51-generic 2013-09-02 05:02:51,940:11902(0x2b6e74c9f700):ZOO_INFO@log_env@671: Client environment:os.version=#77-Ubuntu SMP Wed Jul 24 20:18:19 UTC 2013 2013-09-02 05:02:51,940:11902(0x2b6e74c9f700):ZOO_INFO@log_env@679: Client environment:user.name=(null) 2013-09-02 05:02:51,940:11902(0x2b6e74c9f700):ZOO_INFO@log_env@687: Client environment:user.home=/home/jenkins I0902 05:02:51.939656 11956 master.cpp:262] Master started on 67.195.138.9:54097 I0902 05:02:51.940371 11957 slave.cpp:108] Slave started on 132)@67.195.138.9:54097 I0902 05:02:51.957820 11957 slave.cpp:208] Slave resources: cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] I0902 05:02:51.949857 11955 detector.cpp:234] Master detector ([email protected]:54097) connected to ZooKeeper ... I0902 05:02:51.989585 11955 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0902 05:02:51.965670 11954 detector.cpp:234] Master detector (slave(132)@67.195.138.9:54097) connected to ZooKeeper ... I0902 05:02:51.966171 11951 detector.cpp:234] Master detector (scheduler(114)@67.195.138.9:54097) connected to ZooKeeper ... I0902 05:02:51.982177 11958 slave.cpp:399] Finished recovery I0902 05:02:51.947063 11956 master.cpp:277] Master ID: 201309020502-160088899-54097-11902 I0902 05:02:52.001293 11955 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000004' I0902 05:02:52.005508 11954 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0902 05:02:52.013455 11951 detector.cpp:251] Trying to create path '/znode' in ZooKeeper W0902 05:02:52.029530 11957 master.cpp:80] No whitelist given. Advertising offers for all slaves I0902 05:02:52.029551 11952 hierarchical_allocator_process.hpp:291] Initializing hierarchical allocator process with master : [email protected]:54097 I0902 05:02:52.037899 11955 detector.cpp:420] Master detector ([email protected]:54097) found 1 registered masters I0902 05:02:52.046319 11954 detector.cpp:420] Master detector (slave(132)@67.195.138.9:54097) found 1 registered masters I0902 05:02:52.054335 11951 detector.cpp:420] Master detector (scheduler(114)@67.195.138.9:54097) found 1 registered masters I0902 05:02:52.082929 11955 detector.cpp:467] Master detector ([email protected]:54097) got new master pid: [email protected]:54097 I0902 05:02:52.106313 11955 master.cpp:642] Elected as master! I0902 05:02:52.098834 11951 detector.cpp:467] Master detector (scheduler(114)@67.195.138.9:54097) got new master pid: [email protected]:54097 I0902 05:02:52.090895 11954 detector.cpp:467] Master detector (slave(132)@67.195.138.9:54097) got new master pid: [email protected]:54097 I0902 05:02:52.122225 11951 sched.cpp:178] New master at [email protected]:54097 I0902 05:02:52.130211 11954 slave.cpp:544] New master detected at [email protected]:54097 I0902 05:02:52.138195 11951 master.cpp:692] Registering framework 201309020502-160088899-54097-11902-0000 at scheduler(114)@67.195.138.9:54097 I0902 05:02:52.146114 11953 status_update_manager.cpp:157] New master detected at [email protected]:54097 I0902 05:02:52.154186 11952 sched.cpp:237] Framework registered with 201309020502-160088899-54097-11902-0000 I0902 05:02:52.154242 11954 hierarchical_allocator_process.hpp:321] Added framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.177917 11954 hierarchical_allocator_process.hpp:687] No resources available to allocate! I0902 05:02:52.185855 11954 hierarchical_allocator_process.hpp:649] Performed allocation for 0 slaves in 7.939655ms I0902 05:02:52.154279 11951 master.cpp:1065] Attempting to register slave on vesta.apache.org at slave(132)@67.195.138.9:54097 I0902 05:02:52.201779 11951 master.cpp:2078] Adding slave 201309020502-160088899-54097-11902-0 at vesta.apache.org with cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] I0902 05:02:52.209849 11957 slave.cpp:604] Registered with master [email protected]:54097; given slave ID 201309020502-160088899-54097-11902-0 I0902 05:02:52.169997 11952 sched.cpp:251] Scheduler::registered took 41.118us I0902 05:02:52.209961 11953 hierarchical_allocator_process.hpp:434] Added slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) with cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] (and cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] available) I0902 05:02:52.233738 11953 hierarchical_allocator_process.hpp:712] Offering cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] on slave 201309020502-160088899-54097-11902-0 to framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.241745 11953 hierarchical_allocator_process.hpp:669] Performed allocation for slave 201309020502-160088899-54097-11902-0 in 8.065467ms I0902 05:02:52.241832 11957 master.hpp:339] Adding offer 201309020502-160088899-54097-11902-0 with resources cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:52.257592 11957 master.cpp:1439] Sending 1 offers to framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.265800 11957 sched.cpp:340] Scheduler::resourceOffers took 169.361us I0902 05:02:52.273591 11955 master.cpp:1676] Processing reply for offer 201309020502-160088899-54097-11902-0 on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) for framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.281553 11955 master.hpp:316] Adding task 0 with resources cpus(*):1; mem(*):500 on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:52.289399 11955 master.cpp:1796] Launching task 0 of framework 201309020502-160088899-54097-11902-0000 with resources cpus(*):1; mem(*):500 on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:52.297484 11955 master.hpp:349] Removing offer 201309020502-160088899-54097-11902-0 with resources cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:52.297536 11957 slave.cpp:767] Got assigned task 0 for framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.297586 11956 hierarchical_allocator_process.hpp:508] Framework 201309020502-160088899-54097-11902-0000 left cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] unused on slave 201309020502-160088899-54097-11902-0 I0902 05:02:52.321348 11956 hierarchical_allocator_process.hpp:551] Framework 201309020502-160088899-54097-11902-0000 filtered slave 201309020502-160088899-54097-11902-0 for 5secs I0902 05:02:52.313477 11957 slave.cpp:878] Launching task 0 for framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.338553 11957 paths.hpp:336] Created executor directory '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_hE0qxb/slaves/201309020502-160088899-54097-11902-0/frameworks/201309020502-160088899-54097-11902-0000/executors/default/runs/ecb850af-5ea1-4308-8691-74f516019595' I0902 05:02:52.345289 11957 slave.cpp:989] Queuing task '0' for executor default of framework '201309020502-160088899-54097-11902-0000 I0902 05:02:52.346619 11951 exec.cpp:174] Executor started at: executor(41)@67.195.138.9:54097 with pid 11902 I0902 05:02:52.353147 11957 slave.cpp:526] Successfully attached file '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_hE0qxb/slaves/201309020502-160088899-54097-11902-0/frameworks/201309020502-160088899-54097-11902-0000/executors/default/runs/ecb850af-5ea1-4308-8691-74f516019595' I0902 05:02:52.369088 11957 slave.cpp:1435] Got registration for executor 'default' of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.377076 11957 slave.cpp:1556] Flushing queued task 0 for executor 'default' of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.377123 11956 exec.cpp:198] Executor registered on slave 201309020502-160088899-54097-11902-0 I0902 05:02:52.394036 11956 exec.cpp:210] Executor::registered took 11.59us I0902 05:02:52.400909 11956 exec.cpp:285] Executor asked to run task '0' I0902 05:02:52.408862 11956 exec.cpp:294] Executor::launchTask took 35.122us I0902 05:02:52.417930 11956 exec.cpp:501] Executor sending status update TASK_RUNNING (UUID: f7b68a62-c499-4d7b-a45f-83f5b3c05db0) for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.424813 11956 slave.cpp:1766] Handling status update TASK_RUNNING (UUID: f7b68a62-c499-4d7b-a45f-83f5b3c05db0) for task 0 of framework 201309020502-160088899-54097-11902-0000 from executor(41)@67.195.138.9:54097 I0902 05:02:52.432787 11956 status_update_manager.cpp:300] Received status update TASK_RUNNING (UUID: f7b68a62-c499-4d7b-a45f-83f5b3c05db0) for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.440668 11956 status_update_manager.cpp:471] Creating StatusUpdate stream for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.448699 11956 status_update_manager.cpp:351] Forwarding status update TASK_RUNNING (UUID: f7b68a62-c499-4d7b-a45f-83f5b3c05db0) for task 0 of framework 201309020502-160088899-54097-11902-0000 to [email protected]:54097 I0902 05:02:52.456693 11956 master.cpp:1205] Status update TASK_RUNNING (UUID: f7b68a62-c499-4d7b-a45f-83f5b3c05db0) for task 0 of framework 201309020502-160088899-54097-11902-0000 from slave(132)@67.195.138.9:54097 I0902 05:02:52.464625 11956 sched.cpp:395] Scheduler::statusUpdate took 13.725us I0902 05:02:52.456729 11954 slave.cpp:1885] Status update manager successfully handled status update TASK_RUNNING (UUID: f7b68a62-c499-4d7b-a45f-83f5b3c05db0) for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.464836 11902 master.cpp:478] Master terminating I0902 05:02:52.480469 11954 slave.cpp:1891] Sending acknowledgement for status update TASK_RUNNING (UUID: f7b68a62-c499-4d7b-a45f-83f5b3c05db0) for task 0 of framework 201309020502-160088899-54097-11902-0000 to executor(41)@67.195.138.9:54097 I0902 05:02:52.496501 11954 slave.cpp:1966] [email protected]:54097 exited W0902 05:02:52.504364 11954 slave.cpp:1969] Master disconnected! Waiting for a new master to be elected I0902 05:02:52.496577 11955 status_update_manager.cpp:375] Received status update acknowledgement (UUID: f7b68a62-c499-4d7b-a45f-83f5b3c05db0) for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.528323 11955 slave.cpp:1381] Status update manager successfully handled status update acknowledgement (UUID: f7b68a62-c499-4d7b-a45f-83f5b3c05db0) for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.496539 11958 exec.cpp:331] Executor received status update acknowledgement f7b68a62-c499-4d7b-a45f-83f5b3c05db0 for task 0 of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.488492 11902 master.cpp:206] Shutting down master I0902 05:02:52.552186 11902 master.hpp:329] Removing task 0 with resources cpus(*):1; mem(*):500 on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:52.560178 11902 master.cpp:234] Removing slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:52.560211 11953 hierarchical_allocator_process.hpp:598] Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000]) on slave 201309020502-160088899-54097-11902-0 from framework 201309020502-160088899-54097-11902-0000 I0902 05:02:52.576746 11954 master.cpp:262] Master started on 67.195.138.9:54097 I0902 05:02:52.583983 11954 master.cpp:277] Master ID: 201309020502-160088899-54097-11902 I0902 05:02:52.591557 11951 detector.cpp:234] Master detector ([email protected]:54097) connected to ZooKeeper ... I0902 05:02:52.591812 11956 detector.cpp:420] Master detector (scheduler(114)@67.195.138.9:54097) found 0 registered masters I0902 05:02:52.591960 11958 detector.cpp:420] Master detector (slave(132)@67.195.138.9:54097) found 0 registered masters W0902 05:02:52.598950 11953 master.cpp:80] No whitelist given. Advertising offers for all slaves I0902 05:02:52.599143 11955 hierarchical_allocator_process.hpp:291] Initializing hierarchical allocator process with master : [email protected]:54097 I0902 05:02:52.606783 11951 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0902 05:02:52.614740 11956 detector.cpp:441] Master detector (scheduler(114)@67.195.138.9:54097) couldn't find any masters I0902 05:02:52.659690 11955 sched.cpp:202] No master detected, waiting for another master I0902 05:02:52.655118 11951 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000006' I0902 05:02:52.622700 11958 detector.cpp:441] Master detector (slave(132)@67.195.138.9:54097) couldn't find any masters I0902 05:02:52.660183 11956 detector.cpp:420] Master detector (scheduler(114)@67.195.138.9:54097) found 1 registered masters I0902 05:02:52.667593 11955 sched.cpp:214] Scheduler::disconnected took 10.478us I0902 05:02:52.676087 11951 detector.cpp:420] Master detector ([email protected]:54097) found 1 registered masters I0902 05:02:52.683574 11953 slave.cpp:578] Lost master(s) ... waiting I0902 05:02:52.684093 11958 detector.cpp:420] Master detector (slave(132)@67.195.138.9:54097) found 1 registered masters I0902 05:02:52.691982 11956 detector.cpp:467] Master detector (scheduler(114)@67.195.138.9:54097) got new master pid: [email protected]:54097 I0902 05:02:52.707872 11951 detector.cpp:467] Master detector ([email protected]:54097) got new master pid: [email protected]:54097 I0902 05:02:52.739289 11951 master.cpp:642] Elected as master! I0902 05:02:52.731364 11956 sched.cpp:178] New master at [email protected]:54097 I0902 05:02:52.723863 11958 detector.cpp:467] Master detector (slave(132)@67.195.138.9:54097) got new master pid: [email protected]:54097 I0902 05:02:52.763187 11958 slave.cpp:544] New master detected at [email protected]:54097 I0902 05:02:52.771173 11958 status_update_manager.cpp:157] New master detected at [email protected]:54097 I0902 05:02:52.771240 11957 master.cpp:1159] Attempting to re-register slave 201309020502-160088899-54097-11902-0 at slave(132)@67.195.138.9:54097 (vesta.apache.org) I0902 05:02:52.787001 11957 master.cpp:2078] Adding slave 201309020502-160088899-54097-11902-0 at vesta.apache.org with cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] I0902 05:02:52.795027 11957 master.hpp:316] Adding task 0 with resources cpus(*):1; mem(*):500 on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) W0902 05:02:52.802929 11957 master.cpp:2170] Possibly orphaned task 0 of framework 201309020502-160088899-54097-11902-0000 running on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:52.795090 11952 slave.cpp:645] Re-registered with master [email protected]:54097 I0902 05:02:52.819041 11957 hierarchical_allocator_process.hpp:434] Added slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) with cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] (and cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] available) I0902 05:02:52.834776 11957 hierarchical_allocator_process.hpp:669] Performed allocation for slave 201309020502-160088899-54097-11902-0 in 7.241us I0902 05:02:53.138241 11951 master.cpp:734] Re-registering framework 201309020502-160088899-54097-11902-0000 at scheduler(114)@67.195.138.9:54097 I0902 05:02:53.138521 11953 sched.cpp:237] Framework registered with 201309020502-160088899-54097-11902-0000 I0902 05:02:53.141279 11953 sched.cpp:251] Scheduler::registered took 9.184us I0902 05:02:53.138592 11954 hierarchical_allocator_process.hpp:321] Added framework 201309020502-160088899-54097-11902-0000 I0902 05:02:53.157235 11954 hierarchical_allocator_process.hpp:712] Offering cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] on slave 201309020502-160088899-54097-11902-0 to framework 201309020502-160088899-54097-11902-0000 I0902 05:02:53.165279 11954 hierarchical_allocator_process.hpp:649] Performed allocation for 1 slaves in 8.083453ms I0902 05:02:53.165338 11955 master.hpp:339] Adding offer 201309020502-160088899-54097-11902-0 with resources cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:53.181133 11955 master.cpp:1439] Sending 1 offers to framework 201309020502-160088899-54097-11902-0000 I0902 05:02:53.189177 11955 sched.cpp:340] Scheduler::resourceOffers took 17.379us I0902 05:02:53.197074 11955 sched.cpp:498] Stopping framework '201309020502-160088899-54097-11902-0000' I0902 05:02:53.189370 11902 master.cpp:478] Master terminating I0902 05:02:53.138545 11951 slave.cpp:1327] Updating framework 201309020502-160088899-54097-11902-0000 pid to scheduler(114)@67.195.138.9:54097 I0902 05:02:53.220957 11951 slave.cpp:1966] [email protected]:54097 exited W0902 05:02:53.228874 11951 slave.cpp:1969] Master disconnected! Waiting for a new master to be elected I0902 05:02:53.212995 11902 master.cpp:206] Shutting down master I0902 05:02:53.252823 11902 master.hpp:329] Removing task 0 with resources cpus(*):1; mem(*):500 on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:53.260844 11953 hierarchical_allocator_process.hpp:598] Recovered cpus(*):1; mem(*):500 (total allocatable: cpus(*):1; mem(*):500) on slave 201309020502-160088899-54097-11902-0 from framework 201309020502-160088899-54097-11902-0000 I0902 05:02:53.260895 11902 master.hpp:349] Removing offer 201309020502-160088899-54097-11902-0 with resources cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] on slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:53.276686 11902 master.cpp:234] Removing slave 201309020502-160088899-54097-11902-0 (vesta.apache.org) I0902 05:02:53.297315 11902 slave.cpp:454] Slave terminating I0902 05:02:53.297440 11902 slave.cpp:1162] Asked to shut down framework 201309020502-160088899-54097-11902-0000 by @0.0.0.0:0 I0902 05:02:53.304512 11902 slave.cpp:1187] Shutting down framework 201309020502-160088899-54097-11902-0000 I0902 05:02:53.301306 11957 detector.cpp:420] Master detector (slave(132)@67.195.138.9:54097) found 0 registered masters I0902 05:02:53.320415 11957 detector.cpp:441] Master detector (slave(132)@67.195.138.9:54097) couldn't find any masters I0902 05:02:53.312571 11902 slave.cpp:2417] Shutting down executor 'default' of framework 201309020502-160088899-54097-11902-0000 I0902 05:02:53.336356 11958 exec.cpp:371] Executor asked to shutdown GMOCK WARNING: Uninteresting mock function call - returning directly. Function call: shutdown(0x2b6ea0016240) Stack trace: I0902 05:02:53.344359 11958 exec.cpp:386] Executor::shutdown took 41.119us [ OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (1413 ms) I0902 05:02:53.353792 11902 zookeeper_test_server.cpp:93] Shutdown ZooKeeperTestServer on port 52305 [----------] 2 tests from AllocatorZooKeeperTest/0 (3133 ms total) [----------] Global test environment tear-down [==========] 220 tests from 39 test cases ran. (164371 ms total) [ PASSED ] 219 tests. [ FAILED ] 1 test, listed below: [ FAILED ] SlaveRecoveryTest/0.MultipleFrameworks, where TypeParam = mesos::internal::slave::ProcessIsolator 1 FAILED TEST make[3]: *** [check-local] Error 1 make[3]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/src' make[2]: *** [check-am] Error 2 make[2]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/src' make[1]: *** [check] Error 2 make[1]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/src' make: *** [check-recursive] Error 1 Build step 'Execute shell' marked build as failure
