See https://builds.apache.org/job/ZooKeeper-trunk-openjdk7/825/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE
###########################
[...truncated 372560 lines...]
[junit] 2015-05-29 20:10:08,440 [myid:] - INFO
[ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] -
ConnnectionExpirerThread interrupted
[junit] 2015-05-29 20:10:08,441 [myid:] - WARN
[LearnerHandler-/127.0.0.1:49272:LearnerHandler@595] - ******* GOODBYE
/127.0.0.1:49272 ********
[junit] 2015-05-29 20:10:08,441 [myid:] - INFO
[NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420]
- selector thread exitted run method
[junit] 2015-05-29 20:10:08,441 [myid:] - WARN
[LearnerHandler-/127.0.0.1:49272:LearnerHandler@879] - Ignoring unexpected
exception
[junit] java.lang.InterruptedException
[junit] at
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1219)
[junit] at
java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:340)
[junit] at
java.util.concurrent.LinkedBlockingQueue.put(LinkedBlockingQueue.java:338)
[junit] at
org.apache.zookeeper.server.quorum.LearnerHandler.shutdown(LearnerHandler.java:877)
[junit] at
org.apache.zookeeper.server.quorum.LearnerHandler.run(LearnerHandler.java:598)
[junit] 2015-05-29 20:10:08,441 [myid:] - WARN
[LearnerHandler-/127.0.0.1:49279:LearnerHandler@595] - ******* GOODBYE
/127.0.0.1:49279 ********
[junit] 2015-05-29 20:10:08,441 [myid:] - WARN
[LearnerHandler-/127.0.0.1:49279:LearnerHandler@879] - Ignoring unexpected
exception
[junit] java.lang.InterruptedException
[junit] at
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1219)
[junit] at
java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:340)
[junit] at
java.util.concurrent.LinkedBlockingQueue.put(LinkedBlockingQueue.java:338)
[junit] at
org.apache.zookeeper.server.quorum.LearnerHandler.shutdown(LearnerHandler.java:877)
[junit] at
org.apache.zookeeper.server.quorum.LearnerHandler.run(LearnerHandler.java:598)
[junit] 2015-05-29 20:10:08,441 [myid:] - INFO
[NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420]
- selector thread exitted run method
[junit] 2015-05-29 20:10:08,442 [myid:] - INFO
[QuorumPeer[myid=3](plain=/0:0:0:0:0:0:0:0:30214)(secure=disabled):MBeanRegistry@119]
- Unregister MBean
[org.apache.ZooKeeperService:name0=ReplicatedServer_id3,name1=replica.3,name2=Leader]
[junit] 2015-05-29 20:10:08,442 [myid:] - INFO
[/127.0.0.1:30216:QuorumCnxManager$Listener@654] - Leaving listener
[junit] 2015-05-29 20:10:08,442 [myid:] - WARN
[QuorumPeer[myid=3](plain=/0:0:0:0:0:0:0:0:30214)(secure=disabled):QuorumPeer@1039]
- Unexpected exception
[junit] java.lang.InterruptedException
[junit] at java.lang.Object.wait(Native Method)
[junit] at
org.apache.zookeeper.server.quorum.Leader.lead(Leader.java:559)
[junit] at
org.apache.zookeeper.server.quorum.QuorumPeer.run(QuorumPeer.java:1036)
[junit] 2015-05-29 20:10:08,442 [myid:] - INFO
[QuorumPeer[myid=3](plain=/0:0:0:0:0:0:0:0:30214)(secure=disabled):Leader@613]
- Shutting down
[junit] 2015-05-29 20:10:08,442 [myid:] - INFO [main:QuorumUtil@254] -
Shutting down leader election
QuorumPeer[myid=3](plain=/0:0:0:0:0:0:0:0:30214)(secure=disabled)
[junit] 2015-05-29 20:10:08,442 [myid:] - WARN
[QuorumPeer[myid=3](plain=/0:0:0:0:0:0:0:0:30214)(secure=disabled):QuorumPeer@1070]
- PeerState set to LOOKING
[junit] 2015-05-29 20:10:08,442 [myid:] - INFO [main:QuorumUtil@259] -
Waiting for QuorumPeer[myid=3](plain=/0:0:0:0:0:0:0:0:30214)(secure=disabled)
to exit thread
[junit] 2015-05-29 20:10:08,442 [myid:] - WARN
[QuorumPeer[myid=3](plain=/0:0:0:0:0:0:0:0:30214)(secure=disabled):QuorumPeer@1052]
- QuorumPeer main thread exited
[junit] 2015-05-29 20:10:08,443 [myid:] - INFO
[QuorumPeer[myid=3](plain=/0:0:0:0:0:0:0:0:30214)(secure=disabled):MBeanRegistry@119]
- Unregister MBean [org.apache.ZooKeeperService:name0=ReplicatedServer_id3]
[junit] 2015-05-29 20:10:08,443 [myid:] - INFO
[QuorumPeer[myid=3](plain=/0:0:0:0:0:0:0:0:30214)(secure=disabled):MBeanRegistry@119]
- Unregister MBean
[org.apache.ZooKeeperService:name0=ReplicatedServer_id3,name1=replica.3]
[junit] 2015-05-29 20:10:08,443 [myid:] - INFO
[QuorumPeer[myid=3](plain=/0:0:0:0:0:0:0:0:30214)(secure=disabled):MBeanRegistry@119]
- Unregister MBean
[org.apache.ZooKeeperService:name0=ReplicatedServer_id3,name1=replica.1]
[junit] 2015-05-29 20:10:08,443 [myid:] - INFO
[QuorumPeer[myid=3](plain=/0:0:0:0:0:0:0:0:30214)(secure=disabled):MBeanRegistry@119]
- Unregister MBean
[org.apache.ZooKeeperService:name0=ReplicatedServer_id3,name1=replica.2]
[junit] 2015-05-29 20:10:08,443 [myid:] - INFO
[main:FourLetterWordMain@63] - connecting to 127.0.0.1 30208
[junit] 2015-05-29 20:10:08,444 [myid:] - INFO [main:QuorumUtil@243] -
127.0.0.1:30208 is no longer accepting client connections
[junit] 2015-05-29 20:10:08,444 [myid:] - INFO
[main:FourLetterWordMain@63] - connecting to 127.0.0.1 30211
[junit] 2015-05-29 20:10:08,444 [myid:] - INFO [main:QuorumUtil@243] -
127.0.0.1:30211 is no longer accepting client connections
[junit] 2015-05-29 20:10:08,444 [myid:] - INFO
[main:FourLetterWordMain@63] - connecting to 127.0.0.1 30214
[junit] 2015-05-29 20:10:08,444 [myid:] - INFO [main:QuorumUtil@243] -
127.0.0.1:30214 is no longer accepting client connections
[junit] 2015-05-29 20:10:08,445 [myid:] - INFO [main:ZKTestCase$1@65] -
SUCCEEDED testJMXBeanAfterRoleChange
[junit] 2015-05-29 20:10:08,445 [myid:] - INFO [main:ZKTestCase$1@60] -
FINISHED testJMXBeanAfterRoleChange
[junit] Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed:
115.631 sec, Thread: 8, Class: org.apache.zookeeper.test.ReconfigTest
[junit] 2015-05-29 20:10:08,527 [myid:] - INFO
[WorkerSender[myid=3]:FastLeaderElection$Messenger$WorkerSender@465] -
WorkerSender is down
[junit] 2015-05-29 20:10:08,527 [myid:] - INFO
[WorkerReceiver[myid=3]:FastLeaderElection$Messenger$WorkerReceiver@435] -
WorkerReceiver is down
[junit] 2015-05-29 20:10:08,530 [myid:] - INFO
[WorkerSender[myid=2]:FastLeaderElection$Messenger$WorkerSender@465] -
WorkerSender is down
[junit] 2015-05-29 20:10:08,530 [myid:] - INFO
[WorkerReceiver[myid=2]:FastLeaderElection$Messenger$WorkerReceiver@435] -
WorkerReceiver is down
[junit] 2015-05-29 20:10:08,531 [myid:] - INFO
[WorkerSender[myid=1]:FastLeaderElection$Messenger$WorkerSender@465] -
WorkerSender is down
[junit] 2015-05-29 20:10:08,532 [myid:] - INFO
[WorkerReceiver[myid=1]:FastLeaderElection$Messenger$WorkerReceiver@435] -
WorkerReceiver is down
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-openjdk7/trunk/build.xml:1374:
Tests failed!
Total time: 5 minutes 59 seconds
Build step 'Invoke Ant' marked build as failure
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any)
##############################
1 tests failed.
REGRESSION:
org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testCurrentObserverIsParticipantInNewConfig
Error Message:
waiting for server 2 being up
Stack Trace:
junit.framework.AssertionFailedError: waiting for server 2 being up
at
org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testCurrentObserverIsParticipantInNewConfig(ReconfigRecoveryTest.java:529)
at
org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:55)