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 2016/10/17 10:02:59 UTC
ZooKeeper-trunk-openjdk7 - Build # 1206 - Still Failing
See https://builds.apache.org/job/ZooKeeper-trunk-openjdk7/1206/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 481744 lines...]
[junit] 2016-10-17 10:02:23,498 [myid:3] - WARN [QuorumPeer[myid=3](plain=/127.0.0.1:30082)(secure=disabled):QuorumPeer@1158] - PeerState set to LOOKING
[junit] 2016-10-17 10:02:23,498 [myid:3] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:30082)(secure=disabled):QuorumPeer@1033] - LOOKING
[junit] 2016-10-17 10:02:23,498 [myid:3] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:30082)(secure=disabled):FastLeaderElection@894] - New election. My id = 3, proposed zxid=0x8000000000000000
[junit] 2016-10-17 10:02:23,499 [myid:3] - INFO [WorkerReceiver[myid=3]:FastLeaderElection@688] - Notification: 2 (message format version), 2 (n.leader), 0x100000010 (n.zxid), 0x0 (n.round), LEADING (n.state), 2 (n.sid), 0x2 (n.peerEPoch), LOOKING (my state)200000017 (n.config version)
[junit] 2016-10-17 10:02:23,499 [myid:3] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:30082)(secure=disabled):MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=ReplicatedServer_id3,name1=replica.3,name2=LeaderElection]
[junit] 2016-10-17 10:02:23,500 [myid:3] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:30082)(secure=disabled):QuorumPeer@1096] - OBSERVING
[junit] 2016-10-17 10:02:23,500 [myid:3] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:30082)(secure=disabled):ZooKeeperServer@889] - minSessionTimeout set to 8000
[junit] 2016-10-17 10:02:23,500 [myid:3] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:30082)(secure=disabled):ZooKeeperServer@898] - maxSessionTimeout set to 80000
[junit] 2016-10-17 10:02:23,500 [myid:3] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:30082)(secure=disabled):ZooKeeperServer@159] - Created server with tickTime 4000 minSessionTimeout 8000 maxSessionTimeout 80000 datadir /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-openjdk7/build/test/tmp/test7754486032653410597.junit.dir/data/version-2 snapdir /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-openjdk7/build/test/tmp/test7754486032653410597.junit.dir/data/version-2
[junit] 2016-10-17 10:02:23,500 [myid:3] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:30082)(secure=disabled):ObserverZooKeeperServer@56] - syncEnabled =true
[junit] 2016-10-17 10:02:23,500 [myid:3] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:30082)(secure=disabled):Observer@67] - Observing localhost/127.0.0.1:30080
[junit] 2016-10-17 10:02:23,500 [myid:3] - WARN [QuorumPeer[myid=3](plain=/127.0.0.1:30082)(secure=disabled):Learner@273] - Unexpected exception, tries=0, remaining init limit=40000, connecting to localhost/127.0.0.1:30080
[junit] java.net.ConnectException: Connection refused
[junit] at java.net.PlainSocketImpl.socketConnect(Native Method)
[junit] at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:339)
[junit] at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:200)
[junit] at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:182)
[junit] at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
[junit] at java.net.Socket.connect(Socket.java:579)
[junit] at org.apache.zookeeper.server.quorum.Learner.sockConnect(Learner.java:227)
[junit] at org.apache.zookeeper.server.quorum.Learner.connectToLeader(Learner.java:256)
[junit] at org.apache.zookeeper.server.quorum.Observer.observeLeader(Observer.java:69)
[junit] at org.apache.zookeeper.server.quorum.QuorumPeer.run(QuorumPeer.java:1098)
[junit] 2016-10-17 10:02:24,423 [myid:4] - WARN [QuorumPeer[myid=4](plain=/127.0.0.1:30085)(secure=disabled):Learner@273] - Unexpected exception, tries=1, remaining init limit=39000, connecting to localhost/127.0.0.1:30080
[junit] java.net.ConnectException: Connection refused
[junit] at java.net.PlainSocketImpl.socketConnect(Native Method)
[junit] at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:339)
[junit] at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:200)
[junit] at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:182)
[junit] at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
[junit] at java.net.Socket.connect(Socket.java:579)
[junit] at org.apache.zookeeper.server.quorum.Learner.sockConnect(Learner.java:227)
[junit] at org.apache.zookeeper.server.quorum.Learner.connectToLeader(Learner.java:256)
[junit] at org.apache.zookeeper.server.quorum.Observer.observeLeader(Observer.java:69)
[junit] at org.apache.zookeeper.server.quorum.QuorumPeer.run(QuorumPeer.java:1098)
[junit] 2016-10-17 10:02:24,501 [myid:3] - WARN [QuorumPeer[myid=3](plain=/127.0.0.1:30082)(secure=disabled):Learner@273] - Unexpected exception, tries=1, remaining init limit=39000, connecting to localhost/127.0.0.1:30080
[junit] java.net.ConnectException: Connection refused
[junit] at java.net.PlainSocketImpl.socketConnect(Native Method)
[junit] at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:339)
[junit] at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:200)
[junit] at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:182)
[junit] at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
[junit] at java.net.Socket.connect(Socket.java:579)
[junit] at org.apache.zookeeper.server.quorum.Learner.sockConnect(Learner.java:227)
[junit] at org.apache.zookeeper.server.quorum.Learner.connectToLeader(Learner.java:256)
[junit] at org.apache.zookeeper.server.quorum.Observer.observeLeader(Observer.java:69)
[junit] at org.apache.zookeeper.server.quorum.QuorumPeer.run(QuorumPeer.java:1098)
[junit] Running org.apache.zookeeper.server.quorum.StandaloneDisabledTest in thread 8
[junit] Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 0 sec, Thread: 8, Class: org.apache.zookeeper.server.quorum.StandaloneDisabledTest
[junit] Test org.apache.zookeeper.server.quorum.StandaloneDisabledTest FAILED (timeout)
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-openjdk7/build.xml:1207: Tests failed!
Total time: 16 minutes 15 seconds
Build step 'Invoke Ant' marked build as failure
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
FAILED: org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest
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.
at java.lang.Thread.run(Thread.java:745)
ZooKeeper-trunk-openjdk7 - Build # 1207 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-openjdk7/1207/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 438060 lines...]
[junit] 2016-10-17 20:03:25,341 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-10-17 20:03:25,341 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-10-17 20:03:25,341 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-10-17 20:03:25,341 [myid:] - INFO [main:PrepRequestProcessor@996] - Shutting down
[junit] 2016-10-17 20:03:25,341 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-10-17 20:03:25,341 [myid:] - INFO [ProcessThread(sid:0 cport:27624)::PrepRequestProcessor@156] - PrepRequestProcessor exited loop!
[junit] 2016-10-17 20:03:25,341 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-10-17 20:03:25,342 [myid:] - INFO [main:FinalRequestProcessor@481] - shutdown of request processor complete
[junit] 2016-10-17 20:03:25,342 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port27624,name1=InMemoryDataTree]
[junit] 2016-10-17 20:03:25,342 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port27624]
[junit] 2016-10-17 20:03:25,346 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 27624
[junit] 2016-10-17 20:03:25,347 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-10-17 20:03:25,350 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 1465 at start it was 1465
[junit] 2016-10-17 20:03:25,350 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testWatcherAutoResetWithLocal
[junit] 2016-10-17 20:03:25,350 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testWatcherAutoResetWithLocal
[junit] Tests run: 101, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 444.814 sec, Thread: 7, Class: org.apache.zookeeper.test.NettyNettySuiteTest
[junit] 2016-10-17 20:03:25,667 [myid:127.0.0.1:27504] - INFO [main-SendThread(127.0.0.1:27504):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:27504. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-10-17 20:03:25,668 [myid:] - INFO [New I/O boss #2583:ClientCnxnSocketNetty$1@127] - future isn't success, cause: {}
[junit] java.net.ConnectException: Connection refused: 127.0.0.1/127.0.0.1:27504
[junit] at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
[junit] at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:744)
[junit] at org.jboss.netty.channel.socket.nio.NioClientBoss.connect(NioClientBoss.java:152)
[junit] at org.jboss.netty.channel.socket.nio.NioClientBoss.processSelectedKeys(NioClientBoss.java:105)
[junit] at org.jboss.netty.channel.socket.nio.NioClientBoss.process(NioClientBoss.java:79)
[junit] at org.jboss.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:337)
[junit] at org.jboss.netty.channel.socket.nio.NioClientBoss.run(NioClientBoss.java:42)
[junit] at org.jboss.netty.util.ThreadRenamingRunnable.run(ThreadRenamingRunnable.java:108)
[junit] at org.jboss.netty.util.internal.DeadLockProofWorker$1.run(DeadLockProofWorker.java:42)
[junit] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
[junit] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit] at java.lang.Thread.run(Thread.java:745)
[junit] 2016-10-17 20:03:25,669 [myid:] - WARN [New I/O boss #2583:ClientCnxnSocketNetty$ZKClientHandler@439] - Exception caught: [id: 0x2661e761] EXCEPTION: java.net.ConnectException: Connection refused: 127.0.0.1/127.0.0.1:27504
[junit] java.net.ConnectException: Connection refused: 127.0.0.1/127.0.0.1:27504
[junit] at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
[junit] at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:744)
[junit] at org.jboss.netty.channel.socket.nio.NioClientBoss.connect(NioClientBoss.java:152)
[junit] at org.jboss.netty.channel.socket.nio.NioClientBoss.processSelectedKeys(NioClientBoss.java:105)
[junit] at org.jboss.netty.channel.socket.nio.NioClientBoss.process(NioClientBoss.java:79)
[junit] at org.jboss.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:337)
[junit] at org.jboss.netty.channel.socket.nio.NioClientBoss.run(NioClientBoss.java:42)
[junit] at org.jboss.netty.util.ThreadRenamingRunnable.run(ThreadRenamingRunnable.java:108)
[junit] at org.jboss.netty.util.internal.DeadLockProofWorker$1.run(DeadLockProofWorker.java:42)
[junit] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
[junit] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit] at java.lang.Thread.run(Thread.java:745)
[junit] 2016-10-17 20:03:25,669 [myid:] - INFO [New I/O boss #2583:ClientCnxnSocketNetty@208] - channel is told closing
[junit] 2016-10-17 20:03:25,669 [myid:127.0.0.1:27504] - INFO [main-SendThread(127.0.0.1:27504):ClientCnxn$SendThread@1231] - channel for sessionid 0x200001560740000 is lost, closing socket connection and attempting reconnect
[junit] Running org.apache.zookeeper.server.quorum.Zab1_0Test in thread 4
[junit] Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 0 sec, Thread: 4, Class: org.apache.zookeeper.server.quorum.Zab1_0Test
[junit] Test org.apache.zookeeper.server.quorum.Zab1_0Test FAILED (timeout)
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-openjdk7/build.xml:1207: Tests failed!
Total time: 16 minutes 27 seconds
Build step 'Invoke Ant' marked build as failure
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
2 tests failed.
FAILED: org.apache.zookeeper.server.quorum.Zab1_0Test.testNormalObserverRun
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.
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.zookeeper.test.LETest.testLE
Error Message:
Threads didn't join
Stack Trace:
junit.framework.AssertionFailedError: Threads didn't join
at org.apache.zookeeper.test.LETest.testLE(LETest.java:123)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)