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/08/15 12:58:57 UTC
ZooKeeper-trunk-jdk8 - Build # 709 - Failure
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/709/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 448513 lines...]
[junit] 2016-08-15 12:58:56,216 [myid:] - INFO [main:ZooKeeperServer@889] - minSessionTimeout set to 6000
[junit] 2016-08-15 12:58:56,217 [myid:] - INFO [main:ZooKeeperServer@898] - maxSessionTimeout set to 60000
[junit] 2016-08-15 12:58:56,217 [myid:] - INFO [main:ZooKeeperServer@159] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test6573486747579820905.junit.dir/version-2 snapdir /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test6573486747579820905.junit.dir/version-2
[junit] 2016-08-15 12:58:56,218 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test6573486747579820905.junit.dir/version-2/snapshot.b
[junit] 2016-08-15 12:58:56,220 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test6573486747579820905.junit.dir/version-2/snapshot.b
[junit] 2016-08-15 12:58:56,221 [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-08-15 12:58:56,221 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-15 12:58:56,222 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:42051
[junit] 2016-08-15 12:58:56,223 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:42051
[junit] 2016-08-15 12:58:56,223 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-08-15 12:58:56,223 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:42051 (no session established for client)
[junit] 2016-08-15 12:58:56,224 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-08-15 12:58:56,227 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-08-15 12:58:56,227 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-08-15 12:58:56,228 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-08-15 12:58:56,228 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-08-15 12:58:56,229 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 45012
[junit] 2016-08-15 12:58:56,229 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 25
[junit] 2016-08-15 12:58:56,229 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-08-15 12:58:56,230 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-08-15 12:58:56,281 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x10047276e200000 closed
[junit] 2016-08-15 12:58:56,281 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x10047276e200000
[junit] 2016-08-15 12:58:56,281 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-08-15 12:58:56,282 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-15 12:58:56,282 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-15 12:58:56,282 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-15 12:58:56,282 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-2:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-15 12:58:56,282 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-15 12:58:56,283 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-15 12:58:56,283 [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-08-15 12:58:56,283 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-15 12:58:56,283 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-15 12:58:56,283 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-15 12:58:56,283 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-15 12:58:56,283 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-15 12:58:56,283 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-15 12:58:56,284 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-08-15 12:58:56,284 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-08-15 12:58:56,284 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-15 12:58:56,285 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-08-15 12:58:56,289 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 50 at start it was 35
[junit] 2016-08-15 12:58:56,289 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-08-15 12:58:56,290 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-08-15 12:58:56,290 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.816 sec
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build.xml:1233: Tests failed!
Total time: 74 minutes 28 seconds
Build step 'Invoke Ant' marked build as failure
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting JDK_1_8_LATEST__HOME=/home/jenkins/tools/java/latest1.8
Setting JDK_1_8_LATEST__HOME=/home/jenkins/tools/java/latest1.8
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting JDK_1_8_LATEST__HOME=/home/jenkins/tools/java/latest1.8
Setting JDK_1_8_LATEST__HOME=/home/jenkins/tools/java/latest1.8
###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
FAILED: org.apache.zookeeper.test.WatcherTest.testWatchAutoResetWithPending
Error Message:
For 0 expected:<1> but was:<0>
Stack Trace:
junit.framework.AssertionFailedError: For 0 expected:<1> but was:<0>
at org.apache.zookeeper.test.WatcherTest.testWatchAutoResetWithPending(WatcherTest.java:211)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
ZooKeeper-trunk-jdk8 - Build # 710 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/710/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 453572 lines...]
[junit] 2016-08-16 11:58:28,326 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testWatcherAutoResetWithLocal
[junit] 2016-08-16 11:58:28,326 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testWatcherAutoResetWithLocal
[junit] Tests run: 101, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 521.377 sec, Thread: 4, Class: org.apache.zookeeper.test.NioNettySuiteTest
[junit] 2016-08-16 11:58:28,558 [myid:127.0.0.1:19422] - INFO [main-SendThread(127.0.0.1:19422):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:19422. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-08-16 11:58:28,559 [myid:127.0.0.1:19422] - WARN [main-SendThread(127.0.0.1:19422):ClientCnxn$SendThread@1235] - Session 0x1003d0904070000 for server 127.0.0.1/127.0.0.1:19422, 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:717)
[junit] at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:357)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1214)
[junit] 2016-08-16 11:59:23,492 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 128397
[junit] 2016-08-16 11:59:23,493 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 55
[junit] 2016-08-16 11:59:23,493 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testManyChildWatchersAutoReset
[junit] 2016-08-16 11:59:23,493 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-08-16 11:59:23,494 [myid:] - INFO [ProcessThread(sid:0 cport:16611)::PrepRequestProcessor@647] - Processed session termination for sessionid: 0x1003d0286010000
[junit] 2016-08-16 11:59:23,535 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x1003d0286010000 closed
[junit] 2016-08-16 11:59:23,535 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x1003d0286010000
[junit] 2016-08-16 11:59:23,535 [myid:] - INFO [NIOWorkerThread-26:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port16611,name1=Connections,name2=127.0.0.1,name3=0x1003d0286010000]
[junit] 2016-08-16 11:59:23,536 [myid:] - INFO [ProcessThread(sid:0 cport:16611)::PrepRequestProcessor@647] - Processed session termination for sessionid: 0x1003d0286010001
[junit] 2016-08-16 11:59:23,536 [myid:] - INFO [NIOWorkerThread-26:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:59495 which had sessionid 0x1003d0286010000
[junit] 2016-08-16 11:59:23,668 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x1003d0286010001 closed
[junit] 2016-08-16 11:59:23,668 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x1003d0286010001
[junit] 2016-08-16 11:59:23,668 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-08-16 11:59:23,668 [myid:] - INFO [NIOWorkerThread-12:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port16611,name1=Connections,name2=127.0.0.1,name3=0x1003d0286010001]
[junit] 2016-08-16 11:59:23,669 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-16 11:59:23,670 [myid:] - INFO [NIOWorkerThread-12:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:59465 which had sessionid 0x1003d0286010001
[junit] 2016-08-16 11:59:23,670 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:16611:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-16 11:59:23,672 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-16 11:59:23,674 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-16 11:59:23,677 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-16 11:59:23,677 [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-08-16 11:59:23,677 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-16 11:59:23,677 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-16 11:59:23,677 [myid:] - INFO [ProcessThread(sid:0 cport:16611)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-16 11:59:23,678 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-16 11:59:23,678 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-16 11:59:23,678 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-16 11:59:23,679 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port16611,name1=InMemoryDataTree]
[junit] 2016-08-16 11:59:23,679 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port16611]
[junit] 2016-08-16 11:59:23,679 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 16611
[junit] 2016-08-16 11:59:23,680 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-08-16 11:59:23,705 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 49 at start it was 53
[junit] 2016-08-16 11:59:23,705 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testManyChildWatchersAutoReset
[junit] 2016-08-16 11:59:23,705 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testManyChildWatchersAutoReset
[junit] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 693.766 sec, Thread: 3, Class: org.apache.zookeeper.test.DisconnectedWatcherTest
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build.xml:1207: Tests failed!
Total time: 14 minutes 46 seconds
Build step 'Invoke Ant' marked build as failure
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting JDK_1_8_LATEST__HOME=/home/jenkins/tools/java/latest1.8
Setting JDK_1_8_LATEST__HOME=/home/jenkins/tools/java/latest1.8
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting JDK_1_8_LATEST__HOME=/home/jenkins/tools/java/latest1.8
Setting JDK_1_8_LATEST__HOME=/home/jenkins/tools/java/latest1.8
###################################################################################
############################## FAILED TESTS (if any) ##############################
2 tests failed.
FAILED: org.apache.zookeeper.server.ZxidRolloverTest.testRolloverThenFollowerRestart
Error Message:
Did not connect
Stack Trace:
java.util.concurrent.TimeoutException: Did not connect
at org.apache.zookeeper.test.ClientBase$CountdownWatcher.waitForConnected(ClientBase.java:132)
at org.apache.zookeeper.server.ZxidRolloverTest.waitForClientsConnected(ZxidRolloverTest.java:80)
at org.apache.zookeeper.server.ZxidRolloverTest.createNodes(ZxidRolloverTest.java:237)
at org.apache.zookeeper.server.ZxidRolloverTest.testRolloverThenFollowerRestart(ZxidRolloverTest.java:336)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
FAILED: org.apache.zookeeper.test.WatcherTest.testWatchAutoResetWithPending
Error Message:
For 50 expected:<1> but was:<0>
Stack Trace:
junit.framework.AssertionFailedError: For 50 expected:<1> but was:<0>
at org.apache.zookeeper.test.WatcherTest.testWatchAutoResetWithPending(WatcherTest.java:215)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)