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 2017/10/17 23:16:31 UTC
ZooKeeper_branch34_jdk8 - Build # 1168 - Failure
See https://builds.apache.org/job/ZooKeeper_branch34_jdk8/1168/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 25.05 MB...]
[junit] 2017-10-17 23:16:19,804 [myid:] - INFO [main:PrepRequestProcessor@769] - Shutting down
[junit] 2017-10-17 23:16:19,804 [myid:] - INFO [main:SyncRequestProcessor@208] - Shutting down
[junit] 2017-10-17 23:16:19,804 [myid:] - INFO [ProcessThread(sid:0 cport:11221)::PrepRequestProcessor@144] - PrepRequestProcessor exited loop!
[junit] 2017-10-17 23:16:19,804 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@186] - SyncRequestProcessor exited!
[junit] 2017-10-17 23:16:19,805 [myid:] - INFO [main:FinalRequestProcessor@403] - shutdown of request processor complete
[junit] 2017-10-17 23:16:19,805 [myid:] - INFO [main:FourLetterWordMain@65] - connecting to 127.0.0.1 11221
[junit] 2017-10-17 23:16:19,806 [myid:] - INFO [main:JMXEnv@147] - ensureOnly:[]
[junit] 2017-10-17 23:16:19,807 [myid:] - INFO [main:ClientBase@489] - STARTING server
[junit] 2017-10-17 23:16:19,807 [myid:] - INFO [main:ClientBase@410] - CREATING server instance 127.0.0.1:11221
[junit] 2017-10-17 23:16:19,808 [myid:] - INFO [main:ServerCnxnFactory@117] - Using org.apache.zookeeper.server.NIOServerCnxnFactory as server connection factory
[junit] 2017-10-17 23:16:19,808 [myid:] - INFO [main:NIOServerCnxnFactory@89] - binding to port 0.0.0.0/0.0.0.0:11221
[junit] 2017-10-17 23:16:19,808 [myid:] - INFO [main:ClientBase@385] - STARTING server instance 127.0.0.1:11221
[junit] 2017-10-17 23:16:19,809 [myid:] - INFO [main:ZooKeeperServer@173] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /home/jenkins/jenkins-slave/workspace/ZooKeeper_branch34_jdk8/build/test/tmp/test1528685434709637129.junit.dir/version-2 snapdir /home/jenkins/jenkins-slave/workspace/ZooKeeper_branch34_jdk8/build/test/tmp/test1528685434709637129.junit.dir/version-2
[junit] 2017-10-17 23:16:19,812 [myid:] - ERROR [main:ZooKeeperServer@468] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-10-17 23:16:19,812 [myid:] - INFO [main:FourLetterWordMain@65] - connecting to 127.0.0.1 11221
[junit] 2017-10-17 23:16:19,813 [myid:] - INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory@215] - Accepted socket connection from /127.0.0.1:34614
[junit] 2017-10-17 23:16:19,896 [myid:] - INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxn@892] - Processing stat command from /127.0.0.1:34614
[junit] 2017-10-17 23:16:19,897 [myid:] - INFO [Thread-4:NIOServerCnxn$StatCommand@683] - Stat command output
[junit] 2017-10-17 23:16:19,897 [myid:] - INFO [Thread-4:NIOServerCnxn@1040] - Closed socket connection for client /127.0.0.1:34614 (no session established for client)
[junit] 2017-10-17 23:16:19,897 [myid:] - INFO [main:JMXEnv@230] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2017-10-17 23:16:19,900 [myid:] - INFO [main:JMXEnv@247] - expect:InMemoryDataTree
[junit] 2017-10-17 23:16:19,900 [myid:] - INFO [main:JMXEnv@251] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11221,name1=InMemoryDataTree
[junit] 2017-10-17 23:16:19,900 [myid:] - INFO [main:JMXEnv@247] - expect:StandaloneServer_port
[junit] 2017-10-17 23:16:19,900 [myid:] - INFO [main:JMXEnv@251] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11221
[junit] 2017-10-17 23:16:19,901 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@58] - Memory used 32245
[junit] 2017-10-17 23:16:19,901 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@63] - Number of threads 20
[junit] 2017-10-17 23:16:19,901 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@78] - FINISHED TEST METHOD testQuota
[junit] 2017-10-17 23:16:19,902 [myid:] - INFO [main:ClientBase@566] - tearDown starting
[junit] 2017-10-17 23:16:20,004 [myid:] - INFO [main:ZooKeeper@687] - Session: 0x104f2bd82be0000 closed
[junit] 2017-10-17 23:16:20,005 [myid:] - INFO [main:ClientBase@536] - STOPPING server
[junit] 2017-10-17 23:16:20,004 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@520] - EventThread shut down for session: 0x104f2bd82be0000
[junit] 2017-10-17 23:16:20,005 [myid:] - INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory@242] - NIOServerCnxn factory exited run method
[junit] 2017-10-17 23:16:20,005 [myid:] - INFO [main:ZooKeeperServer@501] - shutting down
[junit] 2017-10-17 23:16:20,005 [myid:] - ERROR [main:ZooKeeperServer@468] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-10-17 23:16:20,006 [myid:] - INFO [main:SessionTrackerImpl@226] - Shutting down
[junit] 2017-10-17 23:16:20,006 [myid:] - INFO [main:PrepRequestProcessor@769] - Shutting down
[junit] 2017-10-17 23:16:20,006 [myid:] - INFO [main:SyncRequestProcessor@208] - Shutting down
[junit] 2017-10-17 23:16:20,006 [myid:] - INFO [ProcessThread(sid:0 cport:11221)::PrepRequestProcessor@144] - PrepRequestProcessor exited loop!
[junit] 2017-10-17 23:16:20,006 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@186] - SyncRequestProcessor exited!
[junit] 2017-10-17 23:16:20,007 [myid:] - INFO [main:FinalRequestProcessor@403] - shutdown of request processor complete
[junit] 2017-10-17 23:16:20,007 [myid:] - INFO [main:FourLetterWordMain@65] - connecting to 127.0.0.1 11221
[junit] 2017-10-17 23:16:20,008 [myid:] - INFO [main:JMXEnv@147] - ensureOnly:[]
[junit] 2017-10-17 23:16:20,011 [myid:] - INFO [main:ClientBase@591] - fdcount after test is: 92 at start it was 78
[junit] 2017-10-17 23:16:20,012 [myid:] - INFO [main:ClientBase@593] - sleeping for 20 secs
[junit] 2017-10-17 23:16:20,013 [myid:] - INFO [main:ZKTestCase$1@69] - SUCCEEDED testQuota
[junit] 2017-10-17 23:16:20,013 [myid:] - INFO [main:ZKTestCase$1@64] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.869 sec
fail.build.on.test.failure:
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper_branch34_jdk8/build.xml:1382: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/ZooKeeper_branch34_jdk8/build.xml:1385: Tests failed!
Total time: 43 minutes 45 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) ##############################
4 tests failed.
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:120)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:55)
FAILED: org.apache.zookeeper.test.LoadFromLogTest.testRestoreWithTransactionErrors
Error Message:
KeeperErrorCode = ConnectionLoss for /invaliddir/test-
Stack Trace:
org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /invaliddir/test-
at org.apache.zookeeper.KeeperException.create(KeeperException.java:102)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:54)
at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:786)
at org.apache.zookeeper.test.LoadFromLogTest.testRestoreWithTransactionErrors(LoadFromLogTest.java:368)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:55)
FAILED: org.apache.zookeeper.test.LoadFromLogTest.testReloadSnapshotWithMissingParent
Error Message:
Address already in use
Stack Trace:
java.net.BindException: Address already in use
at sun.nio.ch.Net.bind0(Native Method)
at sun.nio.ch.Net.bind(Net.java:433)
at sun.nio.ch.Net.bind(Net.java:425)
at sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:223)
at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:74)
at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:67)
at org.apache.zookeeper.server.NIOServerCnxnFactory.configure(NIOServerCnxnFactory.java:90)
at org.apache.zookeeper.server.ServerCnxnFactory.createFactory(ServerCnxnFactory.java:137)
at org.apache.zookeeper.server.ServerCnxnFactory.createFactory(ServerCnxnFactory.java:130)
at org.apache.zookeeper.test.LoadFromLogTest.testReloadSnapshotWithMissingParent(LoadFromLogTest.java:412)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:55)
FAILED: org.apache.zookeeper.test.MaxCnxnsTest.testMaxCnxns
Error Message:
expected same:<30> was not:<16>
Stack Trace:
junit.framework.AssertionFailedError: expected same:<30> was not:<16>
at org.apache.zookeeper.test.MaxCnxnsTest.testMaxCnxns(MaxCnxnsTest.java:137)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:55)
ZooKeeper_branch34_jdk8 - Build # 1169 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch34_jdk8/1169/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 25.90 MB...]
[junit] 2017-10-18 22:40:26,764 [myid:] - INFO [main:PrepRequestProcessor@769] - Shutting down
[junit] 2017-10-18 22:40:26,764 [myid:] - INFO [main:SyncRequestProcessor@208] - Shutting down
[junit] 2017-10-18 22:40:26,764 [myid:] - INFO [ProcessThread(sid:0 cport:11221)::PrepRequestProcessor@144] - PrepRequestProcessor exited loop!
[junit] 2017-10-18 22:40:26,765 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@186] - SyncRequestProcessor exited!
[junit] 2017-10-18 22:40:26,765 [myid:] - INFO [main:FinalRequestProcessor@403] - shutdown of request processor complete
[junit] 2017-10-18 22:40:26,765 [myid:] - INFO [main:FourLetterWordMain@65] - connecting to 127.0.0.1 11221
[junit] 2017-10-18 22:40:26,766 [myid:] - INFO [main:JMXEnv@147] - ensureOnly:[]
[junit] 2017-10-18 22:40:26,767 [myid:] - INFO [main:ClientBase@489] - STARTING server
[junit] 2017-10-18 22:40:26,767 [myid:] - INFO [main:ClientBase@410] - CREATING server instance 127.0.0.1:11221
[junit] 2017-10-18 22:40:26,767 [myid:] - INFO [main:ServerCnxnFactory@117] - Using org.apache.zookeeper.server.NIOServerCnxnFactory as server connection factory
[junit] 2017-10-18 22:40:26,767 [myid:] - INFO [main:NIOServerCnxnFactory@89] - binding to port 0.0.0.0/0.0.0.0:11221
[junit] 2017-10-18 22:40:26,767 [myid:] - INFO [main:ClientBase@385] - STARTING server instance 127.0.0.1:11221
[junit] 2017-10-18 22:40:26,768 [myid:] - INFO [main:ZooKeeperServer@173] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /home/jenkins/jenkins-slave/workspace/ZooKeeper_branch34_jdk8/build/test/tmp/test251909381903390046.junit.dir/version-2 snapdir /home/jenkins/jenkins-slave/workspace/ZooKeeper_branch34_jdk8/build/test/tmp/test251909381903390046.junit.dir/version-2
[junit] 2017-10-18 22:40:26,770 [myid:] - ERROR [main:ZooKeeperServer@468] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-10-18 22:40:26,770 [myid:] - INFO [main:FourLetterWordMain@65] - connecting to 127.0.0.1 11221
[junit] 2017-10-18 22:40:26,771 [myid:] - INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory@215] - Accepted socket connection from /127.0.0.1:43770
[junit] 2017-10-18 22:40:26,771 [myid:] - INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxn@892] - Processing stat command from /127.0.0.1:43770
[junit] 2017-10-18 22:40:26,772 [myid:] - INFO [Thread-4:NIOServerCnxn$StatCommand@683] - Stat command output
[junit] 2017-10-18 22:40:26,772 [myid:] - INFO [Thread-4:NIOServerCnxn@1040] - Closed socket connection for client /127.0.0.1:43770 (no session established for client)
[junit] 2017-10-18 22:40:26,772 [myid:] - INFO [main:JMXEnv@230] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2017-10-18 22:40:26,774 [myid:] - INFO [main:JMXEnv@247] - expect:InMemoryDataTree
[junit] 2017-10-18 22:40:26,774 [myid:] - INFO [main:JMXEnv@251] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11221,name1=InMemoryDataTree
[junit] 2017-10-18 22:40:26,774 [myid:] - INFO [main:JMXEnv@247] - expect:StandaloneServer_port
[junit] 2017-10-18 22:40:26,774 [myid:] - INFO [main:JMXEnv@251] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11221
[junit] 2017-10-18 22:40:26,775 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@58] - Memory used 31589
[junit] 2017-10-18 22:40:26,775 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@63] - Number of threads 20
[junit] 2017-10-18 22:40:26,775 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@78] - FINISHED TEST METHOD testQuota
[junit] 2017-10-18 22:40:26,775 [myid:] - INFO [main:ClientBase@566] - tearDown starting
[junit] 2017-10-18 22:40:26,852 [myid:] - INFO [main:ZooKeeper@687] - Session: 0x1075c9c32c50000 closed
[junit] 2017-10-18 22:40:26,852 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@520] - EventThread shut down for session: 0x1075c9c32c50000
[junit] 2017-10-18 22:40:26,852 [myid:] - INFO [main:ClientBase@536] - STOPPING server
[junit] 2017-10-18 22:40:26,853 [myid:] - INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory@242] - NIOServerCnxn factory exited run method
[junit] 2017-10-18 22:40:26,853 [myid:] - INFO [main:ZooKeeperServer@501] - shutting down
[junit] 2017-10-18 22:40:26,853 [myid:] - ERROR [main:ZooKeeperServer@468] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-10-18 22:40:26,853 [myid:] - INFO [main:SessionTrackerImpl@226] - Shutting down
[junit] 2017-10-18 22:40:26,853 [myid:] - INFO [main:PrepRequestProcessor@769] - Shutting down
[junit] 2017-10-18 22:40:26,854 [myid:] - INFO [main:SyncRequestProcessor@208] - Shutting down
[junit] 2017-10-18 22:40:26,854 [myid:] - INFO [ProcessThread(sid:0 cport:11221)::PrepRequestProcessor@144] - PrepRequestProcessor exited loop!
[junit] 2017-10-18 22:40:26,854 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@186] - SyncRequestProcessor exited!
[junit] 2017-10-18 22:40:26,854 [myid:] - INFO [main:FinalRequestProcessor@403] - shutdown of request processor complete
[junit] 2017-10-18 22:40:26,855 [myid:] - INFO [main:FourLetterWordMain@65] - connecting to 127.0.0.1 11221
[junit] 2017-10-18 22:40:26,856 [myid:] - INFO [main:JMXEnv@147] - ensureOnly:[]
[junit] 2017-10-18 22:40:26,868 [myid:] - INFO [main:ClientBase@591] - fdcount after test is: 96 at start it was 78
[junit] 2017-10-18 22:40:26,868 [myid:] - INFO [main:ClientBase@593] - sleeping for 20 secs
[junit] 2017-10-18 22:40:26,870 [myid:] - INFO [main:ZKTestCase$1@69] - SUCCEEDED testQuota
[junit] 2017-10-18 22:40:26,870 [myid:] - INFO [main:ZKTestCase$1@64] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.691 sec
fail.build.on.test.failure:
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper_branch34_jdk8/build.xml:1382: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/ZooKeeper_branch34_jdk8/build.xml:1385: Tests failed!
Total time: 32 minutes 40 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.auth.QuorumAuthUpgradeTest.testAuthLearnerAgainstNoAuthRequiredServer
Error Message:
QP failed to shutdown in 80000 seconds: QuorumPeer[myid=0]/0:0:0:0:0:0:0:0:11242
Stack Trace:
junit.framework.AssertionFailedError: QP failed to shutdown in 80000 seconds: QuorumPeer[myid=0]/0:0:0:0:0:0:0:0:11242
at org.apache.zookeeper.test.QuorumBase.shutdown(QuorumBase.java:322)
at org.apache.zookeeper.server.quorum.QuorumPeerTestBase$TestQPMain.shutdown(QuorumPeerTestBase.java:59)
at org.apache.zookeeper.server.quorum.QuorumPeerTestBase$MainThread.shutdown(QuorumPeerTestBase.java:156)
at org.apache.zookeeper.server.quorum.auth.QuorumAuthTestBase.shutdown(QuorumAuthTestBase.java:240)
at org.apache.zookeeper.server.quorum.auth.QuorumAuthTestBase.shutdownAll(QuorumAuthTestBase.java:233)
at org.apache.zookeeper.server.quorum.auth.QuorumAuthUpgradeTest.tearDown(QuorumAuthUpgradeTest.java:68)