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/11 20:47:01 UTC
ZooKeeper-trunk-openjdk7 - Build # 1199 - Still Failing
See https://builds.apache.org/job/ZooKeeper-trunk-openjdk7/1199/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 459674 lines...]
[junit] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit] at java.lang.Thread.run(Thread.java:745)
[junit] 2016-10-11 20:46:45,176 [myid:] - INFO [New I/O boss #18:ClientCnxnSocketNetty@208] - channel is told closing
[junit] 2016-10-11 20:46:45,176 [myid:127.0.0.1:19301] - INFO [main-SendThread(127.0.0.1:19301):ClientCnxn$SendThread@1231] - channel for sessionid 0x10000d386310000 is lost, closing socket connection and attempting reconnect
[junit] 2016-10-11 20:46:45,346 [myid:] - INFO [ProcessThread(sid:0 cport:19545)::PrepRequestProcessor@605] - Processed session termination for sessionid: 0x10000d9efe40000
[junit] 2016-10-11 20:46:45,347 [myid:] - WARN [New I/O worker #3953:NettyServerCnxnFactory$CnxnChannelHandler@142] - Exception caught [id: 0x0116d95d, /127.0.0.1:59696 :> /127.0.0.1:19545] EXCEPTION: java.nio.channels.ClosedChannelException
[junit] java.nio.channels.ClosedChannelException
[junit] at sun.nio.ch.SocketChannelImpl.ensureWriteOpen(SocketChannelImpl.java:270)
[junit] at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:479)
[junit] at org.jboss.netty.channel.socket.nio.SocketSendBufferPool$UnpooledSendBuffer.transferTo(SocketSendBufferPool.java:203)
[junit] at org.jboss.netty.channel.socket.nio.AbstractNioWorker.write0(AbstractNioWorker.java:201)
[junit] at org.jboss.netty.channel.socket.nio.AbstractNioWorker.writeFromTaskLoop(AbstractNioWorker.java:151)
[junit] at org.jboss.netty.channel.socket.nio.AbstractNioChannel$WriteTask.run(AbstractNioChannel.java:315)
[junit] at org.jboss.netty.channel.socket.nio.AbstractNioSelector.processTaskQueue(AbstractNioSelector.java:391)
[junit] at org.jboss.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:315)
[junit] at org.jboss.netty.channel.socket.nio.AbstractNioWorker.run(AbstractNioWorker.java:89)
[junit] at org.jboss.netty.channel.socket.nio.NioWorker.run(NioWorker.java:178)
[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-11 20:46:45,347 [myid:] - INFO [New I/O worker #3928:ClientCnxnSocketNetty$ZKClientHandler@384] - channel is disconnected: [id: 0x2cb96b07, /127.0.0.1:59696 :> 127.0.0.1/127.0.0.1:19545]
[junit] 2016-10-11 20:46:45,347 [myid:] - INFO [SyncThread:0:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port19545,name1=Connections,name2=127.0.0.1,name3=0x10000d9efe40000]
[junit] 2016-10-11 20:46:45,347 [myid:] - INFO [New I/O worker #3928:ClientCnxnSocketNetty@208] - channel is told closing
[junit] 2016-10-11 20:46:45,348 [myid:] - INFO [main:ClientCnxnSocketNetty@208] - channel is told closing
[junit] 2016-10-11 20:46:45,348 [myid:] - INFO [main:ZooKeeper@1315] - Session: 0x10000d9efe40000 closed
[junit] 2016-10-11 20:46:45,348 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x10000d9efe40000
[junit] 2016-10-11 20:46:45,348 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 48290
[junit] 2016-10-11 20:46:45,348 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 516
[junit] 2016-10-11 20:46:45,348 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testWatcherAutoResetWithLocal
[junit] 2016-10-11 20:46:45,348 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-10-11 20:46:45,348 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-10-11 20:46:45,348 [myid:] - INFO [main:NettyServerCnxnFactory@464] - shutdown called 0.0.0.0/0.0.0.0:19545
[junit] 2016-10-11 20:46:45,350 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-10-11 20:46:45,350 [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-11 20:46:45,350 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-10-11 20:46:45,350 [myid:] - INFO [main:PrepRequestProcessor@996] - Shutting down
[junit] 2016-10-11 20:46:45,350 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-10-11 20:46:45,350 [myid:] - INFO [ProcessThread(sid:0 cport:19545)::PrepRequestProcessor@156] - PrepRequestProcessor exited loop!
[junit] 2016-10-11 20:46:45,350 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-10-11 20:46:45,350 [myid:] - INFO [main:FinalRequestProcessor@481] - shutdown of request processor complete
[junit] 2016-10-11 20:46:45,351 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port19545,name1=InMemoryDataTree]
[junit] 2016-10-11 20:46:45,351 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port19545]
[junit] 2016-10-11 20:46:45,351 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 19545
[junit] 2016-10-11 20:46:45,351 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-10-11 20:46:45,354 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 1463 at start it was 1464
[junit] 2016-10-11 20:46:45,354 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testWatcherAutoResetWithLocal
[junit] 2016-10-11 20:46:45,354 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testWatcherAutoResetWithLocal
[junit] Tests run: 101, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 427.39 sec, Thread: 4, Class: org.apache.zookeeper.test.NettyNettySuiteTest
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-openjdk7/build.xml:1207: Tests failed!
Total time: 10 minutes 31 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.RaceConditionTest.testRaceConditionBetweenLeaderAndAckRequestProcessor
Error Message:
Leader failed to transition to LOOKING or FOLLOWING state
Stack Trace:
junit.framework.AssertionFailedError: Leader failed to transition to LOOKING or FOLLOWING state
at org.apache.zookeeper.server.quorum.RaceConditionTest.testRaceConditionBetweenLeaderAndAckRequestProcessor(RaceConditionTest.java:74)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testCurrentServersAreObserversInNextConfig
Error Message:
waiting for server 4 being up
Stack Trace:
junit.framework.AssertionFailedError: waiting for server 4 being up
at org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testCurrentServersAreObserversInNextConfig(ReconfigRecoveryTest.java:217)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)