Jira: https://issues.apache.org/jira/browse/ZOOKEEPER-1506
Build: https://builds.apache.org/job/PreCommit-ZOOKEEPER-Build/2072/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE
###########################
[...truncated 16009 lines...]
[exec] [junit] at
org.apache.zookeeper.server.quorum.FastLeaderElection$Messenger$WorkerSender.process(FastLeaderElection.java:469)
[exec] [junit] at
org.apache.zookeeper.server.quorum.FastLeaderElection$Messenger$WorkerSender.run(FastLeaderElection.java:440)
[exec] [junit] at java.lang.Thread.run(Thread.java:662)
[exec] [junit] 2014-04-30 23:13:28,321 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11251:QuorumPeer@995] - LEADING
[exec] [junit] 2014-04-30 23:13:28,321 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11251:ZooKeeperServer@766] -
minSessionTimeout set to 4000
[exec] [junit] 2014-04-30 23:13:28,321 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11251:ZooKeeperServer@775] -
maxSessionTimeout set to 40000
[exec] [junit] 2014-04-30 23:13:28,321 [myid:] - INFO
[QuorumPeer[myid=1]/0:0:0:0:0:0:0:0:11248:QuorumPeer@983] - FOLLOWING
[exec] [junit] 2014-04-30 23:13:28,322 [myid:] - INFO
[QuorumPeer[myid=1]/0:0:0:0:0:0:0:0:11248:ZooKeeperServer@766] -
minSessionTimeout set to 4000
[exec] [junit] 2014-04-30 23:13:28,322 [myid:] - INFO
[QuorumPeer[myid=1]/0:0:0:0:0:0:0:0:11248:ZooKeeperServer@775] -
maxSessionTimeout set to 40000
[exec] [junit] 2014-04-30 23:13:28,321 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11251:ZooKeeperServer@149] - Created server
with tickTime 2000 minSessionTimeout 4000 maxSessionTimeout 40000 datadir
/home/jenkins/jenkins-slave/workspace/PreCommit-ZOOKEEPER-Build/trunk/build/test/tmp/test8096364055794984125.junit.dir/version-2
snapdir
/home/jenkins/jenkins-slave/workspace/PreCommit-ZOOKEEPER-Build/trunk/build/test/tmp/test8096364055794984125.junit.dir/version-2
[exec] [junit] 2014-04-30 23:13:28,322 [myid:] - INFO
[QuorumPeer[myid=1]/0:0:0:0:0:0:0:0:11248:ZooKeeperServer@149] - Created server
with tickTime 2000 minSessionTimeout 4000 maxSessionTimeout 40000 datadir
/home/jenkins/jenkins-slave/workspace/PreCommit-ZOOKEEPER-Build/trunk/build/test/tmp/test707549959984348141.junit.dir/version-2
snapdir
/home/jenkins/jenkins-slave/workspace/PreCommit-ZOOKEEPER-Build/trunk/build/test/tmp/test707549959984348141.junit.dir/version-2
[exec] [junit] 2014-04-30 23:13:28,322 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11251:Leader@449] - LEADING - LEADER
ELECTION TOOK - 1
[exec] [junit] 2014-04-30 23:13:28,322 [myid:] - INFO
[QuorumPeer[myid=1]/0:0:0:0:0:0:0:0:11248:Follower@65] - FOLLOWING - LEADER
ELECTION TOOK - 1
[exec] [junit] 2014-04-30 23:13:28,323 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11251:FileTxnSnapLog@298] - Snapshotting:
0x10000000d to
/home/jenkins/jenkins-slave/workspace/PreCommit-ZOOKEEPER-Build/trunk/build/test/tmp/test8096364055794984125.junit.dir/version-2/snapshot.10000000d
[exec] [junit] 2014-04-30 23:13:28,325 [myid:] - INFO
[LearnerHandler-/127.0.0.1:52025:LearnerHandler@361] - Follower sid: 1 : info :
127.0.0.1:12249:12250:participant;127.0.0.1:11248
[exec] [junit] 2014-04-30 23:13:28,343 [myid:] - INFO
[LearnerHandler-/127.0.0.1:52025:LearnerHandler@648] - Synchronizing with
Follower sid: 1 maxCommittedLog=0x10000000d minCommittedLog=0x100000009
lastProcessedZxid=0x10000000d peerLastZxid=0x10000000d
[exec] [junit] 2014-04-30 23:13:28,343 [myid:] - INFO
[LearnerHandler-/127.0.0.1:52025:LearnerHandler@692] - Sending DIFF
zxid=0x10000000d for peer sid: 1
[exec] [junit] 2014-04-30 23:13:28,344 [myid:] - INFO
[QuorumPeer[myid=1]/0:0:0:0:0:0:0:0:11248:Learner@332] - Getting a diff from
the leader 0x10000000d
[exec] [junit] 2014-04-30 23:13:28,345 [myid:] - INFO
[QuorumPeer[myid=1]/0:0:0:0:0:0:0:0:11248:Learner@474] - Learner received
NEWLEADER message
[exec] [junit] 2014-04-30 23:13:28,345 [myid:] - INFO
[QuorumPeer[myid=1]/0:0:0:0:0:0:0:0:11248:FileTxnSnapLog@298] - Snapshotting:
0x10000000d to
/home/jenkins/jenkins-slave/workspace/PreCommit-ZOOKEEPER-Build/trunk/build/test/tmp/test707549959984348141.junit.dir/version-2/snapshot.10000000d
[exec] [junit] 2014-04-30 23:13:28,350 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11251:Leader@1256] - Have quorum of
supporters, sids: [ [1, 2] ]; starting up and setting last processed zxid:
0x200000000
[exec] [junit] 2014-04-30 23:13:28,351 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11251:CommitProcessor@232] - Configuring
CommitProcessor with 8 worker threads.
[exec] [junit] 2014-04-30 23:13:28,352 [myid:] - INFO
[QuorumPeer[myid=1]/0:0:0:0:0:0:0:0:11248:Learner@459] - Learner received
UPTODATE message
[exec] [junit] 2014-04-30 23:13:28,353 [myid:] - INFO
[QuorumPeer[myid=1]/0:0:0:0:0:0:0:0:11248:CommitProcessor@232] - Configuring
CommitProcessor with 8 worker threads.
FATAL: hudson.remoting.RequestAbortedException: java.io.IOException: Unexpected
termination of the channel
hudson.remoting.RequestAbortedException:
hudson.remoting.RequestAbortedException: java.io.IOException: Unexpected
termination of the channel
at
hudson.remoting.RequestAbortedException.wrapForRethrow(RequestAbortedException.java:41)
at
hudson.remoting.RequestAbortedException.wrapForRethrow(RequestAbortedException.java:34)
at hudson.remoting.Request.call(Request.java:174)
at hudson.remoting.Channel.call(Channel.java:739)
at
hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:168)
at com.sun.proxy.$Proxy54.join(Unknown Source)
at hudson.Launcher$RemoteLauncher$ProcImpl.join(Launcher.java:951)
at hudson.tasks.CommandInterpreter.join(CommandInterpreter.java:137)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:97)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:66)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:745)
at hudson.model.Build$BuildExecution.build(Build.java:198)
at hudson.model.Build$BuildExecution.doRun(Build.java:159)
at
hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:518)
at hudson.model.Run.execute(Run.java:1706)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:88)
at hudson.model.Executor.run(Executor.java:231)
Caused by: hudson.remoting.RequestAbortedException: java.io.IOException:
Unexpected termination of the channel
at hudson.remoting.Request.abort(Request.java:299)
at hudson.remoting.Channel.terminate(Channel.java:802)
at
hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:69)
Caused by: java.io.IOException: Unexpected termination of the channel
at
hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:50)
Caused by: java.io.EOFException
at
java.io.ObjectInputStream$PeekInputStream.readFully(ObjectInputStream.java:2328)
at
java.io.ObjectInputStream$BlockDataInputStream.readShort(ObjectInputStream.java:2797)
at
java.io.ObjectInputStream.readStreamHeader(ObjectInputStream.java:802)
at java.io.ObjectInputStream.<init>(ObjectInputStream.java:299)
at
hudson.remoting.ObjectInputStreamEx.<init>(ObjectInputStreamEx.java:40)
at
hudson.remoting.AbstractSynchronousByteArrayCommandTransport.read(AbstractSynchronousByteArrayCommandTransport.java:34)
at
hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:48)
###################################################################################
############################## FAILED TESTS (if any)
##############################
No tests ran.