MESOS-2048 I believe, shouldn't see any more of these. On Fri, Nov 7, 2014 at 8:46 PM, Apache Jenkins Server < [email protected]> wrote:
> See < > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/2261/changes > > > > Changes: > > [benjamin.hindman] Abstracted out invoking 'mesos-fetcher'. > > ------------------------------------------ > [...truncated 70651 lines...] > 2014-11-08 04:44:55,244:26166(0x2b3a5c135700):ZOO_INFO@log_env@724: > Client environment:os.arch=3.13.0-36-lowlatency > 2014-11-08 04:44:55,244:26166(0x2b3a5c135700):ZOO_INFO@log_env@725: > Client environment:os.version=#63-Ubuntu SMP PREEMPT Wed Sep 3 21:56:12 UTC > 2014 > 2014-11-08 04:44:55,244:26166(0x2b3a5c537700):ZOO_INFO@log_env@741: > Client environment:user.home=/home/jenkins > 2014-11-08 04:44:55,244:26166(0x2b3a5c537700):ZOO_INFO@log_env@753: > Client environment:user.dir=/tmp/LogZooKeeperTest_WriteRead_dFYVWf > 2014-11-08 04:44:55,320:26166(0x2b3a5c537700):ZOO_INFO@zookeeper_init@786: > Initiating client connection, host=127.0.0.1:42847 sessionTimeout=10000 > watcher=0x2b3a56028b0a sessionId=0 sessionPasswd=<null> > context=0x2b3a980cc220 flags=0 > 2014-11-08 04:44:55,244:26166(0x2b3a5c135700):ZOO_INFO@log_env@733: > Client environment:user.name=jenkins > I1108 04:44:55.244516 26184 recover.cpp:437] Starting replica recovery > 2014-11-08 04:44:55,320:26166(0x2b3a5c135700):ZOO_INFO@log_env@741: > Client environment:user.home=/home/jenkins > 2014-11-08 04:44:55,320:26166(0x2b3a5c135700):ZOO_INFO@log_env@753: > Client environment:user.dir=/tmp/LogZooKeeperTest_WriteRead_dFYVWf > 2014-11-08 04:44:55,320:26166(0x2b3a5c135700):ZOO_INFO@zookeeper_init@786: > Initiating client connection, host=127.0.0.1:42847 sessionTimeout=10000 > watcher=0x2b3a56028b0a sessionId=0 sessionPasswd=<null> > context=0x2b3a7408e8f0 flags=0 > I1108 04:44:55.247128 26166 leveldb.cpp:176] Opened db in 3.573419ms > I1108 04:44:55.320708 26184 recover.cpp:463] Replica is in VOTING status > 2014-11-08 04:44:55,320:26166(0x2b3e0ca04700):ZOO_INFO@check_events@1703: > initiated connection to server [127.0.0.1:42847] > 2014-11-08 04:44:55,320:26166(0x2b3e0de2d700):ZOO_INFO@check_events@1703: > initiated connection to server [127.0.0.1:42847] > I1108 04:44:55.320850 26184 recover.cpp:452] Recover process terminated > 2014-11-08 04:44:55,323:26166(0x2b3e0ca04700):ZOO_INFO@check_events@1750: > session establishment complete on server [127.0.0.1:42847], > sessionId=0x1498db822360000, negotiated timeout=10000 > I1108 04:44:55.323797 26166 leveldb.cpp:183] Compacted db in 3.326034ms > I1108 04:44:55.323853 26166 leveldb.cpp:198] Created db iterator in 17790ns > I1108 04:44:55.323887 26166 leveldb.cpp:204] Seeked to beginning of db in > 19544ns > I1108 04:44:55.323922 26166 leveldb.cpp:273] Iterated through 1 keys in > the db in 20972ns > I1108 04:44:55.323957 26166 replica.cpp:741] Replica recovered with log > positions 0 -> 0 with 1 holes and 0 unlearned > I1108 04:44:55.323997 26182 group.cpp:313] Group process (group(53)@ > 67.195.81.190:53738) connected to ZooKeeper > I1108 04:44:55.324029 26182 group.cpp:790] Syncing group operations: queue > size (joins, cancels, datas) = (0, 0, 0) > I1108 04:44:55.324050 26182 group.cpp:385] Trying to create path '/log' in > ZooKeeper > 2014-11-08 04:44:55,324:26166(0x2b3e0de2d700):ZOO_INFO@check_events@1750: > session establishment complete on server [127.0.0.1:42847], > sessionId=0x1498db822360001, negotiated timeout=10000 > 2014-11-08 04:44:55,324:26166(0x2b3a5c336700):ZOO_INFO@log_env@712: > Client environment:zookeeper.version=zookeeper C client 3.4.5 > 2014-11-08 04:44:55,324:26166(0x2b3a5c336700):ZOO_INFO@log_env@716: > Client environment:host.name=pietas.apache.org > 2014-11-08 04:44:55,324:26166(0x2b3a5c336700):ZOO_INFO@log_env@723: > Client environment:os.name=Linux > 2014-11-08 04:44:55,324:26166(0x2b3a5c336700):ZOO_INFO@log_env@724: > Client environment:os.arch=3.13.0-36-lowlatency > 2014-11-08 04:44:55,324:26166(0x2b3a5c336700):ZOO_INFO@log_env@725: > Client environment:os.version=#63-Ubuntu SMP PREEMPT Wed Sep 3 21:56:12 UTC > 2014 > 2014-11-08 04:44:55,324:26166(0x2b3a5c336700):ZOO_INFO@log_env@733: > Client environment:user.name=jenkins > 2014-11-08 04:44:55,324:26166(0x2b3a5c336700):ZOO_INFO@log_env@741: > Client environment:user.home=/home/jenkins > 2014-11-08 04:44:55,324:26166(0x2b3a5c336700):ZOO_INFO@log_env@753: > Client environment:user.dir=/tmp/LogZooKeeperTest_WriteRead_dFYVWf > 2014-11-08 04:44:55,324:26166(0x2b3a5c336700):ZOO_INFO@zookeeper_init@786: > Initiating client connection, host=127.0.0.1:42847 sessionTimeout=10000 > watcher=0x2b3a56028b0a sessionId=0 sessionPasswd=<null> > context=0x2b3a900ae0f0 flags=0 > I1108 04:44:55.324905 26184 log.cpp:238] Attempting to join replica to > ZooKeeper group > 2014-11-08 04:44:55,325:26166(0x2b3a5bb32700):ZOO_INFO@log_env@712: > Client environment:zookeeper.version=zookeeper C client 3.4.5 > 2014-11-08 04:44:55,325:26166(0x2b3a5bb32700):ZOO_INFO@log_env@716: > Client environment:host.name=pietas.apache.org > 2014-11-08 04:44:55,325:26166(0x2b3a5bb32700):ZOO_INFO@log_env@723: > Client environment:os.name=Linux > 2014-11-08 04:44:55,325:26166(0x2b3a5bb32700):ZOO_INFO@log_env@724: > Client environment:os.arch=3.13.0-36-lowlatency > 2014-11-08 04:44:55,325:26166(0x2b3a5bb32700):ZOO_INFO@log_env@725: > Client environment:os.version=#63-Ubuntu SMP PREEMPT Wed Sep 3 21:56:12 UTC > 2014 > 2014-11-08 04:44:55,325:26166(0x2b3a5bb32700):ZOO_INFO@log_env@733: > Client environment:user.name=jenkins > 2014-11-08 04:44:55,325:26166(0x2b3a5bb32700):ZOO_INFO@log_env@741: > Client environment:user.home=/home/jenkins > 2014-11-08 04:44:55,325:26166(0x2b3a5bb32700):ZOO_INFO@log_env@753: > Client environment:user.dir=/tmp/LogZooKeeperTest_WriteRead_dFYVWf > 2014-11-08 04:44:55,325:26166(0x2b3a5bb32700):ZOO_INFO@zookeeper_init@786: > Initiating client connection, host=127.0.0.1:42847 sessionTimeout=10000 > watcher=0x2b3a56028b0a sessionId=0 sessionPasswd=<null> > context=0x2b3a6c0c79b0 flags=0 > I1108 04:44:55.325539 26189 group.cpp:313] Group process (group(54)@ > 67.195.81.190:53738) connected to ZooKeeper > I1108 04:44:55.325574 26189 group.cpp:790] Syncing group operations: queue > size (joins, cancels, datas) = (1, 0, 0) > I1108 04:44:55.325588 26189 group.cpp:385] Trying to create path '/log' in > ZooKeeper > I1108 04:44:55.325582 26194 recover.cpp:437] Starting replica recovery > 2014-11-08 04:44:55,325:26166(0x2b3e0e02e700):ZOO_INFO@check_events@1703: > initiated connection to server [127.0.0.1:42847] > I1108 04:44:55.325893 26194 recover.cpp:463] Replica is in VOTING status > 2014-11-08 04:44:55,325:26166(0x2b3e0d60a700):ZOO_INFO@check_events@1703: > initiated connection to server [127.0.0.1:42847] > I1108 04:44:55.326051 26194 recover.cpp:452] Recover process terminated > I1108 04:44:55.326891 26187 log.cpp:656] Attempting to start the writer > 2014-11-08 04:44:55,328:26166(0x2b3e0e02e700):ZOO_INFO@check_events@1750: > session establishment complete on server [127.0.0.1:42847], > sessionId=0x1498db822360002, negotiated timeout=10000 > I1108 04:44:55.329056 26190 group.cpp:313] Group process (group(55)@ > 67.195.81.190:53738) connected to ZooKeeper > I1108 04:44:55.329090 26190 group.cpp:790] Syncing group operations: queue > size (joins, cancels, datas) = (0, 0, 0) > I1108 04:44:55.329113 26190 group.cpp:385] Trying to create path '/log' in > ZooKeeper > 2014-11-08 04:44:55,329:26166(0x2b3e0d60a700):ZOO_INFO@check_events@1750: > session establishment complete on server [127.0.0.1:42847], > sessionId=0x1498db822360003, negotiated timeout=10000 > I1108 04:44:55.330327 26188 group.cpp:313] Group process (group(56)@ > 67.195.81.190:53738) connected to ZooKeeper > I1108 04:44:55.330359 26188 group.cpp:790] Syncing group operations: queue > size (joins, cancels, datas) = (1, 0, 0) > I1108 04:44:55.330374 26188 group.cpp:385] Trying to create path '/log' in > ZooKeeper > I1108 04:44:55.332345 26192 network.hpp:424] ZooKeeper group memberships > changed > I1108 04:44:55.332495 26181 group.cpp:659] Trying to get '/log/0000000000' > in ZooKeeper > I1108 04:44:55.333076 26192 network.hpp:424] ZooKeeper group memberships > changed > I1108 04:44:55.333212 26191 group.cpp:659] Trying to get '/log/0000000000' > in ZooKeeper > I1108 04:44:55.334625 26194 network.hpp:466] ZooKeeper group PIDs: { > log-replica(438)@67.195.81.190:53738 } > I1108 04:44:55.335556 26186 network.hpp:466] ZooKeeper group PIDs: { > log-replica(438)@67.195.81.190:53738 } > I1108 04:44:55.335785 26180 replica.cpp:474] Replica received implicit > promise request with proposal 1 > I1108 04:44:55.335963 26195 replica.cpp:474] Replica received implicit > promise request with proposal 1 > I1108 04:44:55.336510 26194 network.hpp:424] ZooKeeper group memberships > changed > I1108 04:44:55.336638 26195 leveldb.cpp:306] Persisting metadata (8 bytes) > to leveldb took 639914ns > I1108 04:44:55.336642 26180 leveldb.cpp:306] Persisting metadata (8 bytes) > to leveldb took 818147ns > I1108 04:44:55.336666 26195 replica.cpp:342] Persisted promised to 1 > I1108 04:44:55.336673 26180 replica.cpp:342] Persisted promised to 1 > I1108 04:44:55.336662 26182 group.cpp:659] Trying to get '/log/0000000000' > in ZooKeeper > I1108 04:44:55.337342 26186 network.hpp:424] ZooKeeper group memberships > changed > I1108 04:44:55.337709 26189 coordinator.cpp:230] Coordinator attemping to > fill missing position > I1108 04:44:55.337903 26182 group.cpp:659] Trying to get '/log/0000000001' > in ZooKeeper > I1108 04:44:55.452550 26195 group.cpp:659] Trying to get '/log/0000000000' > in ZooKeeper > I1108 04:44:55.454025 26195 group.cpp:659] Trying to get '/log/0000000001' > in ZooKeeper > I1108 04:44:55.454591 26193 network.hpp:466] ZooKeeper group PIDs: { > log-replica(438)@67.195.81.190:53738, log-replica(439)@67.195.81.190:53738 > } > I1108 04:44:55.454737 26187 replica.cpp:375] Replica received explicit > promise request for position 0 with proposal 2 > I1108 04:44:55.455200 26185 replica.cpp:375] Replica received explicit > promise request for position 0 with proposal 2 > I1108 04:44:55.455358 26187 leveldb.cpp:343] Persisting action (8 bytes) > to leveldb took 580678ns > I1108 04:44:55.455389 26187 replica.cpp:676] Persisted action at 0 > I1108 04:44:55.455752 26185 leveldb.cpp:343] Persisting action (8 bytes) > to leveldb took 511428ns > I1108 04:44:55.455786 26185 replica.cpp:676] Persisted action at 0 > I1108 04:44:55.455962 26195 network.hpp:466] ZooKeeper group PIDs: { > log-replica(438)@67.195.81.190:53738, log-replica(439)@67.195.81.190:53738 > } > I1108 04:44:55.457196 26187 replica.cpp:508] Replica received write > request for position 0 > I1108 04:44:55.457259 26187 leveldb.cpp:438] Reading position from leveldb > took 28672ns > I1108 04:44:55.457571 26183 replica.cpp:508] Replica received write > request for position 0 > I1108 04:44:55.457638 26183 leveldb.cpp:438] Reading position from leveldb > took 29027ns > I1108 04:44:55.457691 26187 leveldb.cpp:343] Persisting action (14 bytes) > to leveldb took 390166ns > I1108 04:44:55.457720 26187 replica.cpp:676] Persisted action at 0 > I1108 04:44:55.458050 26183 leveldb.cpp:343] Persisting action (14 bytes) > to leveldb took 374875ns > I1108 04:44:55.458076 26183 replica.cpp:676] Persisted action at 0 > I1108 04:44:55.458554 26192 replica.cpp:655] Replica received learned > notice for position 0 > I1108 04:44:55.458592 26193 replica.cpp:655] Replica received learned > notice for position 0 > I1108 04:44:55.459014 26193 leveldb.cpp:343] Persisting action (16 bytes) > to leveldb took 391444ns > I1108 04:44:55.459019 26192 leveldb.cpp:343] Persisting action (16 bytes) > to leveldb took 431750ns > I1108 04:44:55.459045 26193 replica.cpp:676] Persisted action at 0 > I1108 04:44:55.459055 26192 replica.cpp:676] Persisted action at 0 > I1108 04:44:55.459067 26193 replica.cpp:661] Replica learned NOP action at > position 0 > I1108 04:44:55.459077 26192 replica.cpp:661] Replica learned NOP action at > position 0 > I1108 04:44:55.459836 26188 log.cpp:672] Writer started with ending > position 0 > I1108 04:44:55.460250 26180 log.cpp:680] Attempting to append 11 bytes to > the log > I1108 04:44:55.460368 26191 coordinator.cpp:340] Coordinator attempting to > write APPEND action at position 1 > I1108 04:44:55.461184 26186 replica.cpp:508] Replica received write > request for position 1 > I1108 04:44:55.461323 26183 replica.cpp:508] Replica received write > request for position 1 > I1108 04:44:55.461616 26186 leveldb.cpp:343] Persisting action (27 bytes) > to leveldb took 394737ns > I1108 04:44:55.461643 26186 replica.cpp:676] Persisted action at 1 > I1108 04:44:55.461727 26183 leveldb.cpp:343] Persisting action (27 bytes) > to leveldb took 370577ns > I1108 04:44:55.461750 26183 replica.cpp:676] Persisted action at 1 > I1108 04:44:55.462525 26194 replica.cpp:655] Replica received learned > notice for position 1 > I1108 04:44:55.462601 26191 replica.cpp:655] Replica received learned > notice for position 1 > I1108 04:44:55.462906 26191 leveldb.cpp:343] Persisting action (29 bytes) > to leveldb took 275192ns > I1108 04:44:55.462906 26194 leveldb.cpp:343] Persisting action (29 bytes) > to leveldb took 351125ns > I1108 04:44:55.462939 26191 replica.cpp:676] Persisted action at 1 > I1108 04:44:55.462947 26194 replica.cpp:676] Persisted action at 1 > I1108 04:44:55.462960 26191 replica.cpp:661] Replica learned APPEND action > at position 1 > I1108 04:44:55.462970 26194 replica.cpp:661] Replica learned APPEND action > at position 1 > I1108 04:44:55.464081 26181 leveldb.cpp:438] Reading position from leveldb > took 36464ns > 2014-11-08 04:44:55,465:26166(0x2b3a53084080):ZOO_INFO@zookeeper_close@2505: > Closing zookeeper sessionId=0x1498db822360003 to [127.0.0.1:42847] > > 2014-11-08 04:44:55,466:26166(0x2b3a5b32e700):ZOO_INFO@zookeeper_close@2505: > Closing zookeeper sessionId=0x1498db822360002 to [127.0.0.1:42847] > > I1108 04:44:55.468557 26186 network.hpp:424] ZooKeeper group memberships > changed > I1108 04:44:55.468693 26193 group.cpp:659] Trying to get '/log/0000000000' > in ZooKeeper > 2014-11-08 04:44:55,469:26166(0x2b3a5b931700):ZOO_INFO@zookeeper_close@2505: > Closing zookeeper sessionId=0x1498db822360001 to [127.0.0.1:42847] > > 2014-11-08 04:44:55,470:26166(0x2b3a5bf34700):ZOO_INFO@zookeeper_close@2505: > Closing zookeeper sessionId=0x1498db822360000 to [127.0.0.1:42847] > > I1108 04:44:55.471582 26166 zookeeper_test_server.cpp:118] Shutting down > ZooKeeperTestServer on port 42847 > [ OK ] LogZooKeeperTest.WriteRead (254 ms) > [ RUN ] LogZooKeeperTest.LostZooKeeper > I1108 04:44:55.475536 26166 zookeeper_test_server.cpp:158] Started > ZooKeeperTestServer on port 52306 > I1108 04:44:55.475628 26166 log_tests.cpp:1945] Using temporary directory > '/tmp/LogZooKeeperTest_LostZooKeeper_B5z3jV' > I1108 04:44:55.478559 26166 leveldb.cpp:176] Opened db in 2.846954ms > I1108 04:44:55.479370 26166 leveldb.cpp:183] Compacted db in 775391ns > I1108 04:44:55.479416 26166 leveldb.cpp:198] Created db iterator in 16244ns > I1108 04:44:55.479460 26166 leveldb.cpp:204] Seeked to beginning of db in > 1968ns > I1108 04:44:55.479472 26166 leveldb.cpp:273] Iterated through 0 keys in > the db in 482ns > I1108 04:44:55.479504 26166 replica.cpp:741] Replica recovered with log > positions 0 -> 0 with 1 holes and 0 unlearned > 2014-11-08 04:44:55,479:26166(0x2b3a5b12d700):ZOO_INFO@log_env@712: > Client environment:zookeeper.version=zookeeper C client 3.4.5 > 2014-11-08 04:44:55,479:26166(0x2b3a5b12d700):ZOO_INFO@log_env@716: > Client environment:host.name=pietas.apache.org > 2014-11-08 04:44:55,479:26166(0x2b3a5b12d700):ZOO_INFO@log_env@723: > Client environment:os.name=Linux > 2014-11-08 04:44:55,479:26166(0x2b3a5b12d700):ZOO_INFO@log_env@724: > Client environment:os.arch=3.13.0-36-lowlatency > 2014-11-08 04:44:55,479:26166(0x2b3a5b12d700):ZOO_INFO@log_env@725: > Client environment:os.version=#63-Ubuntu SMP PREEMPT Wed Sep 3 21:56:12 UTC > 2014 > 2014-11-08 04:44:55,480:26166(0x2b3a5b12d700):ZOO_INFO@log_env@733: > Client environment:user.name=jenkins > 2014-11-08 04:44:55,480:26166(0x2b3a5b12d700):ZOO_INFO@log_env@741: > Client environment:user.home=/home/jenkins > 2014-11-08 04:44:55,480:26166(0x2b3a5b12d700):ZOO_INFO@log_env@753: > Client environment:user.dir=/tmp/LogZooKeeperTest_LostZooKeeper_B5z3jV > I1108 04:44:55.480145 26188 log.cpp:238] Attempting to join replica to > ZooKeeper group > 2014-11-08 04:44:55,480:26166(0x2b3a5b12d700):ZOO_INFO@zookeeper_init@786: > Initiating client connection, host=127.0.0.1:52306 sessionTimeout=10000 > watcher=0x2b3a56028b0a sessionId=0 sessionPasswd=<null> > context=0x2b3a880a5d90 flags=0 > 2014-11-08 04:44:55,480:26166(0x2b3a5b931700):ZOO_INFO@log_env@712: > Client environment:zookeeper.version=zookeeper C client 3.4.5 > 2014-11-08 04:44:55,480:26166(0x2b3a5b931700):ZOO_INFO@log_env@716: > Client environment:host.name=pietas.apache.org > 2014-11-08 04:44:55,480:26166(0x2b3a5b931700):ZOO_INFO@log_env@723: > Client environment:os.name=Linux > 2014-11-08 04:44:55,480:26166(0x2b3a5b931700):ZOO_INFO@log_env@724: > Client environment:os.arch=3.13.0-36-lowlatency > 2014-11-08 04:44:55,480:26166(0x2b3a5b931700):ZOO_INFO@log_env@725: > Client environment:os.version=#63-Ubuntu SMP PREEMPT Wed Sep 3 21:56:12 UTC > 2014 > 2014-11-08 04:44:55,480:26166(0x2b3a5b931700):ZOO_INFO@log_env@733: > Client environment:user.name=jenkins > I1108 04:44:55.480638 26190 recover.cpp:437] Starting replica recovery > 2014-11-08 04:44:55,480:26166(0x2b3e0ca04700):ZOO_INFO@check_events@1703: > initiated connection to server [127.0.0.1:52306] > 2014-11-08 04:44:55,480:26166(0x2b3a5b931700):ZOO_INFO@log_env@741: > Client environment:user.home=/home/jenkins > 2014-11-08 04:44:55,624:26166(0x2b3a5b931700):ZOO_INFO@log_env@753: > Client environment:user.dir=/tmp/LogZooKeeperTest_LostZooKeeper_B5z3jV > 2014-11-08 04:44:55,624:26166(0x2b3a5b931700):ZOO_INFO@zookeeper_init@786: > Initiating client connection, host=127.0.0.1:52306 sessionTimeout=10000 > watcher=0x2b3a56028b0a sessionId=0 sessionPasswd=<null> > context=0x2b3a7c09cad0 flags=0 > I1108 04:44:55.480916 26182 recover.cpp:463] Replica is in EMPTY status > 2014-11-08 04:44:55,483:26166(0x2b3e0ca04700):ZOO_INFO@check_events@1750: > session establishment complete on server [127.0.0.1:52306], > sessionId=0x1498db823320000, negotiated timeout=10000 > 2014-11-08 04:44:55,624:26166(0x2b3e0de2d700):ZOO_INFO@check_events@1703: > initiated connection to server [127.0.0.1:52306] > I1108 04:44:55.625049 26189 group.cpp:313] Group process (group(57)@ > 67.195.81.190:53738) connected to ZooKeeper > I1108 04:44:55.625107 26189 group.cpp:790] Syncing group operations: queue > size (joins, cancels, datas) = (0, 0, 0) > I1108 04:44:55.625128 26189 group.cpp:385] Trying to create path '/log' in > ZooKeeper > I1108 04:44:55.625675 26192 replica.cpp:638] Replica in EMPTY status > received a broadcasted recover request > I1108 04:44:55.626123 26194 recover.cpp:188] Received a recover response > from a replica in EMPTY status > 2014-11-08 04:44:55,626:26166(0x2b3e0de2d700):ZOO_INFO@check_events@1750: > session establishment complete on server [127.0.0.1:52306], > sessionId=0x1498db823320001, negotiated timeout=10000 > I1108 04:44:55.626602 26188 recover.cpp:554] Updating replica status to > STARTING > I1108 04:44:55.627254 26191 group.cpp:313] Group process (group(58)@ > 67.195.81.190:53738) connected to ZooKeeper > I1108 04:44:55.627338 26191 group.cpp:790] Syncing group operations: queue > size (joins, cancels, datas) = (1, 0, 0) > I1108 04:44:55.627353 26191 group.cpp:385] Trying to create path '/log' in > ZooKeeper > I1108 04:44:55.627354 26183 leveldb.cpp:306] Persisting metadata (8 bytes) > to leveldb took 597985ns > I1108 04:44:55.627388 26183 replica.cpp:320] Persisted replica status to > STARTING > I1108 04:44:55.627671 26187 recover.cpp:463] Replica is in STARTING status > I1108 04:44:55.628998 26186 replica.cpp:638] Replica in STARTING status > received a broadcasted recover request > I1108 04:44:55.629487 26192 recover.cpp:188] Received a recover response > from a replica in STARTING status > I1108 04:44:55.629966 26180 recover.cpp:554] Updating replica status to > VOTING > I1108 04:44:55.630470 26182 leveldb.cpp:306] Persisting metadata (8 bytes) > to leveldb took 365147ns > I1108 04:44:55.630506 26182 replica.cpp:320] Persisted replica status to > VOTING > I1108 04:44:55.630600 26185 recover.cpp:568] Successfully joined the Paxos > group > I1108 04:44:55.630774 26185 recover.cpp:452] Recover process terminated > I1108 04:44:55.631284 26193 log.cpp:656] Attempting to start the writer > I1108 04:44:55.632472 26186 network.hpp:424] ZooKeeper group memberships > changed > I1108 04:44:55.632601 26187 group.cpp:659] Trying to get '/log/0000000000' > in ZooKeeper > I1108 04:44:55.632657 26193 replica.cpp:474] Replica received implicit > promise request with proposal 1 > I1108 04:44:55.633139 26193 leveldb.cpp:306] Persisting metadata (8 bytes) > to leveldb took 449102ns > I1108 04:44:55.633165 26193 replica.cpp:342] Persisted promised to 1 > I1108 04:44:55.633846 26194 coordinator.cpp:230] Coordinator attemping to > fill missing position > I1108 04:44:55.634021 26190 network.hpp:466] ZooKeeper group PIDs: { > log-replica(440)@67.195.81.190:53738 } > I1108 04:44:55.635151 26180 replica.cpp:375] Replica received explicit > promise request for position 0 with proposal 2 > I1108 04:44:55.635571 26180 leveldb.cpp:343] Persisting action (8 bytes) > to leveldb took 382219ns > I1108 04:44:55.635596 26180 replica.cpp:676] Persisted action at 0 > I1108 04:44:55.636574 26187 replica.cpp:508] Replica received write > request for position 0 > I1108 04:44:55.636646 26187 leveldb.cpp:438] Reading position from leveldb > took 30476ns > I1108 04:44:55.637039 26187 leveldb.cpp:343] Persisting action (14 bytes) > to leveldb took 357220ns > I1108 04:44:55.637065 26187 replica.cpp:676] Persisted action at 0 > I1108 04:44:55.637536 26182 replica.cpp:655] Replica received learned > notice for position 0 > I1108 04:44:55.637980 26182 leveldb.cpp:343] Persisting action (16 bytes) > to leveldb took 412783ns > I1108 04:44:55.638011 26182 replica.cpp:676] Persisted action at 0 > I1108 04:44:55.638043 26182 replica.cpp:661] Replica learned NOP action at > position 0 > I1108 04:44:55.638600 26183 log.cpp:672] Writer started with ending > position 0 > I1108 04:44:55.638844 26166 zookeeper_test_server.cpp:118] Shutting down > ZooKeeperTestServer on port 52306 > 2014-11-08 > 04:44:55,639:26166(0x2b3e0ca04700):ZOO_ERROR@handle_socket_error_msg@1721: > Socket [127.0.0.1:52306] zk retcode=-4, errno=112(Host is down): failed > while receiving a server response > 2014-11-08 > 04:44:55,639:26166(0x2b3e0de2d700):ZOO_ERROR@handle_socket_error_msg@1721: > Socket [127.0.0.1:52306] zk retcode=-4, errno=112(Host is down): failed > while receiving a server response > I1108 04:44:55.640256 26183 group.cpp:418] Lost connection to ZooKeeper, > attempting to reconnect ... > I1108 04:44:55.640638 26184 group.cpp:418] Lost connection to ZooKeeper, > attempting to reconnect ... > I1108 04:44:55.641289 26188 log.cpp:680] Attempting to append 11 bytes to > the log > I1108 04:44:55.641464 26182 coordinator.cpp:340] Coordinator attempting to > write APPEND action at position 1 > I1108 04:44:55.642262 26184 replica.cpp:508] Replica received write > request for position 1 > I1108 04:44:55.642676 26184 leveldb.cpp:343] Persisting action (27 bytes) > to leveldb took 375727ns > I1108 04:44:55.642704 26184 replica.cpp:676] Persisted action at 1 > I1108 04:44:55.643218 26182 replica.cpp:655] Replica received learned > notice for position 1 > I1108 04:44:55.643797 26182 leveldb.cpp:343] Persisting action (29 bytes) > to leveldb took 551262ns > I1108 04:44:55.643828 26182 replica.cpp:676] Persisted action at 1 > I1108 04:44:55.643854 26182 replica.cpp:661] Replica learned APPEND action > at position 1 > I1108 04:44:55.644922 26185 leveldb.cpp:438] Reading position from leveldb > took 33977ns > 2014-11-08 04:44:55,646:26166(0x2b3a5a929700):ZOO_INFO@zookeeper_close@2522: > Freeing zookeeper resources for sessionId=0x1498db823320001 > > 2014-11-08 04:44:55,647:26166(0x2b3a5c336700):ZOO_INFO@zookeeper_close@2522: > Freeing zookeeper resources for sessionId=0x1498db823320000 > > [ OK ] LogZooKeeperTest.LostZooKeeper (176 ms) > [----------] 2 tests from LogZooKeeperTest (430 ms total) > > [----------] Global test environment tear-down > [==========] 458 tests from 71 test cases ran. (373138 ms total) > [ PASSED ] 457 tests. > [ FAILED ] 1 test, listed below: > [ FAILED ] MesosContainerizerExecuteTest.IoRedirection > > 1 FAILED TEST > YOU HAVE 6 DISABLED TESTS > > make[3]: *** [check-local] 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 > Test finished > Exit status: 2 > Build step 'Execute shell' marked build as failure > Recording test results >
