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/09 21:16:36 UTC
ZooKeeper-trunk-jdk8 - Build # 778 - Failure
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/778/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 473094 lines...]
[junit] 2016-10-09 21:14:17,868 [myid:] - INFO [main:PrepRequestProcessor@996] - Shutting down
[junit] 2016-10-09 21:14:17,868 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-10-09 21:14:17,870 [myid:] - INFO [ProcessThread(sid:0 cport:14159)::PrepRequestProcessor@156] - PrepRequestProcessor exited loop!
[junit] 2016-10-09 21:14:17,870 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-10-09 21:14:17,870 [myid:] - INFO [main:FinalRequestProcessor@481] - shutdown of request processor complete
[junit] 2016-10-09 21:14:17,870 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port14159,name1=InMemoryDataTree]
[junit] 2016-10-09 21:14:17,871 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port14159]
[junit] 2016-10-09 21:14:17,871 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 14159
[junit] 2016-10-09 21:14:17,871 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-10-09 21:14:17,893 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 4831 at start it was 4827
[junit] 2016-10-09 21:14:17,894 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-10-09 21:14:17,894 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testWatcherAutoResetWithLocal
[junit] 2016-10-09 21:14:17,894 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testWatcherAutoResetWithLocal
[junit] Tests run: 101, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 559.971 sec, Thread: 2, Class: org.apache.zookeeper.test.NioNettySuiteTest
[junit] 2016-10-09 21:14:57,116 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 132268
[junit] 2016-10-09 21:14:57,117 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 55
[junit] 2016-10-09 21:14:57,117 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testManyChildWatchersAutoReset
[junit] 2016-10-09 21:14:57,117 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-10-09 21:14:57,118 [myid:] - INFO [ProcessThread(sid:0 cport:27383)::PrepRequestProcessor@605] - Processed session termination for sessionid: 0x102b08e4c760000
[junit] 2016-10-09 21:14:57,129 [myid:] - INFO [NIOWorkerThread-21:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port27383,name1=Connections,name2=127.0.0.1,name3=0x102b08e4c760000]
[junit] 2016-10-09 21:14:57,129 [myid:] - INFO [NIOWorkerThread-21:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:48368 which had sessionid 0x102b08e4c760000
[junit] 2016-10-09 21:14:57,130 [myid:] - INFO [main:ZooKeeper@1315] - Session: 0x102b08e4c760000 closed
[junit] 2016-10-09 21:14:57,130 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x102b08e4c760000
[junit] 2016-10-09 21:14:57,131 [myid:] - INFO [ProcessThread(sid:0 cport:27383)::PrepRequestProcessor@605] - Processed session termination for sessionid: 0x102b08e4c760001
[junit] 2016-10-09 21:14:57,167 [myid:] - INFO [NIOWorkerThread-10:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port27383,name1=Connections,name2=127.0.0.1,name3=0x102b08e4c760001]
[junit] 2016-10-09 21:14:57,167 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x102b08e4c760001
[junit] 2016-10-09 21:14:57,167 [myid:] - INFO [main:ZooKeeper@1315] - Session: 0x102b08e4c760001 closed
[junit] 2016-10-09 21:14:57,168 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-10-09 21:14:57,167 [myid:] - INFO [NIOWorkerThread-10:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:48364 which had sessionid 0x102b08e4c760001
[junit] 2016-10-09 21:14:57,169 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:27383:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-10-09 21:14:57,170 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-10-09 21:14:57,171 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-10-09 21:14:57,172 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-10-09 21:14:57,174 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-10-09 21:14:57,174 [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-09 21:14:57,174 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-10-09 21:14:57,174 [myid:] - INFO [main:PrepRequestProcessor@996] - Shutting down
[junit] 2016-10-09 21:14:57,174 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-10-09 21:14:57,174 [myid:] - INFO [ProcessThread(sid:0 cport:27383)::PrepRequestProcessor@156] - PrepRequestProcessor exited loop!
[junit] 2016-10-09 21:14:57,174 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-10-09 21:14:57,175 [myid:] - INFO [main:FinalRequestProcessor@481] - shutdown of request processor complete
[junit] 2016-10-09 21:14:57,175 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port27383,name1=InMemoryDataTree]
[junit] 2016-10-09 21:14:57,175 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port27383]
[junit] 2016-10-09 21:14:57,176 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 27383
[junit] 2016-10-09 21:14:57,177 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-10-09 21:14:57,224 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 57 at start it was 57
[junit] 2016-10-09 21:14:57,224 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testManyChildWatchersAutoReset
[junit] 2016-10-09 21:14:57,224 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testManyChildWatchersAutoReset
[junit] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 718.838 sec, Thread: 7, Class: org.apache.zookeeper.test.DisconnectedWatcherTest
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/build.xml:1207: Tests failed!
Total time: 15 minutes 39 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) ##############################
1 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:96)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
ZooKeeper-trunk-jdk8 - Build # 779 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/779/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 459879 lines...]
[junit] 2016-10-10 12:00:06,415 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:/127.0.0.1:19337:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:55783
[junit] 2016-10-10 12:00:06,416 [myid:] - WARN [NIOWorkerThread-7:NIOServerCnxn@369] - Exception causing close of session 0x0: ZooKeeperServer not running
[junit] 2016-10-10 12:00:06,416 [myid:] - INFO [NIOWorkerThread-7:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:55783 (no session established for client)
[junit] 2016-10-10 12:00:06,416 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1231] - Unable to read additional data from server sessionid 0x0, likely server has closed socket, closing socket connection and attempting reconnect
[junit] 2016-10-10 12:00:08,173 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:19337. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-10-10 12:00:08,174 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@948] - Socket connection established, initiating session, client: /127.0.0.1:55860, server: 127.0.0.1/127.0.0.1:19337
[junit] 2016-10-10 12:00:08,174 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:/127.0.0.1:19337:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:55860
[junit] 2016-10-10 12:00:08,174 [myid:] - WARN [NIOWorkerThread-8:NIOServerCnxn@369] - Exception causing close of session 0x0: ZooKeeperServer not running
[junit] 2016-10-10 12:00:08,174 [myid:] - INFO [NIOWorkerThread-8:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:55860 (no session established for client)
[junit] 2016-10-10 12:00:08,175 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1231] - Unable to read additional data from server sessionid 0x0, likely server has closed socket, closing socket connection and attempting reconnect
[junit] 2016-10-10 12:00:09,503 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:19337. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-10-10 12:00:09,504 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:/127.0.0.1:19337:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:55919
[junit] 2016-10-10 12:00:09,504 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@948] - Socket connection established, initiating session, client: /127.0.0.1:55919, server: 127.0.0.1/127.0.0.1:19337
[junit] 2016-10-10 12:00:09,504 [myid:] - WARN [NIOWorkerThread-9:NIOServerCnxn@369] - Exception causing close of session 0x0: ZooKeeperServer not running
[junit] 2016-10-10 12:00:09,504 [myid:] - INFO [NIOWorkerThread-9:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:55919 (no session established for client)
[junit] 2016-10-10 12:00:09,504 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1231] - Unable to read additional data from server sessionid 0x0, likely server has closed socket, closing socket connection and attempting reconnect
[junit] 2016-10-10 12:00:10,688 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:19337. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-10-10 12:00:10,688 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@948] - Socket connection established, initiating session, client: /127.0.0.1:55969, server: 127.0.0.1/127.0.0.1:19337
[junit] 2016-10-10 12:00:10,689 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:/127.0.0.1:19337:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:55969
[junit] 2016-10-10 12:00:10,689 [myid:] - WARN [NIOWorkerThread-10:NIOServerCnxn@369] - Exception causing close of session 0x0: ZooKeeperServer not running
[junit] 2016-10-10 12:00:10,689 [myid:] - INFO [NIOWorkerThread-10:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:55969 (no session established for client)
[junit] 2016-10-10 12:00:10,689 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1231] - Unable to read additional data from server sessionid 0x0, likely server has closed socket, closing socket connection and attempting reconnect
[junit] 2016-10-10 12:00:12,518 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:19337. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-10-10 12:00:12,518 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@948] - Socket connection established, initiating session, client: /127.0.0.1:56050, server: 127.0.0.1/127.0.0.1:19337
[junit] 2016-10-10 12:00:12,518 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:/127.0.0.1:19337:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:56050
[junit] 2016-10-10 12:00:12,519 [myid:] - WARN [NIOWorkerThread-11:NIOServerCnxn@369] - Exception causing close of session 0x0: ZooKeeperServer not running
[junit] 2016-10-10 12:00:12,519 [myid:] - INFO [NIOWorkerThread-11:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:56050 (no session established for client)
[junit] 2016-10-10 12:00:12,519 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1231] - Unable to read additional data from server sessionid 0x0, likely server has closed socket, closing socket connection and attempting reconnect
[junit] 2016-10-10 12:00:14,245 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:19337. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-10-10 12:00:14,246 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@948] - Socket connection established, initiating session, client: /127.0.0.1:56124, server: 127.0.0.1/127.0.0.1:19337
[junit] 2016-10-10 12:00:14,246 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:/127.0.0.1:19337:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:56124
[junit] 2016-10-10 12:00:14,247 [myid:] - WARN [NIOWorkerThread-12:NIOServerCnxn@369] - Exception causing close of session 0x0: ZooKeeperServer not running
[junit] 2016-10-10 12:00:14,247 [myid:] - INFO [NIOWorkerThread-12:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:56124 (no session established for client)
[junit] 2016-10-10 12:00:14,247 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1231] - Unable to read additional data from server sessionid 0x0, likely server has closed socket, closing socket connection and attempting reconnect
[junit] 2016-10-10 12:00:15,832 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:19337. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-10-10 12:00:15,833 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@948] - Socket connection established, initiating session, client: /127.0.0.1:56207, server: 127.0.0.1/127.0.0.1:19337
[junit] 2016-10-10 12:00:15,833 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:/127.0.0.1:19337:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:56207
[junit] 2016-10-10 12:00:15,833 [myid:] - WARN [NIOWorkerThread-13:NIOServerCnxn@369] - Exception causing close of session 0x0: ZooKeeperServer not running
[junit] 2016-10-10 12:00:15,834 [myid:] - INFO [NIOWorkerThread-13:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:56207 (no session established for client)
[junit] 2016-10-10 12:00:15,834 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1231] - Unable to read additional data from server sessionid 0x0, likely server has closed socket, closing socket connection and attempting reconnect
[junit] 2016-10-10 12:00:17,857 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:19337. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-10-10 12:00:17,858 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:/127.0.0.1:19337:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:56301
[junit] 2016-10-10 12:00:17,858 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@948] - Socket connection established, initiating session, client: /127.0.0.1:56301, server: 127.0.0.1/127.0.0.1:19337
[junit] 2016-10-10 12:00:17,858 [myid:] - WARN [NIOWorkerThread-14:NIOServerCnxn@369] - Exception causing close of session 0x0: ZooKeeperServer not running
[junit] 2016-10-10 12:00:17,858 [myid:] - INFO [NIOWorkerThread-14:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:56301 (no session established for client)
[junit] 2016-10-10 12:00:17,859 [myid:127.0.0.1:19337] - INFO [main-SendThread(127.0.0.1:19337):ClientCnxn$SendThread@1231] - Unable to read additional data from server sessionid 0x0, likely server has closed socket, closing socket connection and attempting reconnect
[junit] Running org.apache.zookeeper.server.quorum.ReconfigFailureCasesTest in thread 4
[junit] Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 0 sec, Thread: 4, Class: org.apache.zookeeper.server.quorum.ReconfigFailureCasesTest
[junit] Test org.apache.zookeeper.server.quorum.ReconfigFailureCasesTest FAILED (timeout)
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/build.xml:1207: Tests failed!
Total time: 16 minutes 38 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) ##############################
1 tests failed.
FAILED: org.apache.zookeeper.server.quorum.ReconfigFailureCasesTest.testLeaderTimesoutOnNewQuorum
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:745)