You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@zookeeper.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2014/06/17 15:21:58 UTC
ZooKeeper-trunk-jdk7 - Build # 884 - Failure
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