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/12 23:21:05 UTC

ZooKeeper_branch34_jdk8 - Build # 1162 - Failure

See https://builds.apache.org/job/ZooKeeper_branch34_jdk8/1162/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 31.64 MB...]
    [junit] 2017-10-12 23:20:55,109 [myid:] - INFO  [main:PrepRequestProcessor@769] - Shutting down
    [junit] 2017-10-12 23:20:55,109 [myid:] - INFO  [main:SyncRequestProcessor@208] - Shutting down
    [junit] 2017-10-12 23:20:55,109 [myid:] - INFO  [ProcessThread(sid:0 cport:11221)::PrepRequestProcessor@144] - PrepRequestProcessor exited loop!
    [junit] 2017-10-12 23:20:55,110 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@186] - SyncRequestProcessor exited!
    [junit] 2017-10-12 23:20:55,110 [myid:] - INFO  [main:FinalRequestProcessor@403] - shutdown of request processor complete
    [junit] 2017-10-12 23:20:55,111 [myid:] - INFO  [main:FourLetterWordMain@65] - connecting to 127.0.0.1 11221
    [junit] 2017-10-12 23:20:55,111 [myid:] - INFO  [main:JMXEnv@147] - ensureOnly:[]
    [junit] 2017-10-12 23:20:55,113 [myid:] - INFO  [main:ClientBase@489] - STARTING server
    [junit] 2017-10-12 23:20:55,113 [myid:] - INFO  [main:ClientBase@410] - CREATING server instance 127.0.0.1:11221
    [junit] 2017-10-12 23:20:55,114 [myid:] - INFO  [main:ServerCnxnFactory@117] - Using org.apache.zookeeper.server.NIOServerCnxnFactory as server connection factory
    [junit] 2017-10-12 23:20:55,114 [myid:] - INFO  [main:NIOServerCnxnFactory@89] - binding to port 0.0.0.0/0.0.0.0:11221
    [junit] 2017-10-12 23:20:55,114 [myid:] - INFO  [main:ClientBase@385] - STARTING server instance 127.0.0.1:11221
    [junit] 2017-10-12 23:20:55,115 [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/test680045926673423872.junit.dir/version-2 snapdir /home/jenkins/jenkins-slave/workspace/ZooKeeper_branch34_jdk8/build/test/tmp/test680045926673423872.junit.dir/version-2
    [junit] 2017-10-12 23:20:55,119 [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-12 23:20:55,119 [myid:] - INFO  [main:FourLetterWordMain@65] - connecting to 127.0.0.1 11221
    [junit] 2017-10-12 23:20:55,120 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory@215] - Accepted socket connection from /127.0.0.1:60658
    [junit] 2017-10-12 23:20:55,120 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxn@892] - Processing stat command from /127.0.0.1:60658
    [junit] 2017-10-12 23:20:55,121 [myid:] - INFO  [Thread-4:NIOServerCnxn$StatCommand@683] - Stat command output
    [junit] 2017-10-12 23:20:55,122 [myid:] - INFO  [Thread-4:NIOServerCnxn@1040] - Closed socket connection for client /127.0.0.1:60658 (no session established for client)
    [junit] 2017-10-12 23:20:55,122 [myid:] - INFO  [main:JMXEnv@230] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2017-10-12 23:20:55,124 [myid:] - INFO  [main:JMXEnv@247] - expect:InMemoryDataTree
    [junit] 2017-10-12 23:20:55,125 [myid:] - INFO  [main:JMXEnv@251] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11221,name1=InMemoryDataTree
    [junit] 2017-10-12 23:20:55,125 [myid:] - INFO  [main:JMXEnv@247] - expect:StandaloneServer_port
    [junit] 2017-10-12 23:20:55,125 [myid:] - INFO  [main:JMXEnv@251] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11221
    [junit] 2017-10-12 23:20:55,125 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@58] - Memory used 31590
    [junit] 2017-10-12 23:20:55,126 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@63] - Number of threads 20
    [junit] 2017-10-12 23:20:55,126 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@78] - FINISHED TEST METHOD testQuota
    [junit] 2017-10-12 23:20:55,126 [myid:] - INFO  [main:ClientBase@566] - tearDown starting
    [junit] 2017-10-12 23:20:55,188 [myid:] - INFO  [main:ZooKeeper@687] - Session: 0x101721ae2040000 closed
    [junit] 2017-10-12 23:20:55,188 [myid:] - INFO  [main:ClientBase@536] - STOPPING server
    [junit] 2017-10-12 23:20:55,188 [myid:] - INFO  [main-EventThread:ClientCnxn$EventThread@520] - EventThread shut down for session: 0x101721ae2040000
    [junit] 2017-10-12 23:20:55,189 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory@242] - NIOServerCnxn factory exited run method
    [junit] 2017-10-12 23:20:55,189 [myid:] - INFO  [main:ZooKeeperServer@501] - shutting down
    [junit] 2017-10-12 23:20:55,189 [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-12 23:20:55,189 [myid:] - INFO  [main:SessionTrackerImpl@226] - Shutting down
    [junit] 2017-10-12 23:20:55,190 [myid:] - INFO  [main:PrepRequestProcessor@769] - Shutting down
    [junit] 2017-10-12 23:20:55,190 [myid:] - INFO  [main:SyncRequestProcessor@208] - Shutting down
    [junit] 2017-10-12 23:20:55,190 [myid:] - INFO  [ProcessThread(sid:0 cport:11221)::PrepRequestProcessor@144] - PrepRequestProcessor exited loop!
    [junit] 2017-10-12 23:20:55,190 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@186] - SyncRequestProcessor exited!
    [junit] 2017-10-12 23:20:55,191 [myid:] - INFO  [main:FinalRequestProcessor@403] - shutdown of request processor complete
    [junit] 2017-10-12 23:20:55,191 [myid:] - INFO  [main:FourLetterWordMain@65] - connecting to 127.0.0.1 11221
    [junit] 2017-10-12 23:20:55,192 [myid:] - INFO  [main:JMXEnv@147] - ensureOnly:[]
    [junit] 2017-10-12 23:20:55,197 [myid:] - INFO  [main:ClientBase@591] - fdcount after test is: 96 at start it was 78
    [junit] 2017-10-12 23:20:55,198 [myid:] - INFO  [main:ClientBase@593] - sleeping for 20 secs
    [junit] 2017-10-12 23:20:55,199 [myid:] - INFO  [main:ZKTestCase$1@69] - SUCCEEDED testQuota
    [junit] 2017-10-12 23:20:55,199 [myid:] - INFO  [main:ZKTestCase$1@64] - FINISHED testQuota
    [junit] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.767 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 44 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) ##############################
3 tests failed.
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.LoadFromLogTest.testLoad

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.testLoad(LoadFromLogTest.java:85)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:55)

ZooKeeper_branch34_jdk8 - Build # 1163 - Still Failing

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch34_jdk8/1163/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 31.67 MB...]
    [junit] 2017-10-13 23:12:26,950 [myid:] - INFO  [main:PrepRequestProcessor@769] - Shutting down
    [junit] 2017-10-13 23:12:26,950 [myid:] - INFO  [main:SyncRequestProcessor@208] - Shutting down
    [junit] 2017-10-13 23:12:26,950 [myid:] - INFO  [ProcessThread(sid:0 cport:11221)::PrepRequestProcessor@144] - PrepRequestProcessor exited loop!
    [junit] 2017-10-13 23:12:26,950 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@186] - SyncRequestProcessor exited!
    [junit] 2017-10-13 23:12:26,951 [myid:] - INFO  [main:FinalRequestProcessor@403] - shutdown of request processor complete
    [junit] 2017-10-13 23:12:26,951 [myid:] - INFO  [main:FourLetterWordMain@65] - connecting to 127.0.0.1 11221
    [junit] 2017-10-13 23:12:26,952 [myid:] - INFO  [main:JMXEnv@147] - ensureOnly:[]
    [junit] 2017-10-13 23:12:26,953 [myid:] - INFO  [main:ClientBase@489] - STARTING server
    [junit] 2017-10-13 23:12:26,954 [myid:] - INFO  [main:ClientBase@410] - CREATING server instance 127.0.0.1:11221
    [junit] 2017-10-13 23:12:26,954 [myid:] - INFO  [main:ServerCnxnFactory@117] - Using org.apache.zookeeper.server.NIOServerCnxnFactory as server connection factory
    [junit] 2017-10-13 23:12:26,954 [myid:] - INFO  [main:NIOServerCnxnFactory@89] - binding to port 0.0.0.0/0.0.0.0:11221
    [junit] 2017-10-13 23:12:26,954 [myid:] - INFO  [main:ClientBase@385] - STARTING server instance 127.0.0.1:11221
    [junit] 2017-10-13 23:12:26,955 [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/test6254096257809791065.junit.dir/version-2 snapdir /home/jenkins/jenkins-slave/workspace/ZooKeeper_branch34_jdk8/build/test/tmp/test6254096257809791065.junit.dir/version-2
    [junit] 2017-10-13 23:12:26,958 [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-13 23:12:26,958 [myid:] - INFO  [main:FourLetterWordMain@65] - connecting to 127.0.0.1 11221
    [junit] 2017-10-13 23:12:26,959 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory@215] - Accepted socket connection from /127.0.0.1:53054
    [junit] 2017-10-13 23:12:26,960 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxn@892] - Processing stat command from /127.0.0.1:53054
    [junit] 2017-10-13 23:12:26,960 [myid:] - INFO  [Thread-4:NIOServerCnxn$StatCommand@683] - Stat command output
    [junit] 2017-10-13 23:12:26,961 [myid:] - INFO  [Thread-4:NIOServerCnxn@1040] - Closed socket connection for client /127.0.0.1:53054 (no session established for client)
    [junit] 2017-10-13 23:12:26,961 [myid:] - INFO  [main:JMXEnv@230] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2017-10-13 23:12:26,963 [myid:] - INFO  [main:JMXEnv@247] - expect:InMemoryDataTree
    [junit] 2017-10-13 23:12:26,963 [myid:] - INFO  [main:JMXEnv@251] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11221,name1=InMemoryDataTree
    [junit] 2017-10-13 23:12:26,963 [myid:] - INFO  [main:JMXEnv@247] - expect:StandaloneServer_port
    [junit] 2017-10-13 23:12:26,964 [myid:] - INFO  [main:JMXEnv@251] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11221
    [junit] 2017-10-13 23:12:26,964 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@58] - Memory used 31590
    [junit] 2017-10-13 23:12:26,964 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@63] - Number of threads 20
    [junit] 2017-10-13 23:12:26,964 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@78] - FINISHED TEST METHOD testQuota
    [junit] 2017-10-13 23:12:26,965 [myid:] - INFO  [main:ClientBase@566] - tearDown starting
    [junit] 2017-10-13 23:12:27,027 [myid:] - INFO  [main:ZooKeeper@687] - Session: 0x10177397d020000 closed
    [junit] 2017-10-13 23:12:27,027 [myid:] - INFO  [main:ClientBase@536] - STOPPING server
    [junit] 2017-10-13 23:12:27,027 [myid:] - INFO  [main-EventThread:ClientCnxn$EventThread@520] - EventThread shut down for session: 0x10177397d020000
    [junit] 2017-10-13 23:12:27,028 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory@242] - NIOServerCnxn factory exited run method
    [junit] 2017-10-13 23:12:27,028 [myid:] - INFO  [main:ZooKeeperServer@501] - shutting down
    [junit] 2017-10-13 23:12:27,028 [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-13 23:12:27,028 [myid:] - INFO  [main:SessionTrackerImpl@226] - Shutting down
    [junit] 2017-10-13 23:12:27,028 [myid:] - INFO  [main:PrepRequestProcessor@769] - Shutting down
    [junit] 2017-10-13 23:12:27,029 [myid:] - INFO  [main:SyncRequestProcessor@208] - Shutting down
    [junit] 2017-10-13 23:12:27,029 [myid:] - INFO  [ProcessThread(sid:0 cport:11221)::PrepRequestProcessor@144] - PrepRequestProcessor exited loop!
    [junit] 2017-10-13 23:12:27,029 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@186] - SyncRequestProcessor exited!
    [junit] 2017-10-13 23:12:27,029 [myid:] - INFO  [main:FinalRequestProcessor@403] - shutdown of request processor complete
    [junit] 2017-10-13 23:12:27,030 [myid:] - INFO  [main:FourLetterWordMain@65] - connecting to 127.0.0.1 11221
    [junit] 2017-10-13 23:12:27,030 [myid:] - INFO  [main:JMXEnv@147] - ensureOnly:[]
    [junit] 2017-10-13 23:12:27,036 [myid:] - INFO  [main:ClientBase@591] - fdcount after test is: 96 at start it was 78
    [junit] 2017-10-13 23:12:27,036 [myid:] - INFO  [main:ClientBase@593] - sleeping for 20 secs
    [junit] 2017-10-13 23:12:27,037 [myid:] - INFO  [main:ZKTestCase$1@69] - SUCCEEDED testQuota
    [junit] 2017-10-13 23:12:27,037 [myid:] - INFO  [main:ZKTestCase$1@64] - FINISHED testQuota
    [junit] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.712 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 20 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.test.FollowerTest.testNoLogBeforeLeaderEstablishment

Error Message:
Not following

Stack Trace:
junit.framework.AssertionFailedError: Not following
	at org.apache.zookeeper.test.FollowerTest.testNoLogBeforeLeaderEstablishment(FollowerTest.java:181)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:55)