The fix for this is at https://reviews.apache.org/r/10462.
On Sun, Apr 14, 2013 at 8:52 PM, Apache Jenkins Server < [email protected]> wrote: > See < > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/303/changes > > > > Changes: > > [bmahler] Replaced sleep() and usleep() calls with os::sleep(). > > From: Jiang Yan Xu <[email protected]> > Review: https://reviews.apache.org/r/10443 > > [bmahler] Replaced usleep() calls in libprocess with os::sleep(). > > From: Jiang Yan Xu <[email protected]> > Review: https://reviews.apache.org/r/10241 > > [bmahler] Changed os::sleep() to take a Duration instead of a double. > > From: Jiang Yan Xu <[email protected]> > Review: https://reviews.apache.org/r/10231 > > ------------------------------------------ > [...truncated 15692 lines...] > I0415 03:52:14.867821 28013 detector.cpp:531] Master detector (slave(82)@ > 67.195.138.60:60471) got new master pid: [email protected]:60471 > I0415 03:52:14.869232 28013 slave.cpp:453] New master detected at > [email protected]:60471 > W0415 03:52:14.868774 28018 master.cpp:668] Ignoring re-register framework > message since not elected yet > I0415 03:52:14.868716 28011 detector.cpp:531] Master detector ( > [email protected]:60471) got new master pid: > [email protected]:60471 > I0415 03:52:14.869796 28013 status_update_manager.cpp:132] New master > detected at [email protected]:60471 > I0415 03:52:14.870738 28011 master.cpp:603] Elected as master! > I0415 03:52:15.710227 28016 hierarchical_allocator_process.hpp:660] Found > available resources: cpus=1; mem=524; ports=[31000-32000]; disk=1024 on > slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:15.750718 28016 hierarchical_allocator_process.hpp:756] > Filtered cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave > 201304150352-1015726915-60471-27966-0 for framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.751005 28016 hierarchical_allocator_process.hpp:599] > Performed allocation for 1 slaves in 40.82ms > I0415 03:52:15.778457 28015 master.cpp:681] Re-registering framework > 201304150352-1015726915-60471-27966-0000 at scheduler(74)@ > 67.195.138.60:60471 > I0415 03:52:15.778777 28017 sched.cpp:217] Framework registered with > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.778832 28015 hierarchical_allocator_process.hpp:268] Added > framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.779409 28015 hierarchical_allocator_process.hpp:668] No > resources available to allocate! > I0415 03:52:15.779876 28015 hierarchical_allocator_process.hpp:599] > Performed allocation for 0 slaves in 468.78us > I0415 03:52:15.825428 28017 hierarchical_allocator_process.hpp:668] No > resources available to allocate! > I0415 03:52:15.825634 28017 hierarchical_allocator_process.hpp:599] > Performed allocation for 0 slaves in 232.74us > I0415 03:52:15.870821 28017 master.cpp:1029] Attempting to re-register > slave 201304150352-1015726915-60471-27966-0 at slave(82)@ > 67.195.138.60:60471 (janus.apache.org) > I0415 03:52:15.870980 28017 master.cpp:1224] Master now considering a > slave at janus.apache.org:60471 as active > I0415 03:52:15.871337 28017 master.cpp:1862] Adding slave > 201304150352-1015726915-60471-27966-0 at janus.apache.org with cpus=2; > mem=1024; ports=[31000-32000]; disk=1024 > I0415 03:52:15.871814 28013 slave.cpp:520] Re-registered with master > I0415 03:52:15.871881 28017 master.hpp:289] Adding task with resources > cpus=1; mem=500 on slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:15.872872 28012 slave.cpp:956] Updating framework > 201304150352-1015726915-60471-27966-0000 pid to scheduler(74)@ > 67.195.138.60:60471 > I0415 03:52:15.872985 28015 hierarchical_allocator_process.hpp:395] Added > slave 201304150352-1015726915-60471-27966-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) > I0415 03:52:15.873723 28015 hierarchical_allocator_process.hpp:660] Found > available resources: cpus=1; mem=524; ports=[31000-32000]; disk=1024 on > slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:15.874207 28015 hierarchical_allocator_process.hpp:686] > Offering cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave > 201304150352-1015726915-60471-27966-0 to framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.874761 28015 hierarchical_allocator_process.hpp:619] > Performed allocation for slave 201304150352-1015726915-60471-27966-0 in > 1.05ms > I0415 03:52:15.874876 28011 master.hpp:309] Adding offer with resources > cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave > 201304150352-1015726915-60471-27966-0 > I0415 03:52:15.875663 28011 master.cpp:1327] Sending 1 offers to framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.876142 28014 sched.cpp:282] Received 1 offers > I0415 03:52:15.877135 28018 sched.cpp:422] Stopping framework > '201304150352-1015726915-60471-27966-0000' > I0415 03:52:15.877218 28011 master.cpp:774] Asked to unregister framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.877617 28018 slave.cpp:889] Asked to shut down framework > 201304150352-1015726915-60471-27966-0000 by [email protected]:60471 > I0415 03:52:15.877672 28017 hierarchical_allocator_process.hpp:359] > Deactivated framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.877657 28011 master.hpp:300] Removing task with resources > cpus=1; mem=500 on slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:15.877977 28018 slave.cpp:894] Shutting down framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.885417 28017 hierarchical_allocator_process.hpp:544] > Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; > disk=0) on slave 201304150352-1015726915-60471-27966-0 from framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.885397 28011 master.hpp:318] Removing offer with resources > cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave > 201304150352-1015726915-60471-27966-0 > I0415 03:52:15.885673 28018 slave.cpp:1681] Shutting down executor > 'default' of framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.886265 28017 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 > 201304150352-1015726915-60471-27966-0 from framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.887142 28014 exec.cpp:321] Executor asked to shutdown > I0415 03:52:15.887159 28018 slave.cpp:386] Slave terminating > I0415 03:52:15.887166 28016 status_update_manager.cpp:233] Closing status > update streams for framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.889034 28016 status_update_manager.cpp:434] Cleaning up > status update stream for task 0 of framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.888540 28018 slave.cpp:889] Asked to shut down framework > 201304150352-1015726915-60471-27966-0000 by @0.0.0.0:0 > I0415 03:52:15.889957 28018 slave.cpp:894] Shutting down framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.890426 28018 slave.cpp:1681] Shutting down executor > 'default' of framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.890962 28013 status_update_manager.cpp:233] Closing status > update streams for framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.891006 28015 master.cpp:537] Slave > 201304150352-1015726915-60471-27966-0(janus.apache.org) disconnected > I0415 03:52:15.891890 28015 master.cpp:542] Removing disconnected slave > 201304150352-1015726915-60471-27966-0(janus.apache.org) because it is not > checkpointing! > I0415 03:52:15.892469 28017 master.cpp:477] Master terminating > I0415 03:52:15.893165 27966 master.cpp:283] Shutting down master > I0415 03:52:15.893846 27966 master.cpp:283] Shutting down master > I0415 03:52:15.893923 28013 hierarchical_allocator_process.hpp:359] > Deactivated framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.893959 27966 master.hpp:300] Removing task with resources > cpus=1; mem=500 on slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:15.896077 28016 hierarchical_allocator_process.hpp:544] > Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; > ports=[31000-32000]; disk=1024) on slave > 201304150352-1015726915-60471-27966-0 from framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.896258 28016 hierarchical_allocator_process.hpp:312] > Removed framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:15.896742 28016 hierarchical_allocator_process.hpp:423] > Removed slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:15.905767 27966 zookeeper_test_server.cpp:195] Shutdown > ZooKeeperTestServer on port 47833 > [ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (2242 ms) > [ RUN ] AllocatorZooKeeperTest/0.SlaveReregistersFirst > I0415 03:52:15.907378 27966 jvm.cpp:34] looking up method > <init>(Ljava/lang/String;)V > I0415 03:52:15.907512 27966 jvm.cpp:34] looking up method <init>(I)V > I0415 03:52:15.907819 27966 jvm.cpp:34] looking up method > <init>(Ljava/net/InetSocketAddress;)V > I0415 03:52:15.908318 27966 jvm.cpp:34] looking up method > startup(Lorg/apache/zookeeper/server/ZooKeeperServer;)V > I0415 03:52:15.908787 27966 jvm.cpp:34] looking up method isAlive()Z > I0415 03:52:15.909245 27966 jvm.cpp:34] looking up method shutdown()V > I0415 03:52:15.912058 27966 jvm.cpp:34] looking up method > <init>(Ljava/io/File;Ljava/io/File;)V > I0415 03:52:15.912618 27966 jvm.cpp:34] looking up method <init>()V > I0415 03:52:15.912720 27966 jvm.cpp:34] looking up method > <init>(Lorg/apache/zookeeper/server/persistence/FileTxnSnapLog;Lorg/apache/zookeeper/server/ZooKeeperServer$DataTreeBuilder;)V > I0415 03:52:15.913173 27966 jvm.cpp:34] looking up method getClientPort()I > I0415 03:52:15.913513 27966 jvm.cpp:34] looking up method closeSession(J)V > I0415 03:52:15.915868 27966 zookeeper_test_server.cpp:212] Started > ZooKeeperTestServer on port 53584 > I0415 03:52:15.916173 28011 master.cpp:309] Master started on > 67.195.138.60:60471 > I0415 03:52:15.916242 28011 master.cpp:324] Master ID: > 201304150352-1015726915-60471-27966 > I0415 03:52:15.916827 28014 hierarchical_allocator_process.hpp:236] > Initializing hierarchical allocator process with master : > [email protected]:60471 > W0415 03:52:15.916849 28017 master.cpp:81] No whitelist given. Advertising > offers for all slaves > I0415 03:52:15.916645 28013 slave.cpp:203] Slave started on 83)@ > 67.195.138.60:60471 > I0415 03:52:15.918356 28013 slave.cpp:204] Slave resources: cpus=2; > mem=1024; ports=[31000-32000]; disk=1024 > I0415 03:52:15.920147 28012 slave.cpp:377] Finished recovery > I0415 03:52:15.974617 28017 detector.cpp:283] Master detector ( > [email protected]:60471) connected to ZooKeeper ... > I0415 03:52:15.974661 28017 detector.cpp:300] Trying to create path > '/znode' in ZooKeeper > I0415 03:52:15.975020 28014 detector.cpp:283] Master detector (slave(83)@ > 67.195.138.60:60471) connected to ZooKeeper ... > I0415 03:52:15.975471 28014 detector.cpp:300] Trying to create path > '/znode' in ZooKeeper > I0415 03:52:15.986569 28011 detector.cpp:283] Master detector > (scheduler(75)@67.195.138.60:60471) connected to ZooKeeper ... > I0415 03:52:15.986613 28011 detector.cpp:300] Trying to create path > '/znode' in ZooKeeper > I0415 03:52:16.031102 28014 detector.cpp:485] Master detector (slave(83)@ > 67.195.138.60:60471) found 0 registered masters > I0415 03:52:16.031152 28014 detector.cpp:506] Master detector (slave(83)@ > 67.195.138.60:60471) couldn't find any masters > I0415 03:52:16.031517 28014 slave.cpp:479] Lost master(s) ... waiting > I0415 03:52:16.053187 28017 detector.cpp:330] Created ephemeral/sequence > znode at '/znode/0000000000' > I0415 03:52:16.053555 28011 detector.cpp:485] Master detector > (scheduler(75)@67.195.138.60:60471) found 1 registered masters > I0415 03:52:16.053598 28018 detector.cpp:485] Master detector (slave(83)@ > 67.195.138.60:60471) found 1 registered masters > I0415 03:52:16.053761 28017 detector.cpp:485] Master detector ( > [email protected]:60471) found 1 registered masters > I0415 03:52:16.056705 28011 detector.cpp:531] Master detector > (scheduler(75)@67.195.138.60:60471) got new master pid: > [email protected]:60471 > I0415 03:52:16.057068 28018 detector.cpp:531] Master detector (slave(83)@ > 67.195.138.60:60471) got new master pid: [email protected]:60471 > I0415 03:52:16.057497 28017 detector.cpp:531] Master detector ( > [email protected]:60471) got new master pid: > [email protected]:60471 > I0415 03:52:16.057570 28011 sched.cpp:182] New master at > [email protected]:60471 > I0415 03:52:16.058527 28018 slave.cpp:453] New master detected at > [email protected]:60471 > I0415 03:52:16.058948 28017 master.cpp:603] Elected as master! > I0415 03:52:16.059919 28013 status_update_manager.cpp:132] New master > detected at [email protected]:60471 > I0415 03:52:16.060400 28017 master.cpp:646] Registering framework > 201304150352-1015726915-60471-27966-0000 at scheduler(75)@ > 67.195.138.60:60471 > I0415 03:52:16.061298 28014 sched.cpp:217] Framework registered with > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.061336 28012 hierarchical_allocator_process.hpp:268] Added > framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.062196 28012 hierarchical_allocator_process.hpp:668] No > resources available to allocate! > I0415 03:52:16.062657 28012 hierarchical_allocator_process.hpp:599] > Performed allocation for 0 slaves in 463.10us > I0415 03:52:16.061337 28017 master.cpp:968] Attempting to register slave > on janus.apache.org at slave(83)@67.195.138.60:60471 > I0415 03:52:16.063691 28017 master.cpp:1224] Master now considering a > slave at janus.apache.org:60471 as active > I0415 03:52:16.064242 28017 master.cpp:1862] Adding slave > 201304150352-1015726915-60471-27966-0 at janus.apache.org with cpus=2; > mem=1024; ports=[31000-32000]; disk=1024 > I0415 03:52:16.064872 28015 slave.cpp:487] Registered with master; given > slave ID 201304150352-1015726915-60471-27966-0 > I0415 03:52:16.064906 28017 hierarchical_allocator_process.hpp:395] Added > slave 201304150352-1015726915-60471-27966-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) > I0415 03:52:16.066014 28017 hierarchical_allocator_process.hpp:660] Found > available resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on > slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:16.066556 28017 hierarchical_allocator_process.hpp:686] > Offering cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave > 201304150352-1015726915-60471-27966-0 to framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.067203 28017 hierarchical_allocator_process.hpp:619] > Performed allocation for slave 201304150352-1015726915-60471-27966-0 in > 1.20ms > I0415 03:52:16.067248 28015 master.hpp:309] Adding offer with resources > cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave > 201304150352-1015726915-60471-27966-0 > I0415 03:52:16.068080 28015 master.cpp:1327] Sending 1 offers to framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.068614 28013 sched.cpp:282] Received 1 offers > I0415 03:52:16.069325 28011 master.cpp:1534] Processing reply for offer > 201304150352-1015726915-60471-27966-0 on slave > 201304150352-1015726915-60471-27966-0 (janus.apache.org) for framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.069624 28011 master.hpp:289] Adding task with resources > cpus=1; mem=500 on slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:16.070015 28011 master.cpp:1651] Launching task 0 of framework > 201304150352-1015726915-60471-27966-0000 with resources cpus=1; mem=500 on > slave 201304150352-1015726915-60471-27966-0 (janus.apache.org) > I0415 03:52:16.070535 28015 slave.cpp:587] Got assigned task 0 for > framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.072350 28015 paths.hpp:302] Created executor directory > '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_Ern3zU/slaves/201304150352-1015726915-60471-27966-0/frameworks/201304150352-1015726915-60471-27966-0000/executors/default/runs/707fea91-d760-4884-a29d-bf387467c868' > I0415 03:52:16.070592 28018 hierarchical_allocator_process.hpp:471] > Framework 201304150352-1015726915-60471-27966-0000 left cpus=1; mem=524; > ports=[31000-32000]; disk=1024 unused on slave > 201304150352-1015726915-60471-27966-0 > I0415 03:52:16.072819 28018 hierarchical_allocator_process.hpp:497] > Framework 201304150352-1015726915-60471-27966-0000 filtered slave > 201304150352-1015726915-60471-27966-0 for 5.00secs > I0415 03:52:16.072558 28017 slave.cpp:436] Successfully attached file > '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_Ern3zU/slaves/201304150352-1015726915-60471-27966-0/frameworks/201304150352-1015726915-60471-27966-0000/executors/default/runs/707fea91-d760-4884-a29d-bf387467c868' > I0415 03:52:16.072614 28015 exec.cpp:170] Executor started at: > executor(27)@67.195.138.60:60471 with pid 27966 > I0415 03:52:16.070593 28011 master.hpp:318] Removing offer with resources > cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave > 201304150352-1015726915-60471-27966-0 > I0415 03:52:16.107143 28015 slave.cpp:1046] Got registration for executor > 'default' of framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.108271 28015 slave.cpp:1121] Flushing queued tasks for > framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.108311 28016 exec.cpp:194] Executor registered on slave > 201304150352-1015726915-60471-27966-0 > I0415 03:52:16.109413 28016 exec.cpp:258] Executor asked to run task '0' > I0415 03:52:16.110012 28016 exec.cpp:382] Executor sending status update > for task 0 in state TASK_RUNNING > I0415 03:52:16.111738 28016 slave.cpp:1232] Handling status update > TASK_RUNNING from task 0 of framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.111771 28016 slave.cpp:1280] Forwarding status update > TASK_RUNNING from task 0 of framework > 201304150352-1015726915-60471-27966-0000 to the status update manager > I0415 03:52:16.112221 28016 status_update_manager.cpp:254] Received status > update TASK_RUNNING from task 0 of framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.112695 28016 status_update_manager.cpp:403] Creating > StatusUpdate stream for task 0 of framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.113306 28016 status_update_manager.hpp:314] Handling UPDATE > for status update TASK_RUNNING from task 0 of framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.115521 28016 status_update_manager.cpp:289] Forwarding > status update TASK_RUNNING from task 0 of framework > 201304150352-1015726915-60471-27966-0000 to the master at > [email protected]:60471 > I0415 03:52:16.116060 28012 master.cpp:1086] Status update from (824)@ > 67.195.138.60:60471: task 0 of framework > 201304150352-1015726915-60471-27966-0000 is now in state TASK_RUNNING > I0415 03:52:16.116063 28017 slave.cpp:1342] Sending ACK for status update > TASK_RUNNING from task 0 of framework > 201304150352-1015726915-60471-27966-0000 to executor executor(27)@ > 67.195.138.60:60471 > I0415 03:52:16.117076 28017 exec.cpp:289] Executor received ACK for status > update of task 0 of framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.116580 28012 sched.cpp:327] Received status update > TASK_RUNNING from task 0 of framework > 201304150352-1015726915-60471-27966-0000 from slave(83)@ > 67.195.138.60:60471 > I0415 03:52:16.118093 28012 sched.cpp:360] Sending ACK for status update > TASK_RUNNING from task 0 of framework > 201304150352-1015726915-60471-27966-0000 to slave(83)@67.195.138.60:60471 > I0415 03:52:16.118615 28012 slave.cpp:979] Got acknowledgement of status > update for task 0 of framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.118305 27966 master.cpp:477] Master terminating > I0415 03:52:16.119169 28012 status_update_manager.cpp:314] Received status > update acknowledgement for task 0 of framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.119724 28013 slave.cpp:1392] Process exited: @0.0.0.0:0 > W0415 03:52:16.186488 28013 slave.cpp:1395] WARNING! Master disconnected! > Waiting for a new master to be elected. > I0415 03:52:16.120364 28012 status_update_manager.hpp:314] Handling ACK > for status update TASK_RUNNING from task 0 of framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.120265 28016 master.cpp:309] Master started on > 67.195.138.60:60471 > I0415 03:52:16.186831 28011 detector.cpp:283] Master detector ( > [email protected]:60471) connected to ZooKeeper ... > I0415 03:52:16.187080 28017 detector.cpp:485] Master detector > (scheduler(75)@67.195.138.60:60471) found 0 registered masters > I0415 03:52:16.187259 28015 detector.cpp:485] Master detector (slave(83)@ > 67.195.138.60:60471) found 0 registered masters > I0415 03:52:16.196260 28012 slave.cpp:1016] Status update manager > successfully handled status update acknowledgement for task 0 of framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.196817 28016 master.cpp:324] Master ID: > 201304150352-1015726915-60471-27966 > I0415 03:52:16.205389 28011 detector.cpp:300] Trying to create path > '/znode' in ZooKeeper > I0415 03:52:16.215061 28017 detector.cpp:506] Master detector > (scheduler(75)@67.195.138.60:60471) couldn't find any masters > I0415 03:52:16.215571 28015 detector.cpp:506] Master detector (slave(83)@ > 67.195.138.60:60471) couldn't find any masters > W0415 03:52:16.216775 28013 master.cpp:81] No whitelist given. Advertising > offers for all slaves > I0415 03:52:16.216907 28018 hierarchical_allocator_process.hpp:236] > Initializing hierarchical allocator process with master : > [email protected]:60471 > I0415 03:52:16.217649 28017 sched.cpp:193] No master detected, waiting for > another master > I0415 03:52:16.218143 28015 slave.cpp:479] Lost master(s) ... waiting > I0415 03:52:16.290632 28011 detector.cpp:330] Created ephemeral/sequence > znode at '/znode/0000000002' > I0415 03:52:16.291086 28012 detector.cpp:485] Master detector > (scheduler(75)@67.195.138.60:60471) found 1 registered masters > I0415 03:52:16.291277 28015 detector.cpp:485] Master detector (slave(83)@ > 67.195.138.60:60471) found 1 registered masters > I0415 03:52:16.291388 28011 detector.cpp:485] Master detector ( > [email protected]:60471) found 1 registered masters > I0415 03:52:16.291739 28012 detector.cpp:531] Master detector > (scheduler(75)@67.195.138.60:60471) got new master pid: > [email protected]:60471 > I0415 03:52:16.292052 28015 detector.cpp:531] Master detector (slave(83)@ > 67.195.138.60:60471) got new master pid: [email protected]:60471 > I0415 03:52:16.293006 28015 slave.cpp:453] New master detected at > [email protected]:60471 > I0415 03:52:16.292529 28012 sched.cpp:182] New master at > [email protected]:60471 > I0415 03:52:16.292438 28011 detector.cpp:531] Master detector ( > [email protected]:60471) got new master pid: > [email protected]:60471 > I0415 03:52:16.293545 28017 status_update_manager.cpp:132] New master > detected at [email protected]:60471 > W0415 03:52:16.293617 28014 master.cpp:996] Ignoring re-register slave > message from janus.apache.org since not elected yet > I0415 03:52:16.295465 28014 master.cpp:603] Elected as master! > I0415 03:52:16.917891 28013 hierarchical_allocator_process.hpp:660] Found > available resources: cpus=1; mem=524; ports=[31000-32000]; disk=1024 on > slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:16.949961 28013 hierarchical_allocator_process.hpp:756] > Filtered cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave > 201304150352-1015726915-60471-27966-0 for framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:16.950294 28013 hierarchical_allocator_process.hpp:599] > Performed allocation for 1 slaves in 32.45ms > I0415 03:52:17.060214 28011 master.cpp:1029] Attempting to re-register > slave 201304150352-1015726915-60471-27966-0 at slave(83)@ > 67.195.138.60:60471 (janus.apache.org) > I0415 03:52:17.060259 28011 master.cpp:1224] Master now considering a > slave at janus.apache.org:60471 as active > I0415 03:52:17.060606 28011 master.cpp:1862] Adding slave > 201304150352-1015726915-60471-27966-0 at janus.apache.org with cpus=2; > mem=1024; ports=[31000-32000]; disk=1024 > I0415 03:52:17.061087 28017 slave.cpp:520] Re-registered with master > I0415 03:52:17.061118 28011 master.hpp:289] Adding task with resources > cpus=1; mem=500 on slave 201304150352-1015726915-60471-27966-0 > W0415 03:52:17.061993 28011 master.cpp:1948] Possibly orphaned task 0 of > framework 201304150352-1015726915-60471-27966-0000 running on slave > 201304150352-1015726915-60471-27966-0 (janus.apache.org) > I0415 03:52:17.062723 28011 hierarchical_allocator_process.hpp:395] Added > slave 201304150352-1015726915-60471-27966-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) > I0415 03:52:17.063420 28011 hierarchical_allocator_process.hpp:632] No > users to allocate resources! > I0415 03:52:17.063848 28011 hierarchical_allocator_process.hpp:619] > Performed allocation for slave 201304150352-1015726915-60471-27966-0 in > 428.89us > I0415 03:52:17.241173 28013 hierarchical_allocator_process.hpp:632] No > users to allocate resources! > I0415 03:52:17.241243 28013 hierarchical_allocator_process.hpp:599] > Performed allocation for 1 slaves in 73.92us > I0415 03:52:17.294363 28016 master.cpp:681] Re-registering framework > 201304150352-1015726915-60471-27966-0000 at scheduler(75)@ > 67.195.138.60:60471 > I0415 03:52:17.294672 28016 slave.cpp:956] Updating framework > 201304150352-1015726915-60471-27966-0000 pid to scheduler(75)@ > 67.195.138.60:60471 > I0415 03:52:17.294653 28012 sched.cpp:217] Framework registered with > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.294734 28011 hierarchical_allocator_process.hpp:268] Added > framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.344810 28011 hierarchical_allocator_process.hpp:660] Found > available resources: cpus=1; mem=524; ports=[31000-32000]; disk=1024 on > slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:17.345317 28011 hierarchical_allocator_process.hpp:686] > Offering cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave > 201304150352-1015726915-60471-27966-0 to framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.345898 28011 hierarchical_allocator_process.hpp:599] > Performed allocation for 1 slaves in 1.10ms > I0415 03:52:17.345988 28018 master.hpp:309] Adding offer with resources > cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave > 201304150352-1015726915-60471-27966-0 > I0415 03:52:17.346806 28018 master.cpp:1327] Sending 1 offers to framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.347316 28017 sched.cpp:282] Received 1 offers > I0415 03:52:17.348103 28012 sched.cpp:422] Stopping framework > '201304150352-1015726915-60471-27966-0000' > I0415 03:52:17.348254 28015 master.cpp:774] Asked to unregister framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.348747 28017 slave.cpp:889] Asked to shut down framework > 201304150352-1015726915-60471-27966-0000 by [email protected]:60471 > I0415 03:52:17.349159 28017 slave.cpp:894] Shutting down framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.349648 28017 slave.cpp:1681] Shutting down executor > 'default' of framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.350154 28013 exec.cpp:321] Executor asked to shutdown > I0415 03:52:17.348780 28018 hierarchical_allocator_process.hpp:359] > Deactivated framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.350172 28017 status_update_manager.cpp:233] Closing status > update streams for framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.351585 28017 status_update_manager.cpp:434] Cleaning up > status update stream for task 0 of framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.348753 28015 master.hpp:300] Removing task with resources > cpus=1; mem=500 on slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:17.352645 28015 master.hpp:318] Removing offer with resources > cpus=1; mem=524; ports=[31000-32000]; disk=1024 on slave > 201304150352-1015726915-60471-27966-0 > I0415 03:52:17.352738 28014 hierarchical_allocator_process.hpp:544] > Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; > disk=0) on slave 201304150352-1015726915-60471-27966-0 from framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.354449 28018 slave.cpp:386] Slave terminating > I0415 03:52:17.355085 28018 slave.cpp:889] Asked to shut down framework > 201304150352-1015726915-60471-27966-0000 by @0.0.0.0:0 > I0415 03:52:17.355623 28018 slave.cpp:894] Shutting down framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.354775 28014 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 > 201304150352-1015726915-60471-27966-0 from framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.356153 28018 slave.cpp:1681] Shutting down executor > 'default' of framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.357228 28015 status_update_manager.cpp:233] Closing status > update streams for framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.357238 28018 master.cpp:537] Slave > 201304150352-1015726915-60471-27966-0(janus.apache.org) disconnected > I0415 03:52:17.358275 28018 master.cpp:542] Removing disconnected slave > 201304150352-1015726915-60471-27966-0(janus.apache.org) because it is not > checkpointing! > I0415 03:52:17.358933 27966 master.cpp:477] Master terminating > I0415 03:52:17.359760 27966 master.cpp:283] Shutting down master > I0415 03:52:17.381469 27966 master.cpp:283] Shutting down master > I0415 03:52:17.381543 27966 master.hpp:300] Removing task with resources > cpus=1; mem=500 on slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:17.381575 28011 hierarchical_allocator_process.hpp:359] > Deactivated framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.382721 28011 hierarchical_allocator_process.hpp:544] > Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; > ports=[31000-32000]; disk=1024) on slave > 201304150352-1015726915-60471-27966-0 from framework > 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.383054 28011 hierarchical_allocator_process.hpp:312] > Removed framework 201304150352-1015726915-60471-27966-0000 > I0415 03:52:17.383503 28011 hierarchical_allocator_process.hpp:423] > Removed slave 201304150352-1015726915-60471-27966-0 > I0415 03:52:17.394901 27966 zookeeper_test_server.cpp:195] Shutdown > ZooKeeperTestServer on port 53584 > [ OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (1489 ms) > [----------] 2 tests from AllocatorZooKeeperTest/0 (3731 ms total) > > [----------] Global test environment tear-down > [==========] 190 tests from 39 test cases ran. (95876 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-In-Src-Set-JAVA_HOME/ws/src > '> > make[2]: *** [check-am] Error 2 > make[2]: Leaving directory `< > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src > '> > make[1]: *** [check] Error 2 > make[1]: Leaving directory `< > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src > '> > make: *** [check-recursive] Error 1 > Build step 'Execute shell' marked build as failure >
