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/16 04:02:36 UTC
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #339
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/339/changes>
Changes:
[bmahler] Updated the Resource Monitor tests to use dispatch expectations.
Review: https://reviews.apache.org/r/10485
------------------------------------------
[...truncated 15713 lines...]
I0416 02:02:34.469779 14869 detector.cpp:506] Master detector (slave(82)@67.195.138.60:58588) couldn't find any masters
I0416 02:02:34.465926 14875 slave.cpp:1016] Status update manager successfully handled status update acknowledgement for task 0 of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:34.501683 14875 slave.cpp:479] Lost master(s) ... waiting
I0416 02:02:34.531339 14874 detector.cpp:330] Created ephemeral/sequence znode at '/znode/0000000002'
I0416 02:02:34.531838 14868 detector.cpp:485] Master detector (slave(82)@67.195.138.60:58588) found 1 registered masters
I0416 02:02:34.532246 14871 detector.cpp:485] Master detector (scheduler(74)@67.195.138.60:58588) found 1 registered masters
I0416 02:02:34.532630 14868 detector.cpp:531] Master detector (slave(82)@67.195.138.60:58588) got new master pid: master@67.195.138.60:58588
I0416 02:02:34.532802 14868 slave.cpp:453] New master detected at master@67.195.138.60:58588
I0416 02:02:34.532884 14874 detector.cpp:485] Master detector (master@67.195.138.60:58588) found 1 registered masters
I0416 02:02:34.533229 14871 detector.cpp:531] Master detector (scheduler(74)@67.195.138.60:58588) got new master pid: master@67.195.138.60:58588
I0416 02:02:34.533334 14873 status_update_manager.cpp:132] New master detected at master@67.195.138.60:58588
I0416 02:02:34.534173 14874 detector.cpp:531] Master detector (master@67.195.138.60:58588) got new master pid: master@67.195.138.60:58588
I0416 02:02:34.534322 14871 sched.cpp:182] New master at master@67.195.138.60:58588
I0416 02:02:34.535207 14874 master.cpp:603] Elected as master!
I0416 02:02:34.536105 14874 master.cpp:681] Re-registering framework 201304160202-1015726915-58588-14849-0000 at scheduler(74)@67.195.138.60:58588
I0416 02:02:34.536720 14869 sched.cpp:217] Framework registered with 201304160202-1015726915-58588-14849-0000
I0416 02:02:34.536833 14874 hierarchical_allocator_process.hpp:268] Added framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:34.537497 14874 hierarchical_allocator_process.hpp:668] No resources available to allocate!
I0416 02:02:34.537889 14874 hierarchical_allocator_process.hpp:599] Performed allocation for 0 slaves in 395.00us
I0416 02:02:35.261570 14875 hierarchical_allocator_process.hpp:660] Found available resources: cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.285363 14875 hierarchical_allocator_process.hpp:756] Filtered cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0 for framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.285750 14875 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 24.21ms
I0416 02:02:35.389806 14875 master.cpp:1029] Attempting to re-register slave 201304160202-1015726915-58588-14849-0 at slave(82)@67.195.138.60:58588 (janus.apache.org)
I0416 02:02:35.389842 14875 master.cpp:1224] Master now considering a slave at janus.apache.org:58588 as active
I0416 02:02:35.390182 14875 master.cpp:1862] Adding slave 201304160202-1015726915-58588-14849-0 at janus.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=1024
I0416 02:02:35.390655 14874 slave.cpp:520] Re-registered with master
I0416 02:02:35.390740 14875 master.hpp:289] Adding task with resources cpus=1; mem=500 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.391677 14869 slave.cpp:956] Updating framework 201304160202-1015726915-58588-14849-0000 pid to scheduler(74)@67.195.138.60:58588
I0416 02:02:35.391803 14870 hierarchical_allocator_process.hpp:395] Added slave 201304160202-1015726915-58588-14849-0 (janus.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=1024 (and cpus=1; mem=524; ports=[31000-32000]; disk=1024 available)
I0416 02:02:35.392570 14870 hierarchical_allocator_process.hpp:660] Found available resources: cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.393028 14870 hierarchical_allocator_process.hpp:686] Offering cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0 to framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.393589 14870 hierarchical_allocator_process.hpp:619] Performed allocation for slave 201304160202-1015726915-58588-14849-0 in 1.03ms
I0416 02:02:35.393635 14874 master.hpp:309] Adding offer with resources cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.394455 14874 master.cpp:1327] Sending 1 offers to framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.394955 14874 sched.cpp:282] Received 1 offers
I0416 02:02:35.395735 14868 sched.cpp:422] Stopping framework '201304160202-1015726915-58588-14849-0000'
I0416 02:02:35.395901 14872 master.cpp:774] Asked to unregister framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.396381 14872 master.hpp:300] Removing task with resources cpus=1; mem=500 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.396420 14870 slave.cpp:889] Asked to shut down framework 201304160202-1015726915-58588-14849-0000 by master@67.195.138.60:58588
I0416 02:02:35.396435 14873 hierarchical_allocator_process.hpp:359] Deactivated framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.396915 14872 master.hpp:318] Removing offer with resources cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.404196 14870 slave.cpp:894] Shutting down framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.404667 14873 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201304160202-1015726915-58588-14849-0 from framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.406152 14873 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=1024 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=1024) on slave 201304160202-1015726915-58588-14849-0 from framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.405580 14870 slave.cpp:1681] Shutting down executor 'default' of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.407524 14868 exec.cpp:321] Executor asked to shutdown
I0416 02:02:35.407548 14870 slave.cpp:386] Slave terminating
I0416 02:02:35.408409 14870 slave.cpp:889] Asked to shut down framework 201304160202-1015726915-58588-14849-0000 by @0.0.0.0:0
I0416 02:02:35.408880 14870 slave.cpp:894] Shutting down framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.409353 14870 slave.cpp:1681] Shutting down executor 'default' of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.407560 14871 status_update_manager.cpp:233] Closing status update streams for framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.409900 14874 master.cpp:537] Slave 201304160202-1015726915-58588-14849-0(janus.apache.org) disconnected
I0416 02:02:35.410786 14874 master.cpp:542] Removing disconnected slave 201304160202-1015726915-58588-14849-0(janus.apache.org) because it is not checkpointing!
I0416 02:02:35.410326 14871 status_update_manager.cpp:434] Cleaning up status update stream for task 0 of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.411767 14871 status_update_manager.cpp:233] Closing status update streams for framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.411330 14868 master.cpp:477] Master terminating
I0416 02:02:35.412997 14849 master.cpp:283] Shutting down master
I0416 02:02:35.413712 14849 master.cpp:283] Shutting down master
I0416 02:02:35.414450 14870 hierarchical_allocator_process.hpp:359] Deactivated framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.414473 14849 master.hpp:300] Removing task with resources cpus=1; mem=500 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.415402 14874 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=1024) on slave 201304160202-1015726915-58588-14849-0 from framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.415912 14874 hierarchical_allocator_process.hpp:312] Removed framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.416342 14874 hierarchical_allocator_process.hpp:423] Removed slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.422719 14849 zookeeper_test_server.cpp:195] Shutdown ZooKeeperTestServer on port 37666
[ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (2202 ms)
[ RUN ] AllocatorZooKeeperTest/0.SlaveReregistersFirst
I0416 02:02:35.424079 14849 jvm.cpp:34] looking up method <init>(Ljava/lang/String;)V
I0416 02:02:35.424128 14849 jvm.cpp:34] looking up method <init>(I)V
I0416 02:02:35.424484 14849 jvm.cpp:34] looking up method <init>(Ljava/net/InetSocketAddress;)V
I0416 02:02:35.424955 14849 jvm.cpp:34] looking up method startup(Lorg/apache/zookeeper/server/ZooKeeperServer;)V
I0416 02:02:35.425428 14849 jvm.cpp:34] looking up method isAlive()Z
I0416 02:02:35.425922 14849 jvm.cpp:34] looking up method shutdown()V
I0416 02:02:35.428917 14849 jvm.cpp:34] looking up method <init>(Ljava/io/File;Ljava/io/File;)V
I0416 02:02:35.429438 14849 jvm.cpp:34] looking up method <init>()V
I0416 02:02:35.429693 14849 jvm.cpp:34] looking up method <init>(Lorg/apache/zookeeper/server/persistence/FileTxnSnapLog;Lorg/apache/zookeeper/server/ZooKeeperServer$DataTreeBuilder;)V
I0416 02:02:35.430213 14849 jvm.cpp:34] looking up method getClientPort()I
I0416 02:02:35.430596 14849 jvm.cpp:34] looking up method closeSession(J)V
I0416 02:02:35.432759 14849 zookeeper_test_server.cpp:212] Started ZooKeeperTestServer on port 43337
I0416 02:02:35.432977 14873 master.cpp:309] Master started on 67.195.138.60:58588
I0416 02:02:35.433249 14873 master.cpp:324] Master ID: 201304160202-1015726915-58588-14849
I0416 02:02:35.433902 14875 hierarchical_allocator_process.hpp:236] Initializing hierarchical allocator process with master : master@67.195.138.60:58588
W0416 02:02:35.433938 14874 master.cpp:81] No whitelist given. Advertising offers for all slaves
I0416 02:02:35.433954 14868 slave.cpp:203] Slave started on 83)@67.195.138.60:58588
I0416 02:02:35.435627 14868 slave.cpp:204] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024
I0416 02:02:35.439379 14873 slave.cpp:377] Finished recovery
I0416 02:02:35.477419 14870 detector.cpp:283] Master detector (master@67.195.138.60:58588) connected to ZooKeeper ...
I0416 02:02:35.477463 14870 detector.cpp:300] Trying to create path '/znode' in ZooKeeper
I0416 02:02:35.487634 14873 detector.cpp:283] Master detector (slave(83)@67.195.138.60:58588) connected to ZooKeeper ...
I0416 02:02:35.487673 14873 detector.cpp:300] Trying to create path '/znode' in ZooKeeper
I0416 02:02:35.488131 14872 detector.cpp:283] Master detector (scheduler(75)@67.195.138.60:58588) connected to ZooKeeper ...
I0416 02:02:35.488499 14872 detector.cpp:300] Trying to create path '/znode' in ZooKeeper
I0416 02:02:35.510812 14870 detector.cpp:330] Created ephemeral/sequence znode at '/znode/0000000000'
I0416 02:02:35.511047 14872 detector.cpp:485] Master detector (scheduler(75)@67.195.138.60:58588) found 1 registered masters
I0416 02:02:35.511234 14873 detector.cpp:485] Master detector (slave(83)@67.195.138.60:58588) found 1 registered masters
I0416 02:02:35.511476 14870 detector.cpp:485] Master detector (master@67.195.138.60:58588) found 1 registered masters
I0416 02:02:35.511814 14872 detector.cpp:531] Master detector (scheduler(75)@67.195.138.60:58588) got new master pid: master@67.195.138.60:58588
I0416 02:02:35.512137 14873 detector.cpp:531] Master detector (slave(83)@67.195.138.60:58588) got new master pid: master@67.195.138.60:58588
I0416 02:02:35.512616 14870 detector.cpp:531] Master detector (master@67.195.138.60:58588) got new master pid: master@67.195.138.60:58588
I0416 02:02:35.512723 14872 sched.cpp:182] New master at master@67.195.138.60:58588
I0416 02:02:35.513233 14873 slave.cpp:453] New master detected at master@67.195.138.60:58588
I0416 02:02:35.513669 14870 master.cpp:603] Elected as master!
I0416 02:02:35.514634 14868 status_update_manager.cpp:132] New master detected at master@67.195.138.60:58588
I0416 02:02:35.515141 14870 master.cpp:646] Registering framework 201304160202-1015726915-58588-14849-0000 at scheduler(75)@67.195.138.60:58588
I0416 02:02:35.516016 14874 sched.cpp:217] Framework registered with 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.516041 14871 hierarchical_allocator_process.hpp:268] Added framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.516954 14871 hierarchical_allocator_process.hpp:668] No resources available to allocate!
I0416 02:02:35.517416 14871 hierarchical_allocator_process.hpp:599] Performed allocation for 0 slaves in 464.47us
I0416 02:02:35.516041 14870 master.cpp:968] Attempting to register slave on janus.apache.org at slave(83)@67.195.138.60:58588
I0416 02:02:35.518365 14870 master.cpp:1224] Master now considering a slave at janus.apache.org:58588 as active
I0416 02:02:35.518842 14870 master.cpp:1862] Adding slave 201304160202-1015726915-58588-14849-0 at janus.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=1024
I0416 02:02:35.519373 14873 slave.cpp:487] Registered with master; given slave ID 201304160202-1015726915-58588-14849-0
I0416 02:02:35.519474 14872 hierarchical_allocator_process.hpp:395] Added slave 201304160202-1015726915-58588-14849-0 (janus.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=1024 (and cpus=2; mem=1024; ports=[31000-32000]; disk=1024 available)
I0416 02:02:35.521062 14872 hierarchical_allocator_process.hpp:660] Found available resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.521502 14872 hierarchical_allocator_process.hpp:686] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0 to framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.522063 14872 hierarchical_allocator_process.hpp:619] Performed allocation for slave 201304160202-1015726915-58588-14849-0 in 1.01ms
I0416 02:02:35.522100 14873 master.hpp:309] Adding offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.523473 14873 master.cpp:1327] Sending 1 offers to framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.523926 14870 sched.cpp:282] Received 1 offers
I0416 02:02:35.524539 14873 master.cpp:1534] Processing reply for offer 201304160202-1015726915-58588-14849-0 on slave 201304160202-1015726915-58588-14849-0 (janus.apache.org) for framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.524936 14873 master.hpp:289] Adding task with resources cpus=1; mem=500 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.525348 14873 master.cpp:1651] Launching task 0 of framework 201304160202-1015726915-58588-14849-0000 with resources cpus=1; mem=500 on slave 201304160202-1015726915-58588-14849-0 (janus.apache.org)
I0416 02:02:35.525889 14870 slave.cpp:587] Got assigned task 0 for framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.525967 14873 master.hpp:318] Removing offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.525964 14869 hierarchical_allocator_process.hpp:471] Framework 201304160202-1015726915-58588-14849-0000 left cpus=1; mem=524; ports=[31000-32000]; disk=1024 unused on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.527396 14869 hierarchical_allocator_process.hpp:497] Framework 201304160202-1015726915-58588-14849-0000 filtered slave 201304160202-1015726915-58588-14849-0 for 5.00secs
I0416 02:02:35.528198 14870 paths.hpp:302] Created executor directory '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_PUkZlr/slaves/201304160202-1015726915-58588-14849-0/frameworks/201304160202-1015726915-58588-14849-0000/executors/default/runs/44e8d2c6-de5c-4c31-89aa-997d5e693874'
I0416 02:02:35.528519 14873 slave.cpp:436] Successfully attached file '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_PUkZlr/slaves/201304160202-1015726915-58588-14849-0/frameworks/201304160202-1015726915-58588-14849-0000/executors/default/runs/44e8d2c6-de5c-4c31-89aa-997d5e693874'
I0416 02:02:35.528650 14870 exec.cpp:170] Executor started at: executor(27)@67.195.138.60:58588 with pid 14849
I0416 02:02:35.530194 14870 slave.cpp:1046] Got registration for executor 'default' of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.530658 14870 slave.cpp:1121] Flushing queued tasks for framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.530716 14869 exec.cpp:194] Executor registered on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.531707 14869 exec.cpp:258] Executor asked to run task '0'
I0416 02:02:35.532152 14869 exec.cpp:382] Executor sending status update for task 0 in state TASK_RUNNING
I0416 02:02:35.534140 14873 slave.cpp:1232] Handling status update TASK_RUNNING from task 0 of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.534194 14873 slave.cpp:1280] Forwarding status update TASK_RUNNING from task 0 of framework 201304160202-1015726915-58588-14849-0000 to the status update manager
I0416 02:02:35.534607 14874 status_update_manager.cpp:254] Received status update TASK_RUNNING from task 0 of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.535030 14874 status_update_manager.cpp:403] Creating StatusUpdate stream for task 0 of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.535509 14874 status_update_manager.hpp:314] Handling UPDATE for status update TASK_RUNNING from task 0 of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.536006 14874 status_update_manager.cpp:289] Forwarding status update TASK_RUNNING from task 0 of framework 201304160202-1015726915-58588-14849-0000 to the master at master@67.195.138.60:58588
I0416 02:02:35.536533 14873 master.cpp:1086] Status update from (825)@67.195.138.60:58588: task 0 of framework 201304160202-1015726915-58588-14849-0000 is now in state TASK_RUNNING
I0416 02:02:35.537307 14873 sched.cpp:327] Received status update TASK_RUNNING from task 0 of framework 201304160202-1015726915-58588-14849-0000 from slave(83)@67.195.138.60:58588
I0416 02:02:35.536535 14874 slave.cpp:1342] Sending ACK for status update TASK_RUNNING from task 0 of framework 201304160202-1015726915-58588-14849-0000 to executor executor(27)@67.195.138.60:58588
I0416 02:02:35.537835 14873 sched.cpp:360] Sending ACK for status update TASK_RUNNING from task 0 of framework 201304160202-1015726915-58588-14849-0000 to slave(83)@67.195.138.60:58588
I0416 02:02:35.538764 14873 slave.cpp:979] Got acknowledgement of status update for task 0 of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.538300 14872 exec.cpp:289] Executor received ACK for status update of task 0 of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.538092 14849 master.cpp:477] Master terminating
I0416 02:02:35.539259 14873 status_update_manager.cpp:314] Received status update acknowledgement for task 0 of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.540271 14871 slave.cpp:1392] Process exited: @0.0.0.0:0
W0416 02:02:35.541893 14871 slave.cpp:1395] WARNING! Master disconnected! Waiting for a new master to be elected.
I0416 02:02:35.540993 14874 master.cpp:309] Master started on 67.195.138.60:58588
I0416 02:02:35.540716 14873 status_update_manager.hpp:314] Handling ACK for status update TASK_RUNNING from task 0 of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.554719 14874 master.cpp:324] Master ID: 201304160202-1015726915-58588-14849
W0416 02:02:35.563134 14871 master.cpp:81] No whitelist given. Advertising offers for all slaves
I0416 02:02:35.563272 14872 hierarchical_allocator_process.hpp:236] Initializing hierarchical allocator process with master : master@67.195.138.60:58588
I0416 02:02:35.562656 14873 slave.cpp:1016] Status update manager successfully handled status update acknowledgement for task 0 of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:35.569272 14868 detector.cpp:283] Master detector (master@67.195.138.60:58588) connected to ZooKeeper ...
I0416 02:02:35.569324 14868 detector.cpp:300] Trying to create path '/znode' in ZooKeeper
I0416 02:02:35.569490 14869 detector.cpp:485] Master detector (scheduler(75)@67.195.138.60:58588) found 0 registered masters
I0416 02:02:35.569643 14870 detector.cpp:485] Master detector (slave(83)@67.195.138.60:58588) found 0 registered masters
I0416 02:02:35.570197 14869 detector.cpp:506] Master detector (scheduler(75)@67.195.138.60:58588) couldn't find any masters
I0416 02:02:35.571527 14870 detector.cpp:506] Master detector (slave(83)@67.195.138.60:58588) couldn't find any masters
I0416 02:02:35.588048 14870 slave.cpp:479] Lost master(s) ... waiting
I0416 02:02:35.587630 14871 sched.cpp:193] No master detected, waiting for another master
I0416 02:02:35.602629 14868 detector.cpp:330] Created ephemeral/sequence znode at '/znode/0000000002'
I0416 02:02:35.603124 14873 detector.cpp:485] Master detector (slave(83)@67.195.138.60:58588) found 1 registered masters
I0416 02:02:35.603242 14875 detector.cpp:485] Master detector (scheduler(75)@67.195.138.60:58588) found 1 registered masters
I0416 02:02:35.603427 14868 detector.cpp:485] Master detector (master@67.195.138.60:58588) found 1 registered masters
I0416 02:02:35.603857 14873 detector.cpp:531] Master detector (slave(83)@67.195.138.60:58588) got new master pid: master@67.195.138.60:58588
I0416 02:02:35.604185 14875 detector.cpp:531] Master detector (scheduler(75)@67.195.138.60:58588) got new master pid: master@67.195.138.60:58588
I0416 02:02:35.604538 14868 detector.cpp:531] Master detector (master@67.195.138.60:58588) got new master pid: master@67.195.138.60:58588
I0416 02:02:35.605521 14868 master.cpp:603] Elected as master!
I0416 02:02:35.605056 14875 sched.cpp:182] New master at master@67.195.138.60:58588
I0416 02:02:35.604584 14871 slave.cpp:453] New master detected at master@67.195.138.60:58588
I0416 02:02:35.606962 14870 status_update_manager.cpp:132] New master detected at master@67.195.138.60:58588
I0416 02:02:35.607094 14873 master.cpp:1029] Attempting to re-register slave 201304160202-1015726915-58588-14849-0 at slave(83)@67.195.138.60:58588 (janus.apache.org)
I0416 02:02:35.608345 14873 master.cpp:1224] Master now considering a slave at janus.apache.org:58588 as active
I0416 02:02:35.608757 14873 master.cpp:1862] Adding slave 201304160202-1015726915-58588-14849-0 at janus.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=1024
I0416 02:02:35.609293 14873 master.hpp:289] Adding task with resources cpus=1; mem=500 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:35.609318 14874 slave.cpp:520] Re-registered with master
W0416 02:02:35.609710 14873 master.cpp:1948] Possibly orphaned task 0 of framework 201304160202-1015726915-58588-14849-0000 running on slave 201304160202-1015726915-58588-14849-0 (janus.apache.org)
I0416 02:02:35.610879 14874 hierarchical_allocator_process.hpp:395] Added slave 201304160202-1015726915-58588-14849-0 (janus.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=1024 (and cpus=1; mem=524; ports=[31000-32000]; disk=1024 available)
I0416 02:02:35.611134 14874 hierarchical_allocator_process.hpp:632] No users to allocate resources!
I0416 02:02:35.611596 14874 hierarchical_allocator_process.hpp:619] Performed allocation for slave 201304160202-1015726915-58588-14849-0 in 463.19us
I0416 02:02:36.435034 14869 hierarchical_allocator_process.hpp:660] Found available resources: cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:36.460396 14869 hierarchical_allocator_process.hpp:756] Filtered cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0 for framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.460753 14869 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 25.75ms
I0416 02:02:36.515177 14872 master.cpp:681] Re-registering framework 201304160202-1015726915-58588-14849-0000 at scheduler(75)@67.195.138.60:58588
I0416 02:02:36.515372 14870 sched.cpp:217] Framework registered with 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.515413 14875 slave.cpp:956] Updating framework 201304160202-1015726915-58588-14849-0000 pid to scheduler(75)@67.195.138.60:58588
I0416 02:02:36.515462 14874 hierarchical_allocator_process.hpp:268] Added framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.516515 14874 hierarchical_allocator_process.hpp:660] Found available resources: cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:36.516971 14874 hierarchical_allocator_process.hpp:686] Offering cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0 to framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.517540 14874 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 1.05ms
I0416 02:02:36.517596 14872 master.hpp:309] Adding offer with resources cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:36.518431 14872 master.cpp:1327] Sending 1 offers to framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.518923 14869 sched.cpp:282] Received 1 offers
I0416 02:02:36.519666 14871 sched.cpp:422] Stopping framework '201304160202-1015726915-58588-14849-0000'
I0416 02:02:36.519862 14874 master.cpp:774] Asked to unregister framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.520356 14870 slave.cpp:889] Asked to shut down framework 201304160202-1015726915-58588-14849-0000 by master@67.195.138.60:58588
I0416 02:02:36.520359 14874 master.hpp:300] Removing task with resources cpus=1; mem=500 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:36.520401 14871 hierarchical_allocator_process.hpp:359] Deactivated framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.520795 14870 slave.cpp:894] Shutting down framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.528926 14874 master.hpp:318] Removing offer with resources cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:36.529300 14871 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201304160202-1015726915-58588-14849-0 from framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.529706 14870 slave.cpp:1681] Shutting down executor 'default' of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.531194 14869 exec.cpp:321] Executor asked to shutdown
I0416 02:02:36.531213 14870 slave.cpp:386] Slave terminating
I0416 02:02:36.532104 14870 slave.cpp:889] Asked to shut down framework 201304160202-1015726915-58588-14849-0000 by @0.0.0.0:0
I0416 02:02:36.531225 14875 status_update_manager.cpp:233] Closing status update streams for framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.530800 14871 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=1024 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=1024) on slave 201304160202-1015726915-58588-14849-0 from framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.532572 14870 slave.cpp:894] Shutting down framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.533993 14870 slave.cpp:1681] Shutting down executor 'default' of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.533071 14875 status_update_manager.cpp:434] Cleaning up status update stream for task 0 of framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.534519 14868 master.cpp:537] Slave 201304160202-1015726915-58588-14849-0(janus.apache.org) disconnected
I0416 02:02:36.535423 14868 master.cpp:542] Removing disconnected slave 201304160202-1015726915-58588-14849-0(janus.apache.org) because it is not checkpointing!
I0416 02:02:36.534963 14875 status_update_manager.cpp:233] Closing status update streams for framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.536051 14849 master.cpp:477] Master terminating
I0416 02:02:36.537190 14849 master.cpp:283] Shutting down master
I0416 02:02:36.537794 14849 master.cpp:283] Shutting down master
I0416 02:02:36.537868 14868 hierarchical_allocator_process.hpp:359] Deactivated framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.537876 14849 master.hpp:300] Removing task with resources cpus=1; mem=500 on slave 201304160202-1015726915-58588-14849-0
I0416 02:02:36.539644 14874 hierarchical_allocator_process.hpp:544] Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=1024) on slave 201304160202-1015726915-58588-14849-0 from framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.540060 14874 hierarchical_allocator_process.hpp:312] Removed framework 201304160202-1015726915-58588-14849-0000
I0416 02:02:36.540509 14874 hierarchical_allocator_process.hpp:423] Removed slave 201304160202-1015726915-58588-14849-0
I0416 02:02:36.548682 14849 zookeeper_test_server.cpp:195] Shutdown ZooKeeperTestServer on port 43337
[ OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (1126 ms)
[----------] 2 tests from AllocatorZooKeeperTest/0 (3328 ms total)
[----------] Global test environment tear-down
[==========] 190 tests from 39 test cases ran. (96420 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 `<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 #340
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/340/changes>