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/04/18 14:07:44 UTC
ZooKeeper-trunk-jdk8 - Build # 568 - Failure
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/568/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 354577 lines...]
[junit] 2016-04-18 12:06:42,519 [myid:] - INFO [QuorumPeer[myid=5](plain=/127.0.0.1:27396)(secure=disabled):FastLeaderElection@928] - Notification time out: 60000
[junit] 2016-04-18 12:06:42,520 [myid:] - WARN [WorkerSender[myid=5]:QuorumCnxManager@459] - Cannot open channel to 1 at election address /127.0.0.1:27387
[junit] java.net.ConnectException: Connection refused
[junit] at java.net.PlainSocketImpl.socketConnect(Native Method)
[junit] at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:345)
[junit] at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
[junit] at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
[junit] at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
[junit] at java.net.Socket.connect(Socket.java:589)
[junit] at org.apache.zookeeper.server.quorum.QuorumCnxManager.connectOne(QuorumCnxManager.java:444)
[junit] at org.apache.zookeeper.server.quorum.QuorumCnxManager.connectOne(QuorumCnxManager.java:485)
[junit] at org.apache.zookeeper.server.quorum.QuorumCnxManager.toSend(QuorumCnxManager.java:421)
[junit] at org.apache.zookeeper.server.quorum.FastLeaderElection$Messenger$WorkerSender.process(FastLeaderElection.java:486)
[junit] at org.apache.zookeeper.server.quorum.FastLeaderElection$Messenger$WorkerSender.run(FastLeaderElection.java:465)
[junit] at java.lang.Thread.run(Thread.java:744)
[junit] 2016-04-18 12:06:42,520 [myid:] - WARN [WorkerSender[myid=5]:QuorumCnxManager@459] - Cannot open channel to 2 at election address /127.0.0.1:27388
[junit] java.net.ConnectException: Connection refused
[junit] at java.net.PlainSocketImpl.socketConnect(Native Method)
[junit] at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:345)
[junit] at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
[junit] at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
[junit] at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
[junit] at java.net.Socket.connect(Socket.java:589)
[junit] at org.apache.zookeeper.server.quorum.QuorumCnxManager.connectOne(QuorumCnxManager.java:444)
[junit] at org.apache.zookeeper.server.quorum.QuorumCnxManager.connectOne(QuorumCnxManager.java:485)
[junit] at org.apache.zookeeper.server.quorum.QuorumCnxManager.toSend(QuorumCnxManager.java:421)
[junit] at org.apache.zookeeper.server.quorum.FastLeaderElection$Messenger$WorkerSender.process(FastLeaderElection.java:486)
[junit] at org.apache.zookeeper.server.quorum.FastLeaderElection$Messenger$WorkerSender.run(FastLeaderElection.java:465)
[junit] at java.lang.Thread.run(Thread.java:744)
[junit] 2016-04-18 12:06:42,521 [myid:] - WARN [WorkerSender[myid=5]:QuorumCnxManager@459] - Cannot open channel to 3 at election address /127.0.0.1:27389
[junit] java.net.ConnectException: Connection refused
[junit] at java.net.PlainSocketImpl.socketConnect(Native Method)
[junit] at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:345)
[junit] at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
[junit] at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
[junit] at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
[junit] at java.net.Socket.connect(Socket.java:589)
[junit] at org.apache.zookeeper.server.quorum.QuorumCnxManager.connectOne(QuorumCnxManager.java:444)
[junit] at org.apache.zookeeper.server.quorum.QuorumCnxManager.connectOne(QuorumCnxManager.java:485)
[junit] at org.apache.zookeeper.server.quorum.QuorumCnxManager.toSend(QuorumCnxManager.java:421)
[junit] at org.apache.zookeeper.server.quorum.FastLeaderElection$Messenger$WorkerSender.process(FastLeaderElection.java:486)
[junit] at org.apache.zookeeper.server.quorum.FastLeaderElection$Messenger$WorkerSender.run(FastLeaderElection.java:465)
[junit] at java.lang.Thread.run(Thread.java:744)
[junit] 2016-04-18 12:06:42,524 [myid:] - INFO [WorkerReceiver[myid=5]:FastLeaderElection@688] - Notification: 2 (message format version), 5 (n.leader), 0x10000000a (n.zxid), 0x3 (n.round), LOOKING (n.state), 5 (n.sid), 0x2 (n.peerEPoch), LOOKING (my state)100000000 (n.config version)
[junit] 2016-04-18 12:06:42,527 [myid:] - INFO [WorkerReceiver[myid=4]:FastLeaderElection@688] - Notification: 2 (message format version), 5 (n.leader), 0x10000000a (n.zxid), 0x3 (n.round), LOOKING (n.state), 5 (n.sid), 0x2 (n.peerEPoch), LEADING (my state)100000000 (n.config version)
[junit] 2016-04-18 12:06:42,528 [myid:] - INFO [WorkerReceiver[myid=5]:FastLeaderElection@688] - Notification: 2 (message format version), 4 (n.leader), 0x0 (n.zxid), 0xffffffffffffffff (n.round), LEADING (n.state), 4 (n.sid), 0x1 (n.peerEPoch), LOOKING (my state)100000000 (n.config version)
[junit] Running org.apache.zookeeper.test.QuorumTest in thread 7
[junit] Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 0 sec, Thread: 7, Class: org.apache.zookeeper.test.QuorumTest
[junit] Test org.apache.zookeeper.test.QuorumTest FAILED (timeout)
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build.xml:1207: Tests failed!
Total time: 22 minutes 45 seconds
Build step 'Invoke Ant' marked build as failure
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
3 tests failed.
FAILED: org.apache.zookeeper.test.QuorumTest.testLeaderShutdown
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:744)
FAILED: org.apache.zookeeper.test.SSLTest.testSecureQuorumServer
Error Message:
waiting for server 0 being up
Stack Trace:
junit.framework.AssertionFailedError: waiting for server 0 being up
at org.apache.zookeeper.test.SSLTest.testSecureQuorumServer(SSLTest.java:99)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
FAILED: org.apache.zookeeper.test.SSLTest.testSecureStandaloneServer
Error Message:
Timeout connecting to ZK server secure port
Stack Trace:
junit.framework.AssertionFailedError: Timeout connecting to ZK server secure port
at org.apache.zookeeper.test.SSLTest.testSecureStandaloneServer(SSLTest.java:152)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
ZooKeeper-trunk-jdk8 - Build # 569 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/569/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 375377 lines...]
[junit] 2016-04-19 11:56:09,496 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test7490698365538955007.junit.dir/version-2/snapshot.5
[junit] 2016-04-19 11:56:09,497 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0x6 to /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test7490698365538955007.junit.dir/version-2/snapshot.6
[junit] 2016-04-19 11:56:09,504 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 27386
[junit] 2016-04-19 11:56:09,505 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:27386:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:46899
[junit] 2016-04-19 11:56:09,511 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:46899
[junit] 2016-04-19 11:56:09,511 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-04-19 11:56:09,513 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:46899 (no session established for client)
[junit] 2016-04-19 11:56:09,513 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-04-19 11:56:09,516 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-04-19 11:56:09,516 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port27386,name1=InMemoryDataTree
[junit] 2016-04-19 11:56:09,516 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-04-19 11:56:09,516 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port27386
[junit] 2016-04-19 11:56:11,166 [myid:127.0.0.1:27386] - INFO [main-SendThread(127.0.0.1:27386):ClientCnxn$SendThread@1140] - Opening socket connection to server 127.0.0.1/127.0.0.1:27386. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-04-19 11:56:11,167 [myid:127.0.0.1:27386] - INFO [main-SendThread(127.0.0.1:27386):ClientCnxn$SendThread@981] - Socket connection established, initiating session, client: /127.0.0.1:46935, server: 127.0.0.1/127.0.0.1:27386
[junit] 2016-04-19 11:56:11,167 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:27386:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:46935
[junit] 2016-04-19 11:56:11,177 [myid:] - INFO [NIOWorkerThread-2:ZooKeeperServer@969] - Client attempting to renew session 0x10237cec8480000 at /127.0.0.1:46935
[junit] 2016-04-19 11:56:11,178 [myid:] - INFO [NIOWorkerThread-2:ZooKeeperServer@678] - Established session 0x10237cec8480000 with negotiated timeout 6000 for client /127.0.0.1:46935
[junit] 2016-04-19 11:56:11,191 [myid:127.0.0.1:27386] - INFO [main-SendThread(127.0.0.1:27386):ClientCnxn$SendThread@1408] - Session establishment complete on server 127.0.0.1/127.0.0.1:27386, sessionid = 0x10237cec8480000, negotiated timeout = 6000
[junit] 2016-04-19 11:56:11,198 [myid:] - INFO [SyncThread:0:FileTxnLog@204] - Creating new log file: log.7
[junit] 2016-04-19 11:56:11,280 [myid:] - INFO [SessionTracker:SessionTrackerImpl@158] - SessionTrackerImpl exited loop!
[junit] 2016-04-19 11:56:12,277 [myid:] - INFO [ProcessThread(sid:0 cport:27386)::PrepRequestProcessor@647] - Processed session termination for sessionid: 0x10237cec8480000
[junit] 2016-04-19 11:56:12,290 [myid:] - INFO [main:ZooKeeper@1110] - Session: 0x10237cec8480000 closed
[junit] 2016-04-19 11:56:12,291 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 6363
[junit] 2016-04-19 11:56:12,291 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 31
[junit] 2016-04-19 11:56:12,291 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@543] - EventThread shut down for session: 0x10237cec8480000
[junit] 2016-04-19 11:56:12,306 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testWatcherAutoResetWithLocal
[junit] 2016-04-19 11:56:12,309 [myid:] - INFO [main:ClientBase@537] - tearDown starting
[junit] 2016-04-19 11:56:12,310 [myid:] - INFO [main:ClientBase@507] - STOPPING server
[junit] 2016-04-19 11:56:12,311 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-04-19 11:56:12,313 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-04-19 11:56:12,313 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:27386:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-04-19 11:56:12,313 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-04-19 11:56:12,331 [myid:] - INFO [NIOWorkerThread-10:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port27386,name1=Connections,name2=127.0.0.1,name3=0x10237cec8480000]
[junit] 2016-04-19 11:56:12,331 [myid:] - INFO [NIOWorkerThread-10:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:46935 which had sessionid 0x10237cec8480000
[junit] 2016-04-19 11:56:12,334 [myid:] - INFO [main:ZooKeeperServer@498] - shutting down
[junit] 2016-04-19 11:56:12,334 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-04-19 11:56:12,334 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-04-19 11:56:12,334 [myid:] - INFO [ProcessThread(sid:0 cport:27386)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-04-19 11:56:12,335 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-04-19 11:56:12,336 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-04-19 11:56:12,336 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-04-19 11:56:12,337 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port27386,name1=InMemoryDataTree]
[junit] 2016-04-19 11:56:12,337 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port27386]
[junit] 2016-04-19 11:56:12,337 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 27386
[junit] 2016-04-19 11:56:12,338 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-04-19 11:56:12,349 [myid:] - INFO [main:ClientBase@562] - fdcount after test is: 51 at start it was 51
[junit] 2016-04-19 11:56:12,350 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testWatcherAutoResetWithLocal
[junit] 2016-04-19 11:56:12,350 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testWatcherAutoResetWithLocal
[junit] Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 34.959 sec, Thread: 7, Class: org.apache.zookeeper.test.WatcherTest
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build.xml:1207: Tests failed!
Total time: 11 minutes 24 seconds
Build step 'Invoke Ant' marked build as failure
[WARNINGS] Skipping publisher since build result is 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.test.SSLTest.testSecureQuorumServer
Error Message:
waiting for server 0 being up
Stack Trace:
junit.framework.AssertionFailedError: waiting for server 0 being up
at org.apache.zookeeper.test.SSLTest.testSecureQuorumServer(SSLTest.java:99)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
FAILED: org.apache.zookeeper.test.SSLTest.testSecureStandaloneServer
Error Message:
Timeout connecting to ZK server secure port
Stack Trace:
junit.framework.AssertionFailedError: Timeout connecting to ZK server secure port
at org.apache.zookeeper.test.SSLTest.testSecureStandaloneServer(SSLTest.java:152)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)