You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2013/07/12 13:53:53 UTC

Build failed in Jenkins: Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #1357

See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/1357/>

------------------------------------------
[...truncated 14290 lines...]
I0712 11:53:49.965350  2976 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: c337b813-bf00-4d06-a51d-4fbd7ec44817) for task 0 of framework 201307121153-143311683-56642-2946-0000 to master@67.195.138.8:56642
I0712 11:53:49.965451  2971 master.cpp:1093] Status update from slave(100)@67.195.138.8:56642: task 0 of framework 201307121153-143311683-56642-2946-0000 is now in state TASK_RUNNING
I0712 11:53:49.965528  2975 slave.cpp:1803] Status update manager successfully handled status update TASK_RUNNING (UUID: c337b813-bf00-4d06-a51d-4fbd7ec44817) for task 0 of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:49.965658  2975 slave.cpp:1809] Sending acknowledgement for status update TASK_RUNNING (UUID: c337b813-bf00-4d06-a51d-4fbd7ec44817) for task 0 of framework 201307121153-143311683-56642-2946-0000 to executor(37)@67.195.138.8:56642
I0712 11:53:49.965829  2970 exec.cpp:290] Executor received status update acknowledgement c337b813-bf00-4d06-a51d-4fbd7ec44817 for task 0 of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:49.965883  2975 status_update_manager.cpp:360] Received status update acknowledgement c337b813-bf00-4d06-a51d-4fbd7ec44817 for task 0 of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:49.966081  2975 slave.cpp:1343] Status update manager successfully handled status update acknowledgement c337b813-bf00-4d06-a51d-4fbd7ec44817 for task 0 of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:49.966191  2975 master.cpp:436] Master terminating
I0712 11:53:49.966351  2946 master.cpp:209] Shutting down master
I0712 11:53:49.966384  2971 slave.cpp:1884] master@67.195.138.8:56642 exited
I0712 11:53:49.966506  2970 hierarchical_allocator_process.hpp:411] Deactivated framework 201307121153-143311683-56642-2946-0000
I0712 11:53:49.966528  2946 master.hpp:317] Removing task 0 with resources cpus=1; mem=500 on slave 201307121153-143311683-56642-2946-0
W0712 11:53:49.966581  2971 slave.cpp:1887] Master disconnected! Waiting for a new master to be elected
I0712 11:53:49.966825  2971 slave.cpp:1112] Asked to shut down framework 201307121153-143311683-56642-2946-0000 by master@67.195.138.8:56642
I0712 11:53:49.966869  2971 slave.cpp:1137] Shutting down framework 201307121153-143311683-56642-2946-0000
I0712 11:53:49.966869  2969 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20741) on slave 201307121153-143311683-56642-2946-0 from framework 201307121153-143311683-56642-2946-0000
I0712 11:53:49.966959  2971 slave.cpp:2328] Shutting down executor 'default' of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:49.967187  2969 hierarchical_allocator_process.hpp:366] Removed framework 201307121153-143311683-56642-2946-0000
I0712 11:53:49.967187  2974 exec.cpp:323] Executor asked to shutdown
I0712 11:53:49.968009  2972 master.cpp:230] Master started on 67.195.138.8:56642
I0712 11:53:49.968086  2972 master.cpp:245] Master ID: 201307121153-143311683-56642-2946
W0712 11:53:49.968299  2974 master.cpp:83] No whitelist given. Advertising offers for all slaves
I0712 11:53:49.968485  2970 hierarchical_allocator_process.hpp:305] Initializing hierarchical allocator process with master : master@67.195.138.8:56642
I0712 11:53:49.969796  2973 detector.cpp:234] Master detector (master@67.195.138.8:56642) connected to ZooKeeper ...
I0712 11:53:49.969841  2973 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0712 11:53:49.969966  2974 detector.cpp:420] Master detector (slave(100)@67.195.138.8:56642)  found 0 registered masters
I0712 11:53:49.970111  2970 detector.cpp:420] Master detector (scheduler(93)@67.195.138.8:56642)  found 0 registered masters
I0712 11:53:49.973697  2974 detector.cpp:441] Master detector (slave(100)@67.195.138.8:56642) couldn't find any masters
I0712 11:53:49.973809  2970 detector.cpp:441] Master detector (scheduler(93)@67.195.138.8:56642) couldn't find any masters
I0712 11:53:49.973927  2974 slave.cpp:563] Lost master(s) ... waiting
I0712 11:53:49.973997  2970 sched.cpp:194] No master detected, waiting for another master
I0712 11:53:49.975222  2973 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000002'
I0712 11:53:49.975705  2976 detector.cpp:420] Master detector (slave(100)@67.195.138.8:56642)  found 1 registered masters
I0712 11:53:49.975842  2972 detector.cpp:420] Master detector (scheduler(93)@67.195.138.8:56642)  found 1 registered masters
I0712 11:53:49.976006  2973 detector.cpp:420] Master detector (master@67.195.138.8:56642)  found 1 registered masters
I0712 11:53:49.982276  2976 detector.cpp:467] Master detector (slave(100)@67.195.138.8:56642)  got new master pid: master@67.195.138.8:56642
I0712 11:53:49.982403  2976 slave.cpp:529] New master detected at master@67.195.138.8:56642
I0712 11:53:49.982446  2972 detector.cpp:467] Master detector (scheduler(93)@67.195.138.8:56642)  got new master pid: master@67.195.138.8:56642
I0712 11:53:49.982483  2975 status_update_manager.cpp:155] New master detected at master@67.195.138.8:56642
I0712 11:53:49.982673  2973 detector.cpp:467] Master detector (master@67.195.138.8:56642)  got new master pid: master@67.195.138.8:56642
I0712 11:53:49.982733  2975 sched.cpp:177] New master at master@67.195.138.8:56642
I0712 11:53:49.982794  2973 master.cpp:583] Elected as master!
I0712 11:53:49.982907  2973 master.cpp:675] Re-registering framework 201307121153-143311683-56642-2946-0000 at scheduler(93)@67.195.138.8:56642
I0712 11:53:49.983126  2969 sched.cpp:246] Framework re-registered with 201307121153-143311683-56642-2946-0000
I0712 11:53:49.983268  2973 hierarchical_allocator_process.hpp:335] Added framework 201307121153-143311683-56642-2946-0000
I0712 11:53:49.983343  2973 hierarchical_allocator_process.hpp:704] No resources available to allocate!
I0712 11:53:49.983413  2973 hierarchical_allocator_process.hpp:666] Performed allocation for 0 slaves in 70.71us
I0712 11:53:50.959470  2972 master.cpp:1034] Attempting to re-register slave 201307121153-143311683-56642-2946-0 at slave(100)@67.195.138.8:56642 (minerva.apache.org)
I0712 11:53:50.959522  2972 master.cpp:1929] Adding slave 201307121153-143311683-56642-2946-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=20741
I0712 11:53:50.959715  2976 slave.cpp:630] Re-registered with master master@67.195.138.8:56642
I0712 11:53:50.959782  2972 master.hpp:305] Adding task 0 with resources cpus=1; mem=500 on slave 201307121153-143311683-56642-2946-0
W0712 11:53:50.960011  2970 slave.cpp:1273] Ignoring updating pid for framework 201307121153-143311683-56642-2946-0000 because it is terminating
I0712 11:53:50.960144  2974 hierarchical_allocator_process.hpp:448] Added slave 201307121153-143311683-56642-2946-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=20741 (and cpus=1; mem=524; ports=[31000-32000]; disk=20741 available)
I0712 11:53:50.960257  2974 hierarchical_allocator_process.hpp:726] Offering cpus=1; mem=524; ports=[31000-32000]; disk=20741 on slave 201307121153-143311683-56642-2946-0 to framework 201307121153-143311683-56642-2946-0000
I0712 11:53:50.960405  2974 hierarchical_allocator_process.hpp:686] Performed allocation for slave 201307121153-143311683-56642-2946-0 in 173.309us
I0712 11:53:50.960453  2971 master.hpp:327] Adding offer 201307121153-143311683-56642-2946-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20741 on slave 201307121153-143311683-56642-2946-0
I0712 11:53:50.960526  2971 master.cpp:1310] Sending 1 offers to framework 201307121153-143311683-56642-2946-0000
I0712 11:53:50.960909  2975 master.cpp:436] Master terminating
I0712 11:53:50.960908  2976 sched.cpp:427] Stopping framework '201307121153-143311683-56642-2946-0000'
I0712 11:53:50.961047  2946 master.cpp:209] Shutting down master
I0712 11:53:50.960973  2971 slave.cpp:485] Slave asked to shut down by master@67.195.138.8:56642
I0712 11:53:50.961241  2946 master.hpp:317] Removing task 0 with resources cpus=1; mem=500 on slave 201307121153-143311683-56642-2946-0
I0712 11:53:50.961246  2975 hierarchical_allocator_process.hpp:411] Deactivated framework 201307121153-143311683-56642-2946-0000
I0712 11:53:50.961596  2946 master.hpp:337] Removing offer 201307121153-143311683-56642-2946-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20741 on slave 201307121153-143311683-56642-2946-0
I0712 11:53:50.961648  2975 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201307121153-143311683-56642-2946-0 from framework 201307121153-143311683-56642-2946-0000
I0712 11:53:50.961383  2971 slave.cpp:1112] Asked to shut down framework 201307121153-143311683-56642-2946-0000 by master@67.195.138.8:56642
W0712 11:53:50.961820  2971 slave.cpp:1133] Ignoring shutdown framework 201307121153-143311683-56642-2946-0000 because it is terminating
I0712 11:53:50.961933  2975 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=20741 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20741) on slave 201307121153-143311683-56642-2946-0 from framework 201307121153-143311683-56642-2946-0000
I0712 11:53:50.961983  2971 slave.cpp:1884] master@67.195.138.8:56642 exited
I0712 11:53:50.962120  2975 hierarchical_allocator_process.hpp:366] Removed framework 201307121153-143311683-56642-2946-0000
I0712 11:53:50.963445  2976 detector.cpp:420] Master detector (slave(100)@67.195.138.8:56642)  found 0 registered masters
W0712 11:53:50.969662  2971 slave.cpp:1887] Master disconnected! Waiting for a new master to be elected
I0712 11:53:50.969816  2975 hierarchical_allocator_process.hpp:476] Removed slave 201307121153-143311683-56642-2946-0
I0712 11:53:50.969843  2976 detector.cpp:441] Master detector (slave(100)@67.195.138.8:56642) couldn't find any masters
I0712 11:53:50.969957  2971 slave.cpp:440] Slave terminating
I0712 11:53:50.970039  2975 hierarchical_allocator_process.hpp:704] No resources available to allocate!
I0712 11:53:50.970196  2971 slave.cpp:1112] Asked to shut down framework 201307121153-143311683-56642-2946-0000 by @0.0.0.0:0
I0712 11:53:50.970281  2975 hierarchical_allocator_process.hpp:666] Performed allocation for 0 slaves in 243.024us
W0712 11:53:50.970345  2971 slave.cpp:1133] Ignoring shutdown framework 201307121153-143311683-56642-2946-0000 because it is terminating
[       OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (2031 ms)
[ RUN      ] AllocatorZooKeeperTest/0.SlaveReregistersFirst
I0712 11:53:50.971809  2970 master.cpp:230] Master started on 67.195.138.8:56642
2013-07-12 11:53:50,972:2946(0x2af152306700):ZOO_INFO@log_env@658: Client environment:zookeeper.version=zookeeper C client 3.3.4
2013-07-12 11:53:50,972:2946(0x2af152306700):ZOO_INFO@log_env@662: Client environment:host.name=minerva
2013-07-12 11:53:50,972:2946(0x2af152306700):ZOO_INFO@log_env@669: Client environment:os.name=Linux
2013-07-12 11:53:50,972:2946(0x2af152306700):ZOO_INFO@log_env@670: Client environment:os.arch=3.2.0-38-generic
2013-07-12 11:53:50,972:2946(0x2af152306700):ZOO_INFO@log_env@671: Client environment:os.version=#61-Ubuntu SMP Tue Feb 19 12:18:21 UTC 2013
2013-07-12 11:53:50,972:2946(0x2af152306700):ZOO_INFO@log_env@679: Client environment:user.name=(null)
2013-07-12 11:53:50,972:2946(0x2af152306700):ZOO_INFO@log_env@687: Client environment:user.home=/home/jenkins
2013-07-12 11:53:50,972:2946(0x2af152306700):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>
2013-07-12 11:53:50,972:2946(0x2af152306700):ZOO_INFO@zookeeper_init@727: Initiating client connection, host=127.0.0.1:33346 sessionTimeout=10000 watcher=0x2af14f204b60 sessionId=0 sessionPasswd=<null> context=0x2af16400b670 flags=0
I0712 11:53:50.971859  2970 master.cpp:245] Master ID: 201307121153-143311683-56642-2946
I0712 11:53:50.972619  2972 slave.cpp:113] Slave started on 101)@67.195.138.8:56642
I0712 11:53:50.973631  2969 detector.cpp:234] Master detector (master@67.195.138.8:56642) connected to ZooKeeper ...
I0712 11:53:50.974176  2974 detector.cpp:234] Master detector (slave(101)@67.195.138.8:56642) connected to ZooKeeper ...
I0712 11:53:50.974766  2976 detector.cpp:234] Master detector (scheduler(94)@67.195.138.8:56642) connected to ZooKeeper ...
W0712 11:53:50.981807  2973 master.cpp:83] No whitelist given. Advertising offers for all slaves
I0712 11:53:50.981850  2969 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0712 11:53:50.981869  2972 slave.cpp:205] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=20741
I0712 11:53:50.981886  2971 hierarchical_allocator_process.hpp:305] Initializing hierarchical allocator process with master : master@67.195.138.8:56642
I0712 11:53:50.981925  2974 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0712 11:53:50.981999  2976 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0712 11:53:50.982941  2973 slave.cpp:390] Finished recovery
I0712 11:53:50.984140  2976 detector.cpp:420] Master detector (scheduler(94)@67.195.138.8:56642)  found 1 registered masters
I0712 11:53:50.984231  2969 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000004'
I0712 11:53:50.984328  2974 detector.cpp:420] Master detector (slave(101)@67.195.138.8:56642)  found 1 registered masters
I0712 11:53:50.984678  2976 detector.cpp:467] Master detector (scheduler(94)@67.195.138.8:56642)  got new master pid: master@67.195.138.8:56642
I0712 11:53:50.989904  2976 sched.cpp:177] New master at master@67.195.138.8:56642
W0712 11:53:50.989984  2976 master.cpp:606] Ignoring register framework message since not elected yet
I0712 11:53:50.990468  2969 detector.cpp:420] Master detector (master@67.195.138.8:56642)  found 1 registered masters
I0712 11:53:50.990665  2974 detector.cpp:467] Master detector (slave(101)@67.195.138.8:56642)  got new master pid: master@67.195.138.8:56642
I0712 11:53:50.990761  2974 slave.cpp:529] New master detected at master@67.195.138.8:56642
I0712 11:53:50.990819  2976 status_update_manager.cpp:155] New master detected at master@67.195.138.8:56642
W0712 11:53:50.990874  2976 master.cpp:943] Ignoring register slave message from minerva.apache.org since not elected yet
I0712 11:53:50.991065  2969 detector.cpp:467] Master detector (master@67.195.138.8:56642)  got new master pid: master@67.195.138.8:56642
I0712 11:53:50.991161  2969 master.cpp:583] Elected as master!
I0712 11:53:51.983312  2973 hierarchical_allocator_process.hpp:704] No resources available to allocate!
I0712 11:53:51.983399  2973 hierarchical_allocator_process.hpp:666] Performed allocation for 0 slaves in 96.339us
I0712 11:53:51.990627  2970 master.cpp:633] Registering framework 201307121153-143311683-56642-2946-0000 at scheduler(94)@67.195.138.8:56642
I0712 11:53:51.990756  2970 hierarchical_allocator_process.hpp:335] Added framework 201307121153-143311683-56642-2946-0000
I0712 11:53:51.990808  2975 sched.cpp:222] Framework registered with 201307121153-143311683-56642-2946-0000
I0712 11:53:51.990862  2970 hierarchical_allocator_process.hpp:704] No resources available to allocate!
I0712 11:53:51.990952  2970 hierarchical_allocator_process.hpp:666] Performed allocation for 0 slaves in 89.118us
I0712 11:53:51.991637  2973 master.cpp:962] Attempting to register slave on minerva.apache.org at slave(101)@67.195.138.8:56642
I0712 11:53:51.991672  2973 master.cpp:1929] Adding slave 201307121153-143311683-56642-2946-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=20741
I0712 11:53:51.991796  2972 slave.cpp:589] Registered with master master@67.195.138.8:56642; given slave ID 201307121153-143311683-56642-2946-0
I0712 11:53:51.991907  2970 hierarchical_allocator_process.hpp:448] Added slave 201307121153-143311683-56642-2946-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=20741 (and cpus=2; mem=1024; ports=[31000-32000]; disk=20741 available)
I0712 11:53:51.992023  2970 hierarchical_allocator_process.hpp:726] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=20741 on slave 201307121153-143311683-56642-2946-0 to framework 201307121153-143311683-56642-2946-0000
I0712 11:53:51.992168  2970 hierarchical_allocator_process.hpp:686] Performed allocation for slave 201307121153-143311683-56642-2946-0 in 165.801us
I0712 11:53:51.992243  2972 master.hpp:327] Adding offer 201307121153-143311683-56642-2946-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=20741 on slave 201307121153-143311683-56642-2946-0
I0712 11:53:51.992328  2972 master.cpp:1310] Sending 1 offers to framework 201307121153-143311683-56642-2946-0000
I0712 11:53:51.992609  2972 master.cpp:1543] Processing reply for offer 201307121153-143311683-56642-2946-0 on slave 201307121153-143311683-56642-2946-0 (minerva.apache.org) for framework 201307121153-143311683-56642-2946-0000
I0712 11:53:51.992717  2972 master.hpp:305] Adding task 0 with resources cpus=1; mem=500 on slave 201307121153-143311683-56642-2946-0
I0712 11:53:51.992758  2972 master.cpp:1662] Launching task 0 of framework 201307121153-143311683-56642-2946-0000 with resources cpus=1; mem=500 on slave 201307121153-143311683-56642-2946-0 (minerva.apache.org)
I0712 11:53:51.992879  2973 slave.cpp:739] Got assigned task 0 for framework 201307121153-143311683-56642-2946-0000
I0712 11:53:51.992959  2972 master.hpp:337] Removing offer 201307121153-143311683-56642-2946-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=20741 on slave 201307121153-143311683-56642-2946-0
I0712 11:53:51.993055  2973 slave.cpp:837] Launching task 0 for framework 201307121153-143311683-56642-2946-0000
I0712 11:53:51.993100  2972 hierarchical_allocator_process.hpp:525] Framework 201307121153-143311683-56642-2946-0000 left cpus=1; mem=524; ports=[31000-32000]; disk=20741 unused on slave 201307121153-143311683-56642-2946-0
I0712 11:53:51.993273  2972 hierarchical_allocator_process.hpp:568] Framework 201307121153-143311683-56642-2946-0000 filtered slave 201307121153-143311683-56642-2946-0 for 5secs
I0712 11:53:51.998667  2973 paths.hpp:303] Created executor directory '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_A883Sp/slaves/201307121153-143311683-56642-2946-0/frameworks/201307121153-143311683-56642-2946-0000/executors/default/runs/9c07253a-1d12-44fa-bb97-c60311006eb9'
I0712 11:53:51.998826  2973 slave.cpp:948] Queuing task '0' for executor default of framework '201307121153-143311683-56642-2946-0000
I0712 11:53:51.998930  2972 exec.cpp:170] Executor started at: executor(38)@67.195.138.8:56642 with pid 2946
I0712 11:53:52.005686  2973 slave.cpp:511] Successfully attached file '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_A883Sp/slaves/201307121153-143311683-56642-2946-0/frameworks/201307121153-143311683-56642-2946-0000/executors/default/runs/9c07253a-1d12-44fa-bb97-c60311006eb9'
I0712 11:53:52.005851  2973 slave.cpp:1395] Got registration for executor 'default' of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.005962  2973 slave.cpp:1510] Flushing queued task 0 for executor 'default' of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.006002  2975 exec.cpp:194] Executor registered on slave 201307121153-143311683-56642-2946-0
I0712 11:53:52.006206  2970 exec.cpp:258] Executor asked to run task '0'
I0712 11:53:52.007483  2970 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 5ec008cc-a9aa-4127-99a1-3f4ee2ba7877) for task 0 of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.007570  2973 slave.cpp:1692] Handling status update TASK_RUNNING (UUID: 5ec008cc-a9aa-4127-99a1-3f4ee2ba7877) for task 0 of framework 201307121153-143311683-56642-2946-0000 from executor(38)@67.195.138.8:56642
I0712 11:53:52.007709  2973 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 5ec008cc-a9aa-4127-99a1-3f4ee2ba7877) for task 0 of framework 201307121153-143311683-56642-2946-0000 with checkpoint=false
I0712 11:53:52.007763  2973 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.007884  2973 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 5ec008cc-a9aa-4127-99a1-3f4ee2ba7877) for task 0 of framework 201307121153-143311683-56642-2946-0000 to master@67.195.138.8:56642
I0712 11:53:52.008012  2973 master.cpp:1093] Status update from slave(101)@67.195.138.8:56642: task 0 of framework 201307121153-143311683-56642-2946-0000 is now in state TASK_RUNNING
I0712 11:53:52.008095  2973 slave.cpp:1803] Status update manager successfully handled status update TASK_RUNNING (UUID: 5ec008cc-a9aa-4127-99a1-3f4ee2ba7877) for task 0 of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.008123  2973 slave.cpp:1809] Sending acknowledgement for status update TASK_RUNNING (UUID: 5ec008cc-a9aa-4127-99a1-3f4ee2ba7877) for task 0 of framework 201307121153-143311683-56642-2946-0000 to executor(38)@67.195.138.8:56642
I0712 11:53:52.008237  2970 exec.cpp:290] Executor received status update acknowledgement 5ec008cc-a9aa-4127-99a1-3f4ee2ba7877 for task 0 of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.008678  2975 status_update_manager.cpp:360] Received status update acknowledgement 5ec008cc-a9aa-4127-99a1-3f4ee2ba7877 for task 0 of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.008841  2946 master.cpp:436] Master terminating
I0712 11:53:52.008849  2972 slave.cpp:1343] Status update manager successfully handled status update acknowledgement 5ec008cc-a9aa-4127-99a1-3f4ee2ba7877 for task 0 of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.008919  2946 master.cpp:209] Shutting down master
I0712 11:53:52.009140  2972 slave.cpp:1884] master@67.195.138.8:56642 exited
W0712 11:53:52.009232  2972 slave.cpp:1887] Master disconnected! Waiting for a new master to be elected
I0712 11:53:52.009256  2969 hierarchical_allocator_process.hpp:411] Deactivated framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.009261  2946 master.hpp:317] Removing task 0 with resources cpus=1; mem=500 on slave 201307121153-143311683-56642-2946-0
I0712 11:53:52.009321  2972 slave.cpp:1112] Asked to shut down framework 201307121153-143311683-56642-2946-0000 by master@67.195.138.8:56642
I0712 11:53:52.009552  2972 slave.cpp:1137] Shutting down framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.009636  2972 slave.cpp:2328] Shutting down executor 'default' of framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.009672  2976 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20741) on slave 201307121153-143311683-56642-2946-0 from framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.009795  2972 exec.cpp:323] Executor asked to shutdown
I0712 11:53:52.009886  2976 hierarchical_allocator_process.hpp:366] Removed framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.010807  2975 master.cpp:230] Master started on 67.195.138.8:56642
I0712 11:53:52.011030  2975 master.cpp:245] Master ID: 201307121153-143311683-56642-2946
I0712 11:53:52.012645  2970 detector.cpp:234] Master detector (master@67.195.138.8:56642) connected to ZooKeeper ...
I0712 11:53:52.012822  2971 detector.cpp:420] Master detector (slave(101)@67.195.138.8:56642)  found 0 registered masters
I0712 11:53:52.012995  2974 detector.cpp:420] Master detector (scheduler(94)@67.195.138.8:56642)  found 0 registered masters
I0712 11:53:52.017699  2970 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
W0712 11:53:52.017768  2973 master.cpp:83] No whitelist given. Advertising offers for all slaves
I0712 11:53:52.017858  2974 detector.cpp:441] Master detector (scheduler(94)@67.195.138.8:56642) couldn't find any masters
I0712 11:53:52.017887  2971 detector.cpp:441] Master detector (slave(101)@67.195.138.8:56642) couldn't find any masters
I0712 11:53:52.018131  2972 sched.cpp:194] No master detected, waiting for another master
I0712 11:53:52.017974  2969 hierarchical_allocator_process.hpp:305] Initializing hierarchical allocator process with master : master@67.195.138.8:56642
I0712 11:53:52.018224  2971 slave.cpp:563] Lost master(s) ... waiting
I0712 11:53:52.019613  2970 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000006'
I0712 11:53:52.020005  2971 detector.cpp:420] Master detector (slave(101)@67.195.138.8:56642)  found 1 registered masters
I0712 11:53:52.020134  2972 detector.cpp:420] Master detector (scheduler(94)@67.195.138.8:56642)  found 1 registered masters
I0712 11:53:52.020249  2970 detector.cpp:420] Master detector (master@67.195.138.8:56642)  found 1 registered masters
I0712 11:53:52.026233  2972 detector.cpp:467] Master detector (scheduler(94)@67.195.138.8:56642)  got new master pid: master@67.195.138.8:56642
I0712 11:53:52.026347  2970 detector.cpp:467] Master detector (master@67.195.138.8:56642)  got new master pid: master@67.195.138.8:56642
I0712 11:53:52.026403  2972 sched.cpp:177] New master at master@67.195.138.8:56642
I0712 11:53:52.026522  2971 detector.cpp:467] Master detector (slave(101)@67.195.138.8:56642)  got new master pid: master@67.195.138.8:56642
I0712 11:53:52.026546  2973 master.cpp:583] Elected as master!
I0712 11:53:52.026659  2971 slave.cpp:529] New master detected at master@67.195.138.8:56642
I0712 11:53:52.026754  2969 status_update_manager.cpp:155] New master detected at master@67.195.138.8:56642
I0712 11:53:52.026878  2972 master.cpp:1034] Attempting to re-register slave 201307121153-143311683-56642-2946-0 at slave(101)@67.195.138.8:56642 (minerva.apache.org)
I0712 11:53:52.026957  2972 master.cpp:1929] Adding slave 201307121153-143311683-56642-2946-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=20741
I0712 11:53:52.027098  2976 slave.cpp:630] Re-registered with master master@67.195.138.8:56642
I0712 11:53:52.027119  2972 master.hpp:305] Adding task 0 with resources cpus=1; mem=500 on slave 201307121153-143311683-56642-2946-0
W0712 11:53:52.027235  2972 master.cpp:2021] Possibly orphaned task 0 of framework 201307121153-143311683-56642-2946-0000 running on slave 201307121153-143311683-56642-2946-0 (minerva.apache.org)
I0712 11:53:52.027559  2976 hierarchical_allocator_process.hpp:448] Added slave 201307121153-143311683-56642-2946-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=20741 (and cpus=1; mem=524; ports=[31000-32000]; disk=20741 available)
I0712 11:53:52.027647  2976 hierarchical_allocator_process.hpp:686] Performed allocation for slave 201307121153-143311683-56642-2946-0 in 6.186us
I0712 11:53:52.991173  2974 master.cpp:675] Re-registering framework 201307121153-143311683-56642-2946-0000 at scheduler(94)@67.195.138.8:56642
I0712 11:53:52.991382  2976 sched.cpp:246] Framework re-registered with 201307121153-143311683-56642-2946-0000
W0712 11:53:52.991447  2973 slave.cpp:1273] Ignoring updating pid for framework 201307121153-143311683-56642-2946-0000 because it is terminating
I0712 11:53:52.991561  2975 hierarchical_allocator_process.hpp:335] Added framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.991628  2975 hierarchical_allocator_process.hpp:726] Offering cpus=1; mem=524; ports=[31000-32000]; disk=20741 on slave 201307121153-143311683-56642-2946-0 to framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.991754  2975 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 138.597us
I0712 11:53:52.991793  2976 master.hpp:327] Adding offer 201307121153-143311683-56642-2946-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20741 on slave 201307121153-143311683-56642-2946-0
I0712 11:53:52.991899  2976 master.cpp:1310] Sending 1 offers to framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.992256  2976 master.cpp:436] Master terminating
I0712 11:53:52.992254  2970 sched.cpp:427] Stopping framework '201307121153-143311683-56642-2946-0000'
I0712 11:53:52.992331  2976 slave.cpp:485] Slave asked to shut down by master@67.195.138.8:56642
I0712 11:53:52.992360  2946 master.cpp:209] Shutting down master
I0712 11:53:52.992482  2976 slave.cpp:1112] Asked to shut down framework 201307121153-143311683-56642-2946-0000 by master@67.195.138.8:56642
W0712 11:53:52.992641  2976 slave.cpp:1133] Ignoring shutdown framework 201307121153-143311683-56642-2946-0000 because it is terminating
I0712 11:53:52.992719  2976 slave.cpp:1884] master@67.195.138.8:56642 exited
I0712 11:53:52.992779  2946 master.hpp:317] Removing task 0 with resources cpus=1; mem=500 on slave 201307121153-143311683-56642-2946-0
I0712 11:53:52.992645  2972 hierarchical_allocator_process.hpp:411] Deactivated framework 201307121153-143311683-56642-2946-0000
W0712 11:53:52.992801  2976 slave.cpp:1887] Master disconnected! Waiting for a new master to be elected
I0712 11:53:52.993007  2976 slave.cpp:1112] Asked to shut down framework 201307121153-143311683-56642-2946-0000 by master@67.195.138.8:56642
W0712 11:53:52.993084  2976 slave.cpp:1133] Ignoring shutdown framework 201307121153-143311683-56642-2946-0000 because it is terminating
I0712 11:53:52.993176  2972 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201307121153-143311683-56642-2946-0 from framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.993203  2946 master.hpp:337] Removing offer 201307121153-143311683-56642-2946-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20741 on slave 201307121153-143311683-56642-2946-0
I0712 11:53:52.997730  2972 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=20741 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20741) on slave 201307121153-143311683-56642-2946-0 from framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.997908  2974 hierarchical_allocator_process.hpp:366] Removed framework 201307121153-143311683-56642-2946-0000
I0712 11:53:52.998059  2972 hierarchical_allocator_process.hpp:476] Removed slave 201307121153-143311683-56642-2946-0
I0712 11:53:52.998538  2946 slave.cpp:440] Slave terminating
I0712 11:53:52.998579  2946 slave.cpp:1112] Asked to shut down framework 201307121153-143311683-56642-2946-0000 by @0.0.0.0:0
W0712 11:53:52.998635  2946 slave.cpp:1133] Ignoring shutdown framework 201307121153-143311683-56642-2946-0000 because it is terminating
I0712 11:53:52.999357  2976 detector.cpp:420] Master detector (slave(101)@67.195.138.8:56642)  found 0 registered masters
I0712 11:53:53.005705  2976 detector.cpp:441] Master detector (slave(101)@67.195.138.8:56642) couldn't find any masters
[       OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (2035 ms)
I0712 11:53:53.007652  2946 zookeeper_test_server.cpp:93] Shutdown ZooKeeperTestServer on port 33346
[----------] 2 tests from AllocatorZooKeeperTest/0 (4066 ms total)

[----------] Global test environment tear-down
[==========] 198 tests from 37 test cases ran. (66950 ms total)
[  PASSED  ] 197 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] CoordinatorTest.Truncate

 1 FAILED TEST
make[3]: *** [check-local] 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

Jenkins build is back to normal : Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #1358

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/1358/>