See https://builds.apache.org/job/ZooKeeper-trunk-jdk7/884/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE
###########################
[...truncated 297366 lines...]
[junit] at
org.apache.zookeeper.server.quorum.FastLeaderElection$Messenger$WorkerSender.process(FastLeaderElection.java:469)
[junit] at
org.apache.zookeeper.server.quorum.FastLeaderElection$Messenger$WorkerSender.run(FastLeaderElection.java:440)
[junit] at java.lang.Thread.run(Thread.java:724)
[junit] 2014-06-17 13:21:38,980 [myid:] - INFO
[WorkerReceiver[myid=3]:FastLeaderElection@608] - Notification: 4 (n.leader),
0x100000005 (n.zxid), 0x3 (n.round), LOOKING (n.state), 2 (n.sid), 0x1
(n.peerEPoch), LOOKING (my state)100000000 (n.config version)
[junit] 2014-06-17 13:21:38,980 [myid:] - INFO
[WorkerReceiver[myid=4]:FastLeaderElection@608] - Notification: 4 (n.leader),
0x100000005 (n.zxid), 0x3 (n.round), LOOKING (n.state), 2 (n.sid), 0x1
(n.peerEPoch), LOOKING (my state)100000000 (n.config version)
[junit] 2014-06-17 13:21:39,069 [myid:] - INFO
[main-SendThread(127.0.0.1:11239):ClientCnxn$SendThread@1093] - Opening socket
connection to server 127.0.0.1/127.0.0.1:11239. Will not attempt to
authenticate using SASL (unknown error)
[junit] 2014-06-17 13:21:39,070 [myid:] - INFO
[main-SendThread(127.0.0.1:11239):ClientCnxn$SendThread@963] - Socket
connection established to 127.0.0.1/127.0.0.1:11239, initiating session
[junit] 2014-06-17 13:21:39,070 [myid:] - INFO
[NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11239:NIOServerCnxnFactory$AcceptThread@296]
- Accepted socket connection from /127.0.0.1:48618
[junit] 2014-06-17 13:21:39,071 [myid:] - WARN
[NIOWorkerThread-7:NIOServerCnxn@372] - Exception causing close of session 0x0:
ZooKeeperServer not running
[junit] 2014-06-17 13:21:39,071 [myid:] - INFO
[NIOWorkerThread-7:NIOServerCnxn@1006] - Closed socket connection for client
/127.0.0.1:48618 (no session established for client)
[junit] 2014-06-17 13:21:39,071 [myid:] - INFO
[main-SendThread(127.0.0.1:11239):ClientCnxn$SendThread@1209] - Unable to read
additional data from server sessionid 0x0, likely server has closed socket,
closing socket connection and attempting reconnect
[junit] 2014-06-17 13:21:39,116 [myid:] - INFO
[main-SendThread(127.0.0.1:11230):ClientCnxn$SendThread@1093] - Opening socket
connection to server 127.0.0.1/127.0.0.1:11230. Will not attempt to
authenticate using SASL (unknown error)
[junit] 2014-06-17 13:21:39,116 [myid:] - WARN
[main-SendThread(127.0.0.1:11230):ClientCnxn$SendThread@1213] - Session
0x146a9fd5bde0000 for server 127.0.0.1/127.0.0.1:11230, unexpected error,
closing socket connection and attempting reconnect
[junit] java.net.ConnectException: Connection refused
[junit] at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
[junit] at
sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:708)
[junit] at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:356)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1192)
[junit] 2014-06-17 13:21:39,180 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11233:MBeanRegistry@119] - Unregister MBean
[org.apache.ZooKeeperService:name0=ReplicatedServer_id2,name1=replica.2,name2=LeaderElection]
[junit] 2014-06-17 13:21:39,180 [myid:] - INFO
[QuorumPeer[myid=3]/0:0:0:0:0:0:0:0:11236:MBeanRegistry@119] - Unregister MBean
[org.apache.ZooKeeperService:name0=ReplicatedServer_id3,name1=replica.3,name2=LeaderElection]
[junit] 2014-06-17 13:21:39,180 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11233:QuorumPeer@972] - FOLLOWING
[junit] 2014-06-17 13:21:39,180 [myid:] - INFO
[QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11239:MBeanRegistry@119] - Unregister MBean
[org.apache.ZooKeeperService:name0=ReplicatedServer_id4,name1=replica.4,name2=LeaderElection]
[junit] 2014-06-17 13:21:39,181 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11233:ZooKeeperServer@766] -
minSessionTimeout set to 4000
[junit] 2014-06-17 13:21:39,181 [myid:] - INFO
[QuorumPeer[myid=3]/0:0:0:0:0:0:0:0:11236:QuorumPeer@972] - FOLLOWING
[junit] 2014-06-17 13:21:39,181 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11233:ZooKeeperServer@775] -
maxSessionTimeout set to 40000
[junit] 2014-06-17 13:21:39,181 [myid:] - INFO
[QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11239:QuorumPeer@984] - LEADING
[junit] 2014-06-17 13:21:39,181 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11233:ZooKeeperServer@149] - Created server
with tickTime 2000 minSessionTimeout 4000 maxSessionTimeout 40000 datadir
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build/test/tmp/test2598097563397720678.junit.dir/version-2
snapdir
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build/test/tmp/test2598097563397720678.junit.dir/version-2
[junit] 2014-06-17 13:21:39,181 [myid:] - INFO
[QuorumPeer[myid=3]/0:0:0:0:0:0:0:0:11236:ZooKeeperServer@766] -
minSessionTimeout set to 4000
[junit] 2014-06-17 13:21:39,182 [myid:] - INFO
[QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11233:Follower@65] - FOLLOWING - LEADER
ELECTION TOOK - 1
[junit] 2014-06-17 13:21:39,181 [myid:] - INFO
[QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11239:ZooKeeperServer@766] -
minSessionTimeout set to 4000
[junit] 2014-06-17 13:21:39,182 [myid:] - INFO
[QuorumPeer[myid=3]/0:0:0:0:0:0:0:0:11236:ZooKeeperServer@775] -
maxSessionTimeout set to 40000
[junit] 2014-06-17 13:21:39,182 [myid:] - INFO
[QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11239:ZooKeeperServer@775] -
maxSessionTimeout set to 40000
[junit] 2014-06-17 13:21:39,182 [myid:] - INFO
[QuorumPeer[myid=3]/0:0:0:0:0:0:0:0:11236:ZooKeeperServer@149] - Created server
with tickTime 2000 minSessionTimeout 4000 maxSessionTimeout 40000 datadir
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build/test/tmp/test1426181275163611458.junit.dir/version-2
snapdir
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build/test/tmp/test1426181275163611458.junit.dir/version-2
[junit] 2014-06-17 13:21:39,182 [myid:] - INFO
[QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11239:ZooKeeperServer@149] - Created server
with tickTime 2000 minSessionTimeout 4000 maxSessionTimeout 40000 datadir
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build/test/tmp/test8498670941518353085.junit.dir/version-2
snapdir
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build/test/tmp/test8498670941518353085.junit.dir/version-2
[junit] 2014-06-17 13:21:39,182 [myid:] - INFO
[QuorumPeer[myid=3]/0:0:0:0:0:0:0:0:11236:Follower@65] - FOLLOWING - LEADER
ELECTION TOOK - 1
[junit] 2014-06-17 13:21:39,183 [myid:] - INFO
[QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11239:Leader@409] - LEADING - LEADER
ELECTION TOOK - 2
[junit] 2014-06-17 13:21:39,185 [myid:] - INFO
[QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11239:FileTxnSnapLog@298] - Snapshotting:
0x100000005 to
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build/test/tmp/test8498670941518353085.junit.dir/version-2/snapshot.100000005
[junit] 2014-06-17 13:21:39,186 [myid:] - INFO
[LearnerHandler-/127.0.0.1:59879:LearnerHandler@361] - Follower sid: 2 : info :
127.0.0.1:12234:12235:participant;127.0.0.1:11233
[junit] 2014-06-17 13:21:39,186 [myid:] - INFO
[LearnerHandler-/127.0.0.1:59880:LearnerHandler@361] - Follower sid: 3 : info :
127.0.0.1:12237:12238:participant;127.0.0.1:11236
[junit] 2014-06-17 13:21:39,490 [myid:] - INFO
[main-SendThread(127.0.0.1:11233):ClientCnxn$SendThread@1093] - Opening socket
connection to server 127.0.0.1/127.0.0.1:11233. Will not attempt to
authenticate using SASL (unknown error)
[junit] 2014-06-17 13:21:39,490 [myid:] - INFO
[main-SendThread(127.0.0.1:11233):ClientCnxn$SendThread@963] - Socket
connection established to 127.0.0.1/127.0.0.1:11233, initiating session
[junit] 2014-06-17 13:21:39,490 [myid:] - INFO
[NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11233:NIOServerCnxnFactory$AcceptThread@296]
- Accepted socket connection from /127.0.0.1:49414
[junit] 2014-06-17 13:21:39,491 [myid:] - WARN
[NIOWorkerThread-7:NIOServerCnxn@372] - Exception causing close of session 0x0:
ZooKeeperServer not running
[junit] 2014-06-17 13:21:39,491 [myid:] - INFO
[NIOWorkerThread-7:NIOServerCnxn@1006] - Closed socket connection for client
/127.0.0.1:49414 (no session established for client)
[junit] 2014-06-17 13:21:39,492 [myid:] - INFO
[main-SendThread(127.0.0.1:11233):ClientCnxn$SendThread@1209] - Unable to read
additional data from server sessionid 0x246a9fd57d60000, likely server has
closed socket, closing socket connection and attempting reconnect
[junit] 2014-06-17 13:21:39,795 [myid:] - INFO
[main-SendThread(127.0.0.1:11236):ClientCnxn$SendThread@1093] - Opening socket
connection to server 127.0.0.1/127.0.0.1:11236. Will not attempt to
authenticate using SASL (unknown error)
[junit] 2014-06-17 13:21:39,795 [myid:] - INFO
[main-SendThread(127.0.0.1:11236):ClientCnxn$SendThread@963] - Socket
connection established to 127.0.0.1/127.0.0.1:11236, initiating session
[junit] 2014-06-17 13:21:39,795 [myid:] - INFO
[NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11236:NIOServerCnxnFactory$AcceptThread@296]
- Accepted socket connection from /127.0.0.1:39410
[junit] 2014-06-17 13:21:39,796 [myid:] - WARN
[NIOWorkerThread-8:NIOServerCnxn@372] - Exception causing close of session 0x0:
ZooKeeperServer not running
[junit] 2014-06-17 13:21:39,796 [myid:] - INFO
[NIOWorkerThread-8:NIOServerCnxn@1006] - Closed socket connection for client
/127.0.0.1:39410 (no session established for client)
[junit] 2014-06-17 13:21:39,796 [myid:] - INFO
[main-SendThread(127.0.0.1:11236):ClientCnxn$SendThread@1209] - Unable to read
additional data from server sessionid 0x346a9fd57d60000, likely server has
closed socket, closing socket connection and attempting reconnect
Build timed out (after 60 minutes). Marking the build as failed.
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Build was aborted
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any)
##############################
2 tests failed.
REGRESSION: org.apache.zookeeper.test.AsyncHammerTest.testObserversHammer
Error Message:
Timeout occurred. Please note the time in the report does not reflect the time
until the timeout.
Stack Trace:
junit.framework.AssertionFailedError: Timeout occurred. Please note the time in
the report does not reflect the time until the timeout.
FAILED: TEST-org.apache.zookeeper.test.ReconfigTest.xml.<init>
Error Message:
Stack Trace:
Test report file
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build/test/logs/TEST-org.apache.zookeeper.test.ReconfigTest.xml
was length 0
