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/04/04 06:01:19 UTC
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #330
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/330/changes>
Changes:
[vinodkone] Fixed deploy scripts to ignore commented out lines
in slaves/masters files.
From: Andrew Ash <an...@andrewash.com>
Review: https://reviews.apache.org/r/10244
------------------------------------------
[...truncated 15305 lines...]
I0404 04:01:06.967157 9423 detector.cpp:531] Master detector (slave(81)@140.211.11.27:44198) got new master pid: master@140.211.11.27:44198
I0404 04:01:06.967317 9423 slave.cpp:453] New master detected at master@140.211.11.27:44198
I0404 04:01:06.967393 9433 detector.cpp:531] Master detector (master@140.211.11.27:44198) got new master pid: master@140.211.11.27:44198
W0404 04:01:06.967447 9442 master.cpp:668] Ignoring re-register framework message since not elected yet
I0404 04:01:06.967581 9442 master.cpp:603] Elected as master!
I0404 04:01:06.967452 9438 status_update_manager.cpp:132] New master detected at master@140.211.11.27:44198
I0404 04:01:07.925945 9440 hierarchical_allocator_process.hpp:660] Found available resources: cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:07.926065 9440 hierarchical_allocator_process.hpp:756] Filtered cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0 for framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.926141 9440 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 221.85us
I0404 04:01:07.944155 9443 master.cpp:681] Re-registering framework 201304040401-453759884-44198-9401-0000 at scheduler(71)@140.211.11.27:44198
I0404 04:01:07.944411 9443 sched.cpp:217] Framework registered with 201304040401-453759884-44198-9401-0000
I0404 04:01:07.944468 9426 hierarchical_allocator_process.hpp:268] Added framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.944618 9426 hierarchical_allocator_process.hpp:668] No resources available to allocate!
I0404 04:01:07.944653 9426 hierarchical_allocator_process.hpp:599] Performed allocation for 0 slaves in 36.07us
I0404 04:01:07.960078 9437 hierarchical_allocator_process.hpp:668] No resources available to allocate!
I0404 04:01:07.960111 9437 hierarchical_allocator_process.hpp:599] Performed allocation for 0 slaves in 39.45us
I0404 04:01:07.968243 9425 master.cpp:1029] Attempting to re-register slave 201304040401-453759884-44198-9401-0 at slave(81)@140.211.11.27:44198 (hemera.apache.org)
I0404 04:01:07.968287 9425 master.cpp:1224] Master now considering a slave at hemera.apache.org:44198 as active
I0404 04:01:07.968374 9425 master.cpp:1862] Adding slave 201304040401-453759884-44198-9401-0 at hemera.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=1024
I0404 04:01:07.968561 9425 master.hpp:289] Adding task with resources cpus=1; mem=512 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:07.968572 9441 slave.cpp:520] Re-registered with master
I0404 04:01:07.968806 9441 slave.cpp:956] Updating framework 201304040401-453759884-44198-9401-0000 pid to scheduler(71)@140.211.11.27:44198
I0404 04:01:07.968906 9435 hierarchical_allocator_process.hpp:395] Added slave 201304040401-453759884-44198-9401-0 (hemera.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=1024 (and cpus=1; mem=512; ports=[31000-32000]; disk=1024 available)
I0404 04:01:07.968988 9435 hierarchical_allocator_process.hpp:660] Found available resources: cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:07.969104 9435 hierarchical_allocator_process.hpp:686] Offering cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0 to framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.969337 9435 hierarchical_allocator_process.hpp:619] Performed allocation for slave 201304040401-453759884-44198-9401-0 in 354.02us
I0404 04:01:07.969396 9428 master.hpp:309] Adding offer with resources cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:07.969502 9428 master.cpp:1327] Sending 1 offers to framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.969730 9440 sched.cpp:282] Received 1 offers
I0404 04:01:07.969986 9422 sched.cpp:422] Stopping framework '201304040401-453759884-44198-9401-0000'
I0404 04:01:07.970069 9428 master.cpp:774] Asked to unregister framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.970188 9428 master.hpp:300] Removing task with resources cpus=1; mem=512 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:07.970484 9428 master.hpp:318] Removing offer with resources cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:07.970253 9436 hierarchical_allocator_process.hpp:359] Deactivated framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.970770 9436 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=512 (total allocatable: cpus=1; mem=512; ports=[]; disk=0) on slave 201304040401-453759884-44198-9401-0 from framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.970846 9436 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=512; ports=[31000-32000]; disk=1024 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=1024) on slave 201304040401-453759884-44198-9401-0 from framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.970218 9438 slave.cpp:889] Asked to shut down framework 201304040401-453759884-44198-9401-0000 by master@140.211.11.27:44198
I0404 04:01:07.978461 9438 slave.cpp:894] Shutting down framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.978543 9438 slave.cpp:1681] Shutting down executor 'default' of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.978471 9436 hierarchical_allocator_process.hpp:312] Removed framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.978622 9424 status_update_manager.cpp:233] Closing status update streams for framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.978595 9438 exec.cpp:321] Executor asked to shutdown
I0404 04:01:07.978956 9424 status_update_manager.cpp:434] Cleaning up status update stream for task 0 of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.979053 9401 slave.cpp:386] Slave terminating
I0404 04:01:07.979183 9401 slave.cpp:889] Asked to shut down framework 201304040401-453759884-44198-9401-0000 by @0.0.0.0:0
I0404 04:01:07.979290 9401 slave.cpp:894] Shutting down framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.979353 9401 slave.cpp:1681] Shutting down executor 'default' of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.979624 9429 status_update_manager.cpp:233] Closing status update streams for framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.979673 9442 master.cpp:537] Slave 201304040401-453759884-44198-9401-0(hemera.apache.org) disconnected
I0404 04:01:07.979958 9442 master.cpp:542] Removing disconnected slave 201304040401-453759884-44198-9401-0(hemera.apache.org) because it is not checkpointing!
I0404 04:01:07.980123 9401 master.cpp:477] Master terminating
I0404 04:01:07.980553 9401 master.cpp:283] Shutting down master
I0404 04:01:07.981130 9401 master.cpp:283] Shutting down master
I0404 04:01:07.986402 9401 master.hpp:300] Removing task with resources cpus=1; mem=512 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:07.986418 9440 hierarchical_allocator_process.hpp:359] Deactivated framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.986650 9440 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=512 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=1024) on slave 201304040401-453759884-44198-9401-0 from framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.986718 9440 hierarchical_allocator_process.hpp:312] Removed framework 201304040401-453759884-44198-9401-0000
I0404 04:01:07.986855 9440 hierarchical_allocator_process.hpp:423] Removed slave 201304040401-453759884-44198-9401-0
I0404 04:01:07.987934 9401 zookeeper_test_server.cpp:195] Shutdown ZooKeeperTestServer on port 49098
[ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (1069 ms)
[ RUN ] AllocatorZooKeeperTest/0.SlaveReregisterFirst
I0404 04:01:07.988734 9401 jvm.cpp:34] looking up method <init>(Ljava/lang/String;)V
I0404 04:01:07.988775 9401 jvm.cpp:34] looking up method <init>(I)V
I0404 04:01:07.988896 9401 jvm.cpp:34] looking up method <init>(Ljava/net/InetSocketAddress;)V
I0404 04:01:07.988961 9401 jvm.cpp:34] looking up method startup(Lorg/apache/zookeeper/server/ZooKeeperServer;)V
I0404 04:01:07.989044 9401 jvm.cpp:34] looking up method isAlive()Z
I0404 04:01:07.989084 9401 jvm.cpp:34] looking up method shutdown()V
I0404 04:01:07.991430 9401 jvm.cpp:34] looking up method <init>(Ljava/io/File;Ljava/io/File;)V
I0404 04:01:07.991796 9401 jvm.cpp:34] looking up method <init>()V
I0404 04:01:07.991842 9401 jvm.cpp:34] looking up method <init>(Lorg/apache/zookeeper/server/persistence/FileTxnSnapLog;Lorg/apache/zookeeper/server/ZooKeeperServer$DataTreeBuilder;)V
I0404 04:01:07.991955 9401 jvm.cpp:34] looking up method getClientPort()I
I0404 04:01:07.991991 9401 jvm.cpp:34] looking up method closeSession(J)V
I0404 04:01:07.994050 9401 zookeeper_test_server.cpp:212] Started ZooKeeperTestServer on port 39818
I0404 04:01:07.994317 9430 master.cpp:309] Master started on 140.211.11.27:44198
I0404 04:01:07.994371 9430 master.cpp:324] Master ID: 201304040401-453759884-44198-9401
I0404 04:01:07.994518 9439 hierarchical_allocator_process.hpp:236] Initializing hierarchical allocator process with master : master@140.211.11.27:44198
W0404 04:01:07.994518 9425 master.cpp:81] No whitelist given. Advertising offers for all slaves
I0404 04:01:07.995726 9437 slave.cpp:203] Slave started on 82)@140.211.11.27:44198
I0404 04:01:07.995784 9437 slave.cpp:204] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024
I0404 04:01:07.996287 9424 slave.cpp:377] Finished recovery
I0404 04:01:08.003018 9439 detector.cpp:283] Master detector (master@140.211.11.27:44198) connected to ZooKeeper ...
I0404 04:01:08.003061 9439 detector.cpp:300] Trying to create path '/znode' in ZooKeeper
I0404 04:01:08.003568 9433 detector.cpp:283] Master detector (slave(82)@140.211.11.27:44198) connected to ZooKeeper ...
I0404 04:01:08.010411 9433 detector.cpp:300] Trying to create path '/znode' in ZooKeeper
I0404 04:01:08.004101 9423 detector.cpp:283] Master detector (scheduler(72)@140.211.11.27:44198) connected to ZooKeeper ...
I0404 04:01:08.010619 9423 detector.cpp:300] Trying to create path '/znode' in ZooKeeper
I0404 04:01:08.012598 9439 detector.cpp:330] Created ephemeral/sequence znode at '/znode/0000000000'
I0404 04:01:08.014384 9433 detector.cpp:485] Master detector (slave(82)@140.211.11.27:44198) found 1 registered masters
I0404 04:01:08.014394 9423 detector.cpp:485] Master detector (scheduler(72)@140.211.11.27:44198) found 1 registered masters
I0404 04:01:08.014420 9439 detector.cpp:485] Master detector (master@140.211.11.27:44198) found 1 registered masters
I0404 04:01:08.019099 9433 detector.cpp:531] Master detector (slave(82)@140.211.11.27:44198) got new master pid: master@140.211.11.27:44198
I0404 04:01:08.019145 9439 detector.cpp:531] Master detector (master@140.211.11.27:44198) got new master pid: master@140.211.11.27:44198
I0404 04:01:08.019209 9433 slave.cpp:453] New master detected at master@140.211.11.27:44198
I0404 04:01:08.019255 9423 detector.cpp:531] Master detector (scheduler(72)@140.211.11.27:44198) got new master pid: master@140.211.11.27:44198
I0404 04:01:08.019351 9429 status_update_manager.cpp:132] New master detected at master@140.211.11.27:44198
I0404 04:01:08.019358 9432 master.cpp:603] Elected as master!
I0404 04:01:08.019402 9433 sched.cpp:182] New master at master@140.211.11.27:44198
I0404 04:01:08.019497 9432 master.cpp:968] Attempting to register slave on hemera.apache.org at slave(82)@140.211.11.27:44198
I0404 04:01:08.019568 9432 master.cpp:1224] Master now considering a slave at hemera.apache.org:44198 as active
I0404 04:01:08.019613 9432 master.cpp:1862] Adding slave 201304040401-453759884-44198-9401-0 at hemera.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=1024
I0404 04:01:08.019687 9425 slave.cpp:487] Registered with master; given slave ID 201304040401-453759884-44198-9401-0
I0404 04:01:08.019765 9432 master.cpp:646] Registering framework 201304040401-453759884-44198-9401-0000 at scheduler(72)@140.211.11.27:44198
I0404 04:01:08.019793 9435 hierarchical_allocator_process.hpp:395] Added slave 201304040401-453759884-44198-9401-0 (hemera.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=1024 (and cpus=2; mem=1024; ports=[31000-32000]; disk=1024 available)
I0404 04:01:08.019837 9427 sched.cpp:217] Framework registered with 201304040401-453759884-44198-9401-0000
I0404 04:01:08.019915 9435 hierarchical_allocator_process.hpp:632] No users to allocate resources!
I0404 04:01:08.019999 9435 hierarchical_allocator_process.hpp:619] Performed allocation for slave 201304040401-453759884-44198-9401-0 in 84.22us
I0404 04:01:08.020067 9435 hierarchical_allocator_process.hpp:268] Added framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.020102 9435 hierarchical_allocator_process.hpp:660] Found available resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:08.020151 9435 hierarchical_allocator_process.hpp:686] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0 to framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.020233 9435 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 138.01us
I0404 04:01:08.020263 9432 master.hpp:309] Adding offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:08.020334 9432 master.cpp:1327] Sending 1 offers to framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.020445 9435 sched.cpp:282] Received 1 offers
I0404 04:01:08.020613 9432 master.cpp:1534] Processing reply for offer 201304040401-453759884-44198-9401-0 on slave 201304040401-453759884-44198-9401-0 (hemera.apache.org) for framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.020701 9432 master.hpp:289] Adding task with resources cpus=1; mem=512 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:08.020745 9432 master.cpp:1651] Launching task 0 of framework 201304040401-453759884-44198-9401-0000 with resources cpus=1; mem=512 on slave 201304040401-453759884-44198-9401-0 (hemera.apache.org)
I0404 04:01:08.020834 9435 slave.cpp:587] Got assigned task 0 for framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.020848 9432 master.hpp:318] Removing offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:08.020871 9442 hierarchical_allocator_process.hpp:471] Framework 201304040401-453759884-44198-9401-0000 left cpus=1; mem=512; ports=[31000-32000]; disk=1024 unused on slave 201304040401-453759884-44198-9401-0
I0404 04:01:08.021011 9442 hierarchical_allocator_process.hpp:497] Framework 201304040401-453759884-44198-9401-0000 filtered slave 201304040401-453759884-44198-9401-0 for 5.00secs
I0404 04:01:08.022264 9435 paths.hpp:302] Created executor directory '/tmp/AllocatorZooKeeperTest_0_SlaveReregisterFirst_n5qlj5/slaves/201304040401-453759884-44198-9401-0/frameworks/201304040401-453759884-44198-9401-0000/executors/default/runs/1ee4a37d-0f89-4486-8f53-c8dc0ade2307'
I0404 04:01:08.022546 9435 exec.cpp:170] Executor started at: executor(27)@140.211.11.27:44198 with pid 9401
I0404 04:01:08.022711 9438 slave.cpp:1046] Got registration for executor 'default' of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.023013 9438 slave.cpp:1121] Flushing queued tasks for framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.023093 9442 exec.cpp:194] Executor registered on slave 201304040401-453759884-44198-9401-0
I0404 04:01:08.023108 9438 slave.cpp:436] Successfully attached file '/tmp/AllocatorZooKeeperTest_0_SlaveReregisterFirst_n5qlj5/slaves/201304040401-453759884-44198-9401-0/frameworks/201304040401-453759884-44198-9401-0000/executors/default/runs/1ee4a37d-0f89-4486-8f53-c8dc0ade2307'
I0404 04:01:08.023175 9442 exec.cpp:258] Executor asked to run task '0'
I0404 04:01:08.023373 9442 exec.cpp:382] Executor sending status update for task 0 in state TASK_RUNNING
I0404 04:01:08.024659 9442 slave.cpp:1232] Handling status update TASK_RUNNING from task 0 of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.024694 9442 slave.cpp:1280] Forwarding status update TASK_RUNNING from task 0 of framework 201304040401-453759884-44198-9401-0000 to the status update manager
I0404 04:01:08.024868 9426 status_update_manager.cpp:254] Received status update TASK_RUNNING from task 0 of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.024904 9426 status_update_manager.cpp:403] Creating StatusUpdate stream for task 0 of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.024973 9426 status_update_manager.hpp:314] Handling UPDATE for status update TASK_RUNNING from task 0 of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.025035 9426 status_update_manager.cpp:289] Forwarding status update TASK_RUNNING from task 0 of framework 201304040401-453759884-44198-9401-0000 to the master at master@140.211.11.27:44198
I0404 04:01:08.025135 9442 master.cpp:1086] Status update from (831)@140.211.11.27:44198: task 0 of framework 201304040401-453759884-44198-9401-0000 is now in state TASK_RUNNING
I0404 04:01:08.025305 9424 sched.cpp:327] Received status update TASK_RUNNING from task 0 of framework 201304040401-453759884-44198-9401-0000 from slave(82)@140.211.11.27:44198
I0404 04:01:08.025367 9438 slave.cpp:1342] Sending ACK for status update TASK_RUNNING from task 0 of framework 201304040401-453759884-44198-9401-0000 to executor executor(27)@140.211.11.27:44198
I0404 04:01:08.025373 9424 sched.cpp:360] Sending ACK for status update TASK_RUNNING from task 0 of framework 201304040401-453759884-44198-9401-0000 to slave(82)@140.211.11.27:44198
I0404 04:01:08.025419 9401 master.cpp:477] Master terminating
I0404 04:01:08.025476 9428 exec.cpp:289] Executor received ACK for status update of task 0 of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.025499 9421 slave.cpp:979] Got acknowledgement of status update for task 0 of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.025682 9437 status_update_manager.cpp:314] Received status update acknowledgement for task 0 of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.025719 9421 slave.cpp:1392] Process exited: @0.0.0.0:0
I0404 04:01:08.025728 9437 status_update_manager.hpp:314] Handling ACK for status update TASK_RUNNING from task 0 of framework 201304040401-453759884-44198-9401-0000
W0404 04:01:08.025774 9421 slave.cpp:1395] WARNING! Master disconnected! Waiting for a new master to be elected.
I0404 04:01:08.025970 9424 master.cpp:309] Master started on 140.211.11.27:44198
I0404 04:01:08.025975 9433 slave.cpp:1016] Status update manager successfully handled status update acknowledgement for task 0 of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.026021 9424 master.cpp:324] Master ID: 201304040401-453759884-44198-9401
I0404 04:01:08.026681 9432 detector.cpp:485] Master detector (scheduler(72)@140.211.11.27:44198) found 0 registered masters
I0404 04:01:08.026829 9441 detector.cpp:485] Master detector (slave(82)@140.211.11.27:44198) found 0 registered masters
I0404 04:01:08.027386 9421 detector.cpp:283] Master detector (master@140.211.11.27:44198) connected to ZooKeeper ...
I0404 04:01:08.034756 9421 detector.cpp:300] Trying to create path '/znode' in ZooKeeper
I0404 04:01:08.034530 9432 detector.cpp:506] Master detector (scheduler(72)@140.211.11.27:44198) couldn't find any masters
I0404 04:01:08.034665 9441 detector.cpp:506] Master detector (slave(82)@140.211.11.27:44198) couldn't find any masters
I0404 04:01:08.034689 9420 hierarchical_allocator_process.hpp:236] Initializing hierarchical allocator process with master : master@140.211.11.27:44198
I0404 04:01:08.035087 9441 slave.cpp:479] Lost master(s) ... waiting
I0404 04:01:08.034978 9432 sched.cpp:193] No master detected, waiting for another master
W0404 04:01:08.034529 9437 master.cpp:81] No whitelist given. Advertising offers for all slaves
I0404 04:01:08.036615 9421 detector.cpp:330] Created ephemeral/sequence znode at '/znode/0000000002'
I0404 04:01:08.036936 9433 detector.cpp:485] Master detector (scheduler(72)@140.211.11.27:44198) found 1 registered masters
I0404 04:01:08.037052 9426 detector.cpp:485] Master detector (slave(82)@140.211.11.27:44198) found 1 registered masters
I0404 04:01:08.037176 9421 detector.cpp:485] Master detector (master@140.211.11.27:44198) found 1 registered masters
I0404 04:01:08.042989 9433 detector.cpp:531] Master detector (scheduler(72)@140.211.11.27:44198) got new master pid: master@140.211.11.27:44198
I0404 04:01:08.043047 9426 detector.cpp:531] Master detector (slave(82)@140.211.11.27:44198) got new master pid: master@140.211.11.27:44198
I0404 04:01:08.043123 9430 sched.cpp:182] New master at master@140.211.11.27:44198
I0404 04:01:08.043175 9426 slave.cpp:453] New master detected at master@140.211.11.27:44198
I0404 04:01:08.043174 9421 detector.cpp:531] Master detector (master@140.211.11.27:44198) got new master pid: master@140.211.11.27:44198
W0404 04:01:08.043370 9424 master.cpp:996] Ignoring re-register slave message from hemera.apache.org since not elected yet
I0404 04:01:08.043464 9424 master.cpp:603] Elected as master!
I0404 04:01:08.043483 9429 status_update_manager.cpp:132] New master detected at master@140.211.11.27:44198
I0404 04:01:08.995540 9426 hierarchical_allocator_process.hpp:660] Found available resources: cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:08.995663 9426 hierarchical_allocator_process.hpp:756] Filtered cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0 for framework 201304040401-453759884-44198-9401-0000
I0404 04:01:08.995741 9426 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 229.88us
I0404 04:01:09.019701 9439 master.cpp:1029] Attempting to re-register slave 201304040401-453759884-44198-9401-0 at slave(82)@140.211.11.27:44198 (hemera.apache.org)
I0404 04:01:09.019742 9439 master.cpp:1224] Master now considering a slave at hemera.apache.org:44198 as active
I0404 04:01:09.019923 9439 master.cpp:1862] Adding slave 201304040401-453759884-44198-9401-0 at hemera.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=1024
I0404 04:01:09.020143 9422 slave.cpp:520] Re-registered with master
I0404 04:01:09.020257 9439 master.hpp:289] Adding task with resources cpus=1; mem=512 on slave 201304040401-453759884-44198-9401-0
W0404 04:01:09.020344 9439 master.cpp:1948] Possibly orphaned task 0 of framework 201304040401-453759884-44198-9401-0000 running on slave 201304040401-453759884-44198-9401-0 (hemera.apache.org)
I0404 04:01:09.020648 9422 hierarchical_allocator_process.hpp:395] Added slave 201304040401-453759884-44198-9401-0 (hemera.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=1024 (and cpus=1; mem=512; ports=[31000-32000]; disk=1024 available)
I0404 04:01:09.020704 9422 hierarchical_allocator_process.hpp:632] No users to allocate resources!
I0404 04:01:09.020881 9422 hierarchical_allocator_process.hpp:619] Performed allocation for slave 201304040401-453759884-44198-9401-0 in 176.05us
I0404 04:01:09.020889 9426 master.cpp:681] Re-registering framework 201304040401-453759884-44198-9401-0000 at scheduler(72)@140.211.11.27:44198
I0404 04:01:09.021257 9428 sched.cpp:217] Framework registered with 201304040401-453759884-44198-9401-0000
I0404 04:01:09.021597 9436 slave.cpp:956] Updating framework 201304040401-453759884-44198-9401-0000 pid to scheduler(72)@140.211.11.27:44198
I0404 04:01:09.021610 9422 hierarchical_allocator_process.hpp:268] Added framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.021803 9422 hierarchical_allocator_process.hpp:660] Found available resources: cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:09.021880 9422 hierarchical_allocator_process.hpp:686] Offering cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0 to framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.022008 9422 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 213.39us
I0404 04:01:09.022073 9422 master.hpp:309] Adding offer with resources cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:09.022153 9422 master.cpp:1327] Sending 1 offers to framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.022337 9443 sched.cpp:282] Received 1 offers
I0404 04:01:09.022560 9421 sched.cpp:422] Stopping framework '201304040401-453759884-44198-9401-0000'
I0404 04:01:09.022650 9431 master.cpp:774] Asked to unregister framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.022781 9422 hierarchical_allocator_process.hpp:359] Deactivated framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.022806 9431 master.hpp:300] Removing task with resources cpus=1; mem=512 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:09.022790 9438 slave.cpp:889] Asked to shut down framework 201304040401-453759884-44198-9401-0000 by master@140.211.11.27:44198
I0404 04:01:09.023000 9431 master.hpp:318] Removing offer with resources cpus=1; mem=512; ports=[31000-32000]; disk=1024 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:09.023056 9438 slave.cpp:894] Shutting down framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.023088 9436 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=512 (total allocatable: cpus=1; mem=512; ports=[]; disk=0) on slave 201304040401-453759884-44198-9401-0 from framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.023253 9438 slave.cpp:1681] Shutting down executor 'default' of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.023357 9436 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=512; ports=[31000-32000]; disk=1024 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=1024) on slave 201304040401-453759884-44198-9401-0 from framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.023406 9435 exec.cpp:321] Executor asked to shutdown
I0404 04:01:09.023411 9438 status_update_manager.cpp:233] Closing status update streams for framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.030570 9438 status_update_manager.cpp:434] Cleaning up status update stream for task 0 of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.030496 9401 slave.cpp:386] Slave terminating
I0404 04:01:09.030417 9436 hierarchical_allocator_process.hpp:312] Removed framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.030732 9401 slave.cpp:889] Asked to shut down framework 201304040401-453759884-44198-9401-0000 by @0.0.0.0:0
I0404 04:01:09.030833 9401 slave.cpp:894] Shutting down framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.030899 9401 slave.cpp:1681] Shutting down executor 'default' of framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.031138 9429 status_update_manager.cpp:233] Closing status update streams for framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.031352 9436 master.cpp:537] Slave 201304040401-453759884-44198-9401-0(hemera.apache.org) disconnected
I0404 04:01:09.031404 9436 master.cpp:542] Removing disconnected slave 201304040401-453759884-44198-9401-0(hemera.apache.org) because it is not checkpointing!
I0404 04:01:09.032008 9401 master.cpp:477] Master terminating
I0404 04:01:09.032346 9401 master.cpp:283] Shutting down master
I0404 04:01:09.035774 9440 hierarchical_allocator_process.hpp:632] No users to allocate resources!
I0404 04:01:09.038455 9440 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 2.69ms
I0404 04:01:09.038789 9401 master.cpp:283] Shutting down master
I0404 04:01:09.038877 9435 hierarchical_allocator_process.hpp:359] Deactivated framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.038893 9401 master.hpp:300] Removing task with resources cpus=1; mem=512 on slave 201304040401-453759884-44198-9401-0
I0404 04:01:09.039371 9424 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=512 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=1024) on slave 201304040401-453759884-44198-9401-0 from framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.039446 9424 hierarchical_allocator_process.hpp:312] Removed framework 201304040401-453759884-44198-9401-0000
I0404 04:01:09.039592 9424 hierarchical_allocator_process.hpp:423] Removed slave 201304040401-453759884-44198-9401-0
I0404 04:01:09.040531 9401 zookeeper_test_server.cpp:195] Shutdown ZooKeeperTestServer on port 39818
[ OK ] AllocatorZooKeeperTest/0.SlaveReregisterFirst (1053 ms)
[----------] 2 tests from AllocatorZooKeeperTest/0 (2122 ms total)
[----------] Global test environment tear-down
[==========] 190 tests from 39 test cases ran. (85252 ms total)
[ PASSED ] 189 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] FaultToleranceTest.SchedulerFailover
1 FAILED TEST
YOU HAVE 1 DISABLED TEST
FAIL: mesos-tests
==================
1 of 1 test failed
==================
make[3]: *** [check-TESTS] Error 1
make[3]: Leaving directory `/x1/jenkins/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 `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/src'
make[1]: *** [check] Error 2
make[1]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/src'
make: *** [check-recursive] Error 1
Process leaked file descriptors. See http://wiki.jenkins-ci.org/display/JENKINS/Spawning+processes+from+build for more information
Build step 'Execute shell' marked build as failure