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/02/20 08:22:50 UTC

ZooKeeper-trunk-solaris - Build # 1514 - Still Failing

See https://builds.apache.org/job/ZooKeeper-trunk-solaris/1514/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 60.02 MB...]
    [junit] 2017-02-20 08:24:00,376 [myid:] - INFO  [main:ClientBase@376] - STARTING server instance 127.0.0.1:11222
    [junit] 2017-02-20 08:24:00,376 [myid:] - INFO  [main:ZooKeeperServer@908] - minSessionTimeout set to 6000
    [junit] 2017-02-20 08:24:00,377 [myid:] - INFO  [main:ZooKeeperServer@917] - maxSessionTimeout set to 60000
    [junit] 2017-02-20 08:24:00,377 [myid:] - INFO  [main:ZooKeeperServer@160] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test7453853958782576051.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test7453853958782576051.junit.dir/version-2
    [junit] 2017-02-20 08:24:00,377 [myid:] - INFO  [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test7453853958782576051.junit.dir/version-2/snapshot.b
    [junit] 2017-02-20 08:24:00,380 [myid:] - INFO  [main:FileTxnSnapLog@346] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test7453853958782576051.junit.dir/version-2/snapshot.b
    [junit] 2017-02-20 08:24:00,381 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-20 08:24:00,381 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-20 08:24:00,382 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:34214
    [junit] 2017-02-20 08:24:00,382 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:34214
    [junit] 2017-02-20 08:24:00,383 [myid:] - INFO  [NIOWorkerThread-1:StatCommand@49] - Stat command output
    [junit] 2017-02-20 08:24:00,383 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:34214 (no session established for client)
    [junit] 2017-02-20 08:24:00,383 [myid:] - INFO  [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2017-02-20 08:24:00,384 [myid:] - INFO  [main:JMXEnv@245] - expect:InMemoryDataTree
    [junit] 2017-02-20 08:24:00,385 [myid:] - INFO  [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
    [junit] 2017-02-20 08:24:00,385 [myid:] - INFO  [main:JMXEnv@245] - expect:StandaloneServer_port
    [junit] 2017-02-20 08:24:00,385 [myid:] - INFO  [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
    [junit] 2017-02-20 08:24:00,385 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17910
    [junit] 2017-02-20 08:24:00,385 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
    [junit] 2017-02-20 08:24:00,385 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
    [junit] 2017-02-20 08:24:00,386 [myid:] - INFO  [main:ClientBase@558] - tearDown starting
    [junit] 2017-02-20 08:24:00,462 [myid:] - INFO  [main:ZooKeeper@1324] - Session: 0x126d797a15b0000 closed
    [junit] 2017-02-20 08:24:00,462 [myid:] - INFO  [main:ClientBase@528] - STOPPING server
    [junit] 2017-02-20 08:24:00,462 [myid:] - INFO  [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x126d797a15b0000
    [junit] 2017-02-20 08:24:00,462 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
    [junit] 2017-02-20 08:24:00,462 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-20 08:24:00,462 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-20 08:24:00,462 [myid:] - INFO  [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
    [junit] 2017-02-20 08:24:00,463 [myid:] - INFO  [main:ZooKeeperServer@542] - shutting down
    [junit] 2017-02-20 08:24:00,463 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-20 08:24:00,463 [myid:] - INFO  [main:SessionTrackerImpl@232] - Shutting down
    [junit] 2017-02-20 08:24:00,463 [myid:] - INFO  [main:PrepRequestProcessor@1008] - Shutting down
    [junit] 2017-02-20 08:24:00,463 [myid:] - INFO  [main:SyncRequestProcessor@191] - Shutting down
    [junit] 2017-02-20 08:24:00,463 [myid:] - INFO  [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@157] - PrepRequestProcessor exited loop!
    [junit] 2017-02-20 08:24:00,463 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
    [junit] 2017-02-20 08:24:00,464 [myid:] - INFO  [main:FinalRequestProcessor@481] - shutdown of request processor complete
    [junit] 2017-02-20 08:24:00,464 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
    [junit] 2017-02-20 08:24:00,464 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
    [junit] 2017-02-20 08:24:00,464 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-20 08:24:00,465 [myid:] - INFO  [main:JMXEnv@146] - ensureOnly:[]
    [junit] 2017-02-20 08:24:00,469 [myid:] - INFO  [main:ClientBase@583] - fdcount after test is: 60 at start it was 43
    [junit] 2017-02-20 08:24:00,469 [myid:] - INFO  [main:ClientBase@585] - sleeping for 20 secs
    [junit] 2017-02-20 08:24:00,470 [myid:] - INFO  [main:ZKTestCase$1@65] - SUCCEEDED testQuota
    [junit] 2017-02-20 08:24:00,470 [myid:] - INFO  [main:ZKTestCase$1@60] - FINISHED testQuota
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.163 sec

fail.build.on.test.failure:

BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1242: The following error occurred while executing this line:
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1216: Tests failed!

Total time: 67 minutes 45 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
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.test.ReconfigTest.testPortChangeToBlockedPortLeader

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:719)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)


FAILED:  org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:715)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)



ZooKeeper-trunk-solaris - Build # 1521 - Still Failing

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-solaris/1521/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 66.05 MB...]
    [junit] 2017-02-27 08:35:35,776 [myid:] - INFO  [main:ClientBase@376] - STARTING server instance 127.0.0.1:11222
    [junit] 2017-02-27 08:35:35,776 [myid:] - INFO  [main:ZooKeeperServer@908] - minSessionTimeout set to 6000
    [junit] 2017-02-27 08:35:35,776 [myid:] - INFO  [main:ZooKeeperServer@917] - maxSessionTimeout set to 60000
    [junit] 2017-02-27 08:35:35,776 [myid:] - INFO  [main:ZooKeeperServer@160] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test6609383126355056909.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test6609383126355056909.junit.dir/version-2
    [junit] 2017-02-27 08:35:35,777 [myid:] - INFO  [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test6609383126355056909.junit.dir/version-2/snapshot.b
    [junit] 2017-02-27 08:35:35,779 [myid:] - INFO  [main:FileTxnSnapLog@346] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test6609383126355056909.junit.dir/version-2/snapshot.b
    [junit] 2017-02-27 08:35:35,780 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-27 08:35:35,780 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-27 08:35:35,781 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:54613
    [junit] 2017-02-27 08:35:35,781 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:54613
    [junit] 2017-02-27 08:35:35,782 [myid:] - INFO  [NIOWorkerThread-1:StatCommand@49] - Stat command output
    [junit] 2017-02-27 08:35:35,782 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:54613 (no session established for client)
    [junit] 2017-02-27 08:35:35,782 [myid:] - INFO  [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2017-02-27 08:35:35,783 [myid:] - INFO  [main:JMXEnv@245] - expect:InMemoryDataTree
    [junit] 2017-02-27 08:35:35,784 [myid:] - INFO  [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
    [junit] 2017-02-27 08:35:35,784 [myid:] - INFO  [main:JMXEnv@245] - expect:StandaloneServer_port
    [junit] 2017-02-27 08:35:35,784 [myid:] - INFO  [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
    [junit] 2017-02-27 08:35:35,784 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17907
    [junit] 2017-02-27 08:35:35,784 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
    [junit] 2017-02-27 08:35:35,785 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
    [junit] 2017-02-27 08:35:35,785 [myid:] - INFO  [main:ClientBase@558] - tearDown starting
    [junit] 2017-02-27 08:35:35,862 [myid:] - INFO  [main:ZooKeeper@1324] - Session: 0x126fbaeaa420000 closed
    [junit] 2017-02-27 08:35:35,862 [myid:] - INFO  [main:ClientBase@528] - STOPPING server
    [junit] 2017-02-27 08:35:35,862 [myid:] - INFO  [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x126fbaeaa420000
    [junit] 2017-02-27 08:35:35,862 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-27 08:35:35,862 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-27 08:35:35,862 [myid:] - INFO  [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
    [junit] 2017-02-27 08:35:35,862 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
    [junit] 2017-02-27 08:35:35,863 [myid:] - INFO  [main:ZooKeeperServer@542] - shutting down
    [junit] 2017-02-27 08:35:35,863 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-27 08:35:35,863 [myid:] - INFO  [main:SessionTrackerImpl@232] - Shutting down
    [junit] 2017-02-27 08:35:35,864 [myid:] - INFO  [main:PrepRequestProcessor@1008] - Shutting down
    [junit] 2017-02-27 08:35:35,864 [myid:] - INFO  [main:SyncRequestProcessor@191] - Shutting down
    [junit] 2017-02-27 08:35:35,864 [myid:] - INFO  [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@157] - PrepRequestProcessor exited loop!
    [junit] 2017-02-27 08:35:35,864 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
    [junit] 2017-02-27 08:35:35,864 [myid:] - INFO  [main:FinalRequestProcessor@481] - shutdown of request processor complete
    [junit] 2017-02-27 08:35:35,864 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
    [junit] 2017-02-27 08:35:35,865 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
    [junit] 2017-02-27 08:35:35,865 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-27 08:35:35,865 [myid:] - INFO  [main:JMXEnv@146] - ensureOnly:[]
    [junit] 2017-02-27 08:35:35,870 [myid:] - INFO  [main:ClientBase@583] - fdcount after test is: 60 at start it was 43
    [junit] 2017-02-27 08:35:35,870 [myid:] - INFO  [main:ClientBase@585] - sleeping for 20 secs
    [junit] 2017-02-27 08:35:36,031 [myid:] - INFO  [main:ZKTestCase$1@65] - SUCCEEDED testQuota
    [junit] 2017-02-27 08:35:36,031 [myid:] - INFO  [main:ZKTestCase$1@60] - FINISHED testQuota
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.097 sec

fail.build.on.test.failure:

BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1242: The following error occurred while executing this line:
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1216: Tests failed!

Total time: 76 minutes 14 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
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.ReconfigTest.testJMXBeanAfterRoleChange

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.



ZooKeeper-trunk-solaris - Build # 1520 - Still Failing

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-solaris/1520/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 60.38 MB...]
    [junit] 2017-02-26 09:00:11,007 [myid:] - INFO  [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2017-02-26 09:00:11,009 [myid:] - INFO  [main:JMXEnv@245] - expect:InMemoryDataTree
    [junit] 2017-02-26 09:00:11,009 [myid:] - INFO  [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
    [junit] 2017-02-26 09:00:11,009 [myid:] - INFO  [main:JMXEnv@245] - expect:StandaloneServer_port
    [junit] 2017-02-26 09:00:11,009 [myid:] - INFO  [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
    [junit] 2017-02-26 09:00:11,009 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17907
    [junit] 2017-02-26 09:00:11,010 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
    [junit] 2017-02-26 09:00:11,010 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
    [junit] 2017-02-26 09:00:11,010 [myid:] - INFO  [main:ClientBase@558] - tearDown starting
    [junit] 2017-02-26 09:00:11,261 [myid:] - INFO  [SessionTracker:SessionTrackerImpl@158] - SessionTrackerImpl exited loop!
    [junit] 2017-02-26 09:00:11,261 [myid:] - INFO  [SessionTracker:SessionTrackerImpl@158] - SessionTrackerImpl exited loop!
    [junit] 2017-02-26 09:00:12,471 [myid:127.0.0.1:11222] - INFO  [main-SendThread(127.0.0.1:11222):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:11222. Will not attempt to authenticate using SASL (unknown error)
    [junit] 2017-02-26 09:00:12,471 [myid:127.0.0.1:11222] - INFO  [main-SendThread(127.0.0.1:11222):ClientCnxn$SendThread@948] - Socket connection established, initiating session, client: null, server: null
    [junit] 2017-02-26 09:00:12,471 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:59404
    [junit] 2017-02-26 09:00:12,473 [myid:] - INFO  [NIOWorkerThread-2:ZooKeeperServer@1019] - Client attempting to renew session 0x126f69ed1d10000 at /127.0.0.1:59404
    [junit] 2017-02-26 09:00:12,473 [myid:] - INFO  [NIOWorkerThread-2:ZooKeeperServer@728] - Established session 0x126f69ed1d10000 with negotiated timeout 30000 for client /127.0.0.1:59404
    [junit] 2017-02-26 09:00:12,474 [myid:127.0.0.1:11222] - INFO  [main-SendThread(127.0.0.1:11222):ClientCnxn$SendThread@1381] - Session establishment complete on server null, sessionid = 0x126f69ed1d10000, negotiated timeout = 30000
    [junit] 2017-02-26 09:00:12,475 [myid:] - INFO  [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@617] - Processed session termination for sessionid: 0x126f69ed1d10000
    [junit] 2017-02-26 09:00:12,475 [myid:] - INFO  [SyncThread:0:FileTxnLog@204] - Creating new log file: log.c
    [junit] 2017-02-26 09:00:12,477 [myid:] - INFO  [NIOWorkerThread-5:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=Connections,name2=127.0.0.1,name3=0x126f69ed1d10000]
    [junit] 2017-02-26 09:00:12,478 [myid:] - INFO  [NIOWorkerThread-5:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:59404 which had sessionid 0x126f69ed1d10000
    [junit] 2017-02-26 09:00:12,478 [myid:] - INFO  [main:ZooKeeper@1324] - Session: 0x126f69ed1d10000 closed
    [junit] 2017-02-26 09:00:12,478 [myid:] - INFO  [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x126f69ed1d10000
    [junit] 2017-02-26 09:00:12,478 [myid:] - INFO  [main:ClientBase@528] - STOPPING server
    [junit] 2017-02-26 09:00:12,479 [myid:] - INFO  [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
    [junit] 2017-02-26 09:00:12,479 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-26 09:00:12,479 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
    [junit] 2017-02-26 09:00:12,479 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-26 09:00:12,480 [myid:] - INFO  [main:ZooKeeperServer@542] - shutting down
    [junit] 2017-02-26 09:00:12,480 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-26 09:00:12,480 [myid:] - INFO  [main:SessionTrackerImpl@232] - Shutting down
    [junit] 2017-02-26 09:00:12,480 [myid:] - INFO  [main:PrepRequestProcessor@1008] - Shutting down
    [junit] 2017-02-26 09:00:12,481 [myid:] - INFO  [main:SyncRequestProcessor@191] - Shutting down
    [junit] 2017-02-26 09:00:12,481 [myid:] - INFO  [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@157] - PrepRequestProcessor exited loop!
    [junit] 2017-02-26 09:00:12,481 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
    [junit] 2017-02-26 09:00:12,481 [myid:] - INFO  [main:FinalRequestProcessor@481] - shutdown of request processor complete
    [junit] 2017-02-26 09:00:12,481 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
    [junit] 2017-02-26 09:00:12,482 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
    [junit] 2017-02-26 09:00:12,482 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-26 09:00:12,483 [myid:] - INFO  [main:JMXEnv@146] - ensureOnly:[]
    [junit] 2017-02-26 09:00:12,551 [myid:] - INFO  [main:ClientBase@583] - fdcount after test is: 60 at start it was 43
    [junit] 2017-02-26 09:00:12,552 [myid:] - INFO  [main:ClientBase@585] - sleeping for 20 secs
    [junit] 2017-02-26 09:00:12,578 [myid:] - INFO  [main:ZKTestCase$1@65] - SUCCEEDED testQuota
    [junit] 2017-02-26 09:00:12,578 [myid:] - INFO  [main:ZKTestCase$1@60] - FINISHED testQuota
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 14.298 sec

fail.build.on.test.failure:

BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1242: The following error occurred while executing this line:
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1216: Tests failed!

Total time: 102 minutes 28 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
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.server.quorum.Zab1_0Test.testNormalObserverRun

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.


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)


FAILED:  org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:719)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)


FAILED:  org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:715)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)



ZooKeeper-trunk-solaris - Build # 1519 - Still Failing

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-solaris/1519/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 58.90 MB...]
    [junit] 2017-02-25 08:26:26,381 [myid:] - INFO  [main:ClientBase@376] - STARTING server instance 127.0.0.1:11222
    [junit] 2017-02-25 08:26:26,382 [myid:] - INFO  [main:ZooKeeperServer@908] - minSessionTimeout set to 6000
    [junit] 2017-02-25 08:26:26,382 [myid:] - INFO  [main:ZooKeeperServer@917] - maxSessionTimeout set to 60000
    [junit] 2017-02-25 08:26:26,382 [myid:] - INFO  [main:ZooKeeperServer@160] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test2323635937556005077.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test2323635937556005077.junit.dir/version-2
    [junit] 2017-02-25 08:26:26,383 [myid:] - INFO  [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test2323635937556005077.junit.dir/version-2/snapshot.b
    [junit] 2017-02-25 08:26:26,385 [myid:] - INFO  [main:FileTxnSnapLog@346] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test2323635937556005077.junit.dir/version-2/snapshot.b
    [junit] 2017-02-25 08:26:26,386 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-25 08:26:26,386 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-25 08:26:26,387 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:42161
    [junit] 2017-02-25 08:26:26,387 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:42161
    [junit] 2017-02-25 08:26:26,388 [myid:] - INFO  [NIOWorkerThread-1:StatCommand@49] - Stat command output
    [junit] 2017-02-25 08:26:26,388 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:42161 (no session established for client)
    [junit] 2017-02-25 08:26:26,388 [myid:] - INFO  [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2017-02-25 08:26:26,389 [myid:] - INFO  [main:JMXEnv@245] - expect:InMemoryDataTree
    [junit] 2017-02-25 08:26:26,390 [myid:] - INFO  [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
    [junit] 2017-02-25 08:26:26,390 [myid:] - INFO  [main:JMXEnv@245] - expect:StandaloneServer_port
    [junit] 2017-02-25 08:26:26,390 [myid:] - INFO  [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
    [junit] 2017-02-25 08:26:26,390 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17906
    [junit] 2017-02-25 08:26:26,390 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
    [junit] 2017-02-25 08:26:26,391 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
    [junit] 2017-02-25 08:26:26,391 [myid:] - INFO  [main:ClientBase@558] - tearDown starting
    [junit] 2017-02-25 08:26:26,472 [myid:] - INFO  [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x126f15998100000
    [junit] 2017-02-25 08:26:26,472 [myid:] - INFO  [main:ZooKeeper@1324] - Session: 0x126f15998100000 closed
    [junit] 2017-02-25 08:26:26,473 [myid:] - INFO  [main:ClientBase@528] - STOPPING server
    [junit] 2017-02-25 08:26:26,473 [myid:] - INFO  [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
    [junit] 2017-02-25 08:26:26,473 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-25 08:26:26,473 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
    [junit] 2017-02-25 08:26:26,473 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-25 08:26:26,473 [myid:] - INFO  [main:ZooKeeperServer@542] - shutting down
    [junit] 2017-02-25 08:26:26,474 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-25 08:26:26,474 [myid:] - INFO  [main:SessionTrackerImpl@232] - Shutting down
    [junit] 2017-02-25 08:26:26,474 [myid:] - INFO  [main:PrepRequestProcessor@1008] - Shutting down
    [junit] 2017-02-25 08:26:26,474 [myid:] - INFO  [main:SyncRequestProcessor@191] - Shutting down
    [junit] 2017-02-25 08:26:26,474 [myid:] - INFO  [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@157] - PrepRequestProcessor exited loop!
    [junit] 2017-02-25 08:26:26,474 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
    [junit] 2017-02-25 08:26:26,475 [myid:] - INFO  [main:FinalRequestProcessor@481] - shutdown of request processor complete
    [junit] 2017-02-25 08:26:26,475 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
    [junit] 2017-02-25 08:26:26,475 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
    [junit] 2017-02-25 08:26:26,475 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-25 08:26:26,476 [myid:] - INFO  [main:JMXEnv@146] - ensureOnly:[]
    [junit] 2017-02-25 08:26:26,480 [myid:] - INFO  [main:ClientBase@583] - fdcount after test is: 60 at start it was 43
    [junit] 2017-02-25 08:26:26,480 [myid:] - INFO  [main:ClientBase@585] - sleeping for 20 secs
    [junit] 2017-02-25 08:26:26,482 [myid:] - INFO  [main:ZKTestCase$1@65] - SUCCEEDED testQuota
    [junit] 2017-02-25 08:26:26,482 [myid:] - INFO  [main:ZKTestCase$1@60] - FINISHED testQuota
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.937 sec

fail.build.on.test.failure:

BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1242: The following error occurred while executing this line:
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1216: Tests failed!

Total time: 68 minutes 51 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
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.test.ReconfigTest.testPortChangeToBlockedPortLeader

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:719)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)


FAILED:  org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:715)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)



ZooKeeper-trunk-solaris - Build # 1518 - Still Failing

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-solaris/1518/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 60.62 MB...]
    [junit] 2017-02-24 08:47:35,268 [myid:] - INFO  [main:ClientBase@376] - STARTING server instance 127.0.0.1:11222
    [junit] 2017-02-24 08:47:35,268 [myid:] - INFO  [main:ZooKeeperServer@908] - minSessionTimeout set to 6000
    [junit] 2017-02-24 08:47:35,268 [myid:] - INFO  [main:ZooKeeperServer@917] - maxSessionTimeout set to 60000
    [junit] 2017-02-24 08:47:35,268 [myid:] - INFO  [main:ZooKeeperServer@160] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test6433130690732192384.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test6433130690732192384.junit.dir/version-2
    [junit] 2017-02-24 08:47:35,269 [myid:] - INFO  [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test6433130690732192384.junit.dir/version-2/snapshot.b
    [junit] 2017-02-24 08:47:35,271 [myid:] - INFO  [main:FileTxnSnapLog@346] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test6433130690732192384.junit.dir/version-2/snapshot.b
    [junit] 2017-02-24 08:47:35,272 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-24 08:47:35,273 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-24 08:47:35,273 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:59813
    [junit] 2017-02-24 08:47:35,273 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:59813
    [junit] 2017-02-24 08:47:35,274 [myid:] - INFO  [NIOWorkerThread-1:StatCommand@49] - Stat command output
    [junit] 2017-02-24 08:47:35,274 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:59813 (no session established for client)
    [junit] 2017-02-24 08:47:35,274 [myid:] - INFO  [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2017-02-24 08:47:35,276 [myid:] - INFO  [main:JMXEnv@245] - expect:InMemoryDataTree
    [junit] 2017-02-24 08:47:35,276 [myid:] - INFO  [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
    [junit] 2017-02-24 08:47:35,276 [myid:] - INFO  [main:JMXEnv@245] - expect:StandaloneServer_port
    [junit] 2017-02-24 08:47:35,276 [myid:] - INFO  [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
    [junit] 2017-02-24 08:47:35,276 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 18142
    [junit] 2017-02-24 08:47:35,277 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
    [junit] 2017-02-24 08:47:35,277 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
    [junit] 2017-02-24 08:47:35,277 [myid:] - INFO  [main:ClientBase@558] - tearDown starting
    [junit] 2017-02-24 08:47:35,352 [myid:] - INFO  [main:ZooKeeper@1324] - Session: 0x126ec469fbb0000 closed
    [junit] 2017-02-24 08:47:35,352 [myid:] - INFO  [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x126ec469fbb0000
    [junit] 2017-02-24 08:47:35,352 [myid:] - INFO  [main:ClientBase@528] - STOPPING server
    [junit] 2017-02-24 08:47:35,353 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
    [junit] 2017-02-24 08:47:35,353 [myid:] - INFO  [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
    [junit] 2017-02-24 08:47:35,353 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-24 08:47:35,353 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-24 08:47:35,353 [myid:] - INFO  [main:ZooKeeperServer@542] - shutting down
    [junit] 2017-02-24 08:47:35,353 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-24 08:47:35,354 [myid:] - INFO  [main:SessionTrackerImpl@232] - Shutting down
    [junit] 2017-02-24 08:47:35,354 [myid:] - INFO  [main:PrepRequestProcessor@1008] - Shutting down
    [junit] 2017-02-24 08:47:35,354 [myid:] - INFO  [main:SyncRequestProcessor@191] - Shutting down
    [junit] 2017-02-24 08:47:35,354 [myid:] - INFO  [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@157] - PrepRequestProcessor exited loop!
    [junit] 2017-02-24 08:47:35,354 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
    [junit] 2017-02-24 08:47:35,354 [myid:] - INFO  [main:FinalRequestProcessor@481] - shutdown of request processor complete
    [junit] 2017-02-24 08:47:35,355 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
    [junit] 2017-02-24 08:47:35,355 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
    [junit] 2017-02-24 08:47:35,355 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-24 08:47:35,355 [myid:] - INFO  [main:JMXEnv@146] - ensureOnly:[]
    [junit] 2017-02-24 08:47:35,360 [myid:] - INFO  [main:ClientBase@583] - fdcount after test is: 60 at start it was 43
    [junit] 2017-02-24 08:47:35,360 [myid:] - INFO  [main:ClientBase@585] - sleeping for 20 secs
    [junit] 2017-02-24 08:47:35,361 [myid:] - INFO  [main:ZKTestCase$1@65] - SUCCEEDED testQuota
    [junit] 2017-02-24 08:47:35,362 [myid:] - INFO  [main:ZKTestCase$1@60] - FINISHED testQuota
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.996 sec

fail.build.on.test.failure:

BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1242: The following error occurred while executing this line:
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1216: Tests failed!

Total time: 90 minutes 10 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any



###################################################################################
############################## FAILED TESTS (if any) ##############################
5 tests failed.
FAILED:  org.apache.zookeeper.test.NioNettySuiteTest.testJMXBeanAfterRoleChange

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.


FAILED:  org.apache.zookeeper.test.WatchEventWhenAutoResetTest.testNodeDataChanged

Error Message:
expected:<NodeDataChanged> but was:<NodeDeleted>

Stack Trace:
junit.framework.AssertionFailedError: expected:<NodeDataChanged> but was:<NodeDeleted>
	at org.apache.zookeeper.test.WatchEventWhenAutoResetTest$EventsWatcher.assertEvent(WatchEventWhenAutoResetTest.java:67)
	at org.apache.zookeeper.test.WatchEventWhenAutoResetTest.testNodeDataChanged(WatchEventWhenAutoResetTest.java:126)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)


FAILED:  org.apache.zookeeper.server.quorum.Zab1_0Test.testNormalObserverRun

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.


FAILED:  org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:719)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)


FAILED:  org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:715)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)



ZooKeeper-trunk-solaris - Build # 1517 - Still Failing

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-solaris/1517/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 58.60 MB...]
    [junit] 2017-02-23 08:39:05,558 [myid:] - INFO  [main:ClientBase@376] - STARTING server instance 127.0.0.1:11222
    [junit] 2017-02-23 08:39:05,559 [myid:] - INFO  [main:ZooKeeperServer@908] - minSessionTimeout set to 6000
    [junit] 2017-02-23 08:39:05,559 [myid:] - INFO  [main:ZooKeeperServer@917] - maxSessionTimeout set to 60000
    [junit] 2017-02-23 08:39:05,559 [myid:] - INFO  [main:ZooKeeperServer@160] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test6452893461893143809.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test6452893461893143809.junit.dir/version-2
    [junit] 2017-02-23 08:39:05,560 [myid:] - INFO  [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test6452893461893143809.junit.dir/version-2/snapshot.b
    [junit] 2017-02-23 08:39:05,562 [myid:] - INFO  [main:FileTxnSnapLog@346] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test6452893461893143809.junit.dir/version-2/snapshot.b
    [junit] 2017-02-23 08:39:05,563 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-23 08:39:05,563 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-23 08:39:05,564 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:44975
    [junit] 2017-02-23 08:39:05,564 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:44975
    [junit] 2017-02-23 08:39:05,565 [myid:] - INFO  [NIOWorkerThread-1:StatCommand@49] - Stat command output
    [junit] 2017-02-23 08:39:05,565 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:44975 (no session established for client)
    [junit] 2017-02-23 08:39:05,565 [myid:] - INFO  [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2017-02-23 08:39:05,566 [myid:] - INFO  [main:JMXEnv@245] - expect:InMemoryDataTree
    [junit] 2017-02-23 08:39:05,566 [myid:] - INFO  [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
    [junit] 2017-02-23 08:39:05,567 [myid:] - INFO  [main:JMXEnv@245] - expect:StandaloneServer_port
    [junit] 2017-02-23 08:39:05,567 [myid:] - INFO  [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
    [junit] 2017-02-23 08:39:05,567 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17905
    [junit] 2017-02-23 08:39:05,567 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
    [junit] 2017-02-23 08:39:05,567 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
    [junit] 2017-02-23 08:39:05,567 [myid:] - INFO  [main:ClientBase@558] - tearDown starting
    [junit] 2017-02-23 08:39:05,642 [myid:] - INFO  [main:ZooKeeper@1324] - Session: 0x126e7187d520000 closed
    [junit] 2017-02-23 08:39:05,642 [myid:] - INFO  [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x126e7187d520000
    [junit] 2017-02-23 08:39:05,642 [myid:] - INFO  [main:ClientBase@528] - STOPPING server
    [junit] 2017-02-23 08:39:05,643 [myid:] - INFO  [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
    [junit] 2017-02-23 08:39:05,643 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-23 08:39:05,643 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-23 08:39:05,643 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
    [junit] 2017-02-23 08:39:05,643 [myid:] - INFO  [main:ZooKeeperServer@542] - shutting down
    [junit] 2017-02-23 08:39:05,643 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-23 08:39:05,644 [myid:] - INFO  [main:SessionTrackerImpl@232] - Shutting down
    [junit] 2017-02-23 08:39:05,644 [myid:] - INFO  [main:PrepRequestProcessor@1008] - Shutting down
    [junit] 2017-02-23 08:39:05,644 [myid:] - INFO  [main:SyncRequestProcessor@191] - Shutting down
    [junit] 2017-02-23 08:39:05,644 [myid:] - INFO  [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@157] - PrepRequestProcessor exited loop!
    [junit] 2017-02-23 08:39:05,644 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
    [junit] 2017-02-23 08:39:05,644 [myid:] - INFO  [main:FinalRequestProcessor@481] - shutdown of request processor complete
    [junit] 2017-02-23 08:39:05,644 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
    [junit] 2017-02-23 08:39:05,645 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
    [junit] 2017-02-23 08:39:05,645 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-23 08:39:05,645 [myid:] - INFO  [main:JMXEnv@146] - ensureOnly:[]
    [junit] 2017-02-23 08:39:05,659 [myid:] - INFO  [main:ClientBase@583] - fdcount after test is: 60 at start it was 43
    [junit] 2017-02-23 08:39:05,659 [myid:] - INFO  [main:ClientBase@585] - sleeping for 20 secs
    [junit] 2017-02-23 08:39:05,661 [myid:] - INFO  [main:ZKTestCase$1@65] - SUCCEEDED testQuota
    [junit] 2017-02-23 08:39:05,661 [myid:] - INFO  [main:ZKTestCase$1@60] - FINISHED testQuota
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.832 sec

fail.build.on.test.failure:

BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1242: The following error occurred while executing this line:
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1216: Tests failed!

Total time: 82 minutes 36 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
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.server.quorum.Zab1_0Test.testNormalObserverRun

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.


FAILED:  org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:719)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)


FAILED:  org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:715)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)



ZooKeeper-trunk-solaris - Build # 1516 - Still Failing

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-solaris/1516/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 58.63 MB...]
    [junit] 2017-02-22 08:23:10,328 [myid:] - INFO  [main:ClientBase@376] - STARTING server instance 127.0.0.1:11222
    [junit] 2017-02-22 08:23:10,328 [myid:] - INFO  [main:ZooKeeperServer@908] - minSessionTimeout set to 6000
    [junit] 2017-02-22 08:23:10,329 [myid:] - INFO  [main:ZooKeeperServer@917] - maxSessionTimeout set to 60000
    [junit] 2017-02-22 08:23:10,329 [myid:] - INFO  [main:ZooKeeperServer@160] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test8864537983339373962.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test8864537983339373962.junit.dir/version-2
    [junit] 2017-02-22 08:23:10,329 [myid:] - INFO  [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test8864537983339373962.junit.dir/version-2/snapshot.b
    [junit] 2017-02-22 08:23:10,332 [myid:] - INFO  [main:FileTxnSnapLog@346] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test8864537983339373962.junit.dir/version-2/snapshot.b
    [junit] 2017-02-22 08:23:10,333 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-22 08:23:10,333 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-22 08:23:10,333 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:63787
    [junit] 2017-02-22 08:23:10,334 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:63787
    [junit] 2017-02-22 08:23:10,334 [myid:] - INFO  [NIOWorkerThread-1:StatCommand@49] - Stat command output
    [junit] 2017-02-22 08:23:10,335 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:63787 (no session established for client)
    [junit] 2017-02-22 08:23:10,335 [myid:] - INFO  [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2017-02-22 08:23:10,336 [myid:] - INFO  [main:JMXEnv@245] - expect:InMemoryDataTree
    [junit] 2017-02-22 08:23:10,337 [myid:] - INFO  [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
    [junit] 2017-02-22 08:23:10,337 [myid:] - INFO  [main:JMXEnv@245] - expect:StandaloneServer_port
    [junit] 2017-02-22 08:23:10,337 [myid:] - INFO  [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
    [junit] 2017-02-22 08:23:10,337 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17913
    [junit] 2017-02-22 08:23:10,337 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
    [junit] 2017-02-22 08:23:10,337 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
    [junit] 2017-02-22 08:23:10,338 [myid:] - INFO  [main:ClientBase@558] - tearDown starting
    [junit] 2017-02-22 08:23:10,412 [myid:] - INFO  [main:ZooKeeper@1324] - Session: 0x126e1e38fa70000 closed
    [junit] 2017-02-22 08:23:10,412 [myid:] - INFO  [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x126e1e38fa70000
    [junit] 2017-02-22 08:23:10,412 [myid:] - INFO  [main:ClientBase@528] - STOPPING server
    [junit] 2017-02-22 08:23:10,412 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-22 08:23:10,413 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-22 08:23:10,412 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
    [junit] 2017-02-22 08:23:10,412 [myid:] - INFO  [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
    [junit] 2017-02-22 08:23:10,413 [myid:] - INFO  [main:ZooKeeperServer@542] - shutting down
    [junit] 2017-02-22 08:23:10,413 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-22 08:23:10,413 [myid:] - INFO  [main:SessionTrackerImpl@232] - Shutting down
    [junit] 2017-02-22 08:23:10,414 [myid:] - INFO  [main:PrepRequestProcessor@1008] - Shutting down
    [junit] 2017-02-22 08:23:10,414 [myid:] - INFO  [main:SyncRequestProcessor@191] - Shutting down
    [junit] 2017-02-22 08:23:10,414 [myid:] - INFO  [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@157] - PrepRequestProcessor exited loop!
    [junit] 2017-02-22 08:23:10,414 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
    [junit] 2017-02-22 08:23:10,414 [myid:] - INFO  [main:FinalRequestProcessor@481] - shutdown of request processor complete
    [junit] 2017-02-22 08:23:10,414 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
    [junit] 2017-02-22 08:23:10,415 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
    [junit] 2017-02-22 08:23:10,415 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-22 08:23:10,415 [myid:] - INFO  [main:JMXEnv@146] - ensureOnly:[]
    [junit] 2017-02-22 08:23:10,420 [myid:] - INFO  [main:ClientBase@583] - fdcount after test is: 60 at start it was 43
    [junit] 2017-02-22 08:23:10,420 [myid:] - INFO  [main:ClientBase@585] - sleeping for 20 secs
    [junit] 2017-02-22 08:23:10,421 [myid:] - INFO  [main:ZKTestCase$1@65] - SUCCEEDED testQuota
    [junit] 2017-02-22 08:23:10,421 [myid:] - INFO  [main:ZKTestCase$1@60] - FINISHED testQuota
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 2.576 sec

fail.build.on.test.failure:

BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1242: The following error occurred while executing this line:
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1216: Tests failed!

Total time: 65 minutes 46 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any



###################################################################################
############################## FAILED TESTS (if any) ##############################
10 tests failed.
FAILED:  org.apache.zookeeper.test.WatcherTest.testWatchAutoResetWithPending

Error Message:
Unexpected bean exists! expected:<0> but was:<1>

Stack Trace:
junit.framework.AssertionFailedError: Unexpected bean exists! expected:<0> but was:<1>
	at org.apache.zookeeper.test.ClientBase.verifyUnexpectedBeans(ClientBase.java:513)
	at org.apache.zookeeper.test.ClientBase.startServer(ClientBase.java:492)
	at org.apache.zookeeper.test.ClientBase.setUp(ClientBase.java:475)
	at org.apache.zookeeper.test.WatcherTest.setUp(WatcherTest.java:76)


FAILED:  org.apache.zookeeper.test.WatcherTest.testWatcherCorrectness

Error Message:
Unexpected bean exists! expected:<0> but was:<1>

Stack Trace:
junit.framework.AssertionFailedError: Unexpected bean exists! expected:<0> but was:<1>
	at org.apache.zookeeper.test.ClientBase.verifyUnexpectedBeans(ClientBase.java:513)
	at org.apache.zookeeper.test.ClientBase.startServer(ClientBase.java:492)
	at org.apache.zookeeper.test.ClientBase.setUp(ClientBase.java:475)
	at org.apache.zookeeper.test.WatcherTest.setUp(WatcherTest.java:76)


FAILED:  org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetDisabledWithLocal

Error Message:
Unexpected bean exists! expected:<0> but was:<1>

Stack Trace:
junit.framework.AssertionFailedError: Unexpected bean exists! expected:<0> but was:<1>
	at org.apache.zookeeper.test.ClientBase.verifyUnexpectedBeans(ClientBase.java:513)
	at org.apache.zookeeper.test.ClientBase.startServer(ClientBase.java:492)
	at org.apache.zookeeper.test.ClientBase.setUp(ClientBase.java:475)
	at org.apache.zookeeper.test.WatcherTest.setUp(WatcherTest.java:76)


FAILED:  org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetWithGlobal

Error Message:
Unexpected bean exists! expected:<0> but was:<1>

Stack Trace:
junit.framework.AssertionFailedError: Unexpected bean exists! expected:<0> but was:<1>
	at org.apache.zookeeper.test.ClientBase.verifyUnexpectedBeans(ClientBase.java:513)
	at org.apache.zookeeper.test.ClientBase.startServer(ClientBase.java:492)
	at org.apache.zookeeper.test.ClientBase.setUp(ClientBase.java:475)
	at org.apache.zookeeper.test.WatcherTest.setUp(WatcherTest.java:76)


FAILED:  org.apache.zookeeper.test.WatcherTest.testWatcherCount

Error Message:
Unexpected bean exists! expected:<0> but was:<1>

Stack Trace:
junit.framework.AssertionFailedError: Unexpected bean exists! expected:<0> but was:<1>
	at org.apache.zookeeper.test.ClientBase.verifyUnexpectedBeans(ClientBase.java:513)
	at org.apache.zookeeper.test.ClientBase.startServer(ClientBase.java:492)
	at org.apache.zookeeper.test.ClientBase.setUp(ClientBase.java:475)
	at org.apache.zookeeper.test.WatcherTest.setUp(WatcherTest.java:76)


FAILED:  org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetDisabledWithGlobal

Error Message:
Unexpected bean exists! expected:<0> but was:<1>

Stack Trace:
junit.framework.AssertionFailedError: Unexpected bean exists! expected:<0> but was:<1>
	at org.apache.zookeeper.test.ClientBase.verifyUnexpectedBeans(ClientBase.java:513)
	at org.apache.zookeeper.test.ClientBase.startServer(ClientBase.java:492)
	at org.apache.zookeeper.test.ClientBase.setUp(ClientBase.java:475)
	at org.apache.zookeeper.test.WatcherTest.setUp(WatcherTest.java:76)


FAILED:  org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetWithLocal

Error Message:
Unexpected bean exists! expected:<0> but was:<1>

Stack Trace:
junit.framework.AssertionFailedError: Unexpected bean exists! expected:<0> but was:<1>
	at org.apache.zookeeper.test.ClientBase.verifyUnexpectedBeans(ClientBase.java:513)
	at org.apache.zookeeper.test.ClientBase.startServer(ClientBase.java:492)
	at org.apache.zookeeper.test.ClientBase.setUp(ClientBase.java:475)
	at org.apache.zookeeper.test.WatcherTest.setUp(WatcherTest.java:76)


FAILED:  org.apache.zookeeper.test.WatchEventWhenAutoResetTest.testNodeDataChanged

Error Message:
expected:<NodeDataChanged> but was:<NodeDeleted>

Stack Trace:
junit.framework.AssertionFailedError: expected:<NodeDataChanged> but was:<NodeDeleted>
	at org.apache.zookeeper.test.WatchEventWhenAutoResetTest$EventsWatcher.assertEvent(WatchEventWhenAutoResetTest.java:67)
	at org.apache.zookeeper.test.WatchEventWhenAutoResetTest.testNodeDataChanged(WatchEventWhenAutoResetTest.java:117)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)


FAILED:  org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:719)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)


FAILED:  org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:715)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)



ZooKeeper-trunk-solaris - Build # 1515 - Still Failing

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-solaris/1515/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 59.99 MB...]
    [junit] 2017-02-21 08:39:59,116 [myid:] - INFO  [main:ClientBase@376] - STARTING server instance 127.0.0.1:11222
    [junit] 2017-02-21 08:39:59,116 [myid:] - INFO  [main:ZooKeeperServer@908] - minSessionTimeout set to 6000
    [junit] 2017-02-21 08:39:59,117 [myid:] - INFO  [main:ZooKeeperServer@917] - maxSessionTimeout set to 60000
    [junit] 2017-02-21 08:39:59,117 [myid:] - INFO  [main:ZooKeeperServer@160] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test9097261130983239221.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test9097261130983239221.junit.dir/version-2
    [junit] 2017-02-21 08:39:59,117 [myid:] - INFO  [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test9097261130983239221.junit.dir/version-2/snapshot.b
    [junit] 2017-02-21 08:39:59,120 [myid:] - INFO  [main:FileTxnSnapLog@346] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build/test/tmp/test9097261130983239221.junit.dir/version-2/snapshot.b
    [junit] 2017-02-21 08:39:59,121 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-21 08:39:59,121 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-21 08:39:59,122 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:49505
    [junit] 2017-02-21 08:39:59,122 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:49505
    [junit] 2017-02-21 08:39:59,122 [myid:] - INFO  [NIOWorkerThread-1:StatCommand@49] - Stat command output
    [junit] 2017-02-21 08:39:59,123 [myid:] - INFO  [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:49505 (no session established for client)
    [junit] 2017-02-21 08:39:59,123 [myid:] - INFO  [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2017-02-21 08:39:59,124 [myid:] - INFO  [main:JMXEnv@245] - expect:InMemoryDataTree
    [junit] 2017-02-21 08:39:59,124 [myid:] - INFO  [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
    [junit] 2017-02-21 08:39:59,125 [myid:] - INFO  [main:JMXEnv@245] - expect:StandaloneServer_port
    [junit] 2017-02-21 08:39:59,125 [myid:] - INFO  [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
    [junit] 2017-02-21 08:39:59,125 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17910
    [junit] 2017-02-21 08:39:59,125 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
    [junit] 2017-02-21 08:39:59,125 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
    [junit] 2017-02-21 08:39:59,125 [myid:] - INFO  [main:ClientBase@558] - tearDown starting
    [junit] 2017-02-21 08:39:59,202 [myid:] - INFO  [main:ZooKeeper@1324] - Session: 0x126dccc9c7d0000 closed
    [junit] 2017-02-21 08:39:59,202 [myid:] - INFO  [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x126dccc9c7d0000
    [junit] 2017-02-21 08:39:59,202 [myid:] - INFO  [main:ClientBase@528] - STOPPING server
    [junit] 2017-02-21 08:39:59,202 [myid:] - INFO  [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
    [junit] 2017-02-21 08:39:59,203 [myid:] - INFO  [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
    [junit] 2017-02-21 08:39:59,203 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-21 08:39:59,203 [myid:] - INFO  [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
    [junit] 2017-02-21 08:39:59,203 [myid:] - INFO  [main:ZooKeeperServer@542] - shutting down
    [junit] 2017-02-21 08:39:59,203 [myid:] - ERROR [main:ZooKeeperServer@506] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-02-21 08:39:59,203 [myid:] - INFO  [main:SessionTrackerImpl@232] - Shutting down
    [junit] 2017-02-21 08:39:59,203 [myid:] - INFO  [main:PrepRequestProcessor@1008] - Shutting down
    [junit] 2017-02-21 08:39:59,204 [myid:] - INFO  [main:SyncRequestProcessor@191] - Shutting down
    [junit] 2017-02-21 08:39:59,204 [myid:] - INFO  [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@157] - PrepRequestProcessor exited loop!
    [junit] 2017-02-21 08:39:59,204 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
    [junit] 2017-02-21 08:39:59,204 [myid:] - INFO  [main:FinalRequestProcessor@481] - shutdown of request processor complete
    [junit] 2017-02-21 08:39:59,204 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
    [junit] 2017-02-21 08:39:59,204 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
    [junit] 2017-02-21 08:39:59,205 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
    [junit] 2017-02-21 08:39:59,205 [myid:] - INFO  [main:JMXEnv@146] - ensureOnly:[]
    [junit] 2017-02-21 08:39:59,210 [myid:] - INFO  [main:ClientBase@583] - fdcount after test is: 60 at start it was 43
    [junit] 2017-02-21 08:39:59,210 [myid:] - INFO  [main:ClientBase@585] - sleeping for 20 secs
    [junit] 2017-02-21 08:39:59,211 [myid:] - INFO  [main:ZKTestCase$1@65] - SUCCEEDED testQuota
    [junit] 2017-02-21 08:39:59,211 [myid:] - INFO  [main:ZKTestCase$1@60] - FINISHED testQuota
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.514 sec

fail.build.on.test.failure:

BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1242: The following error occurred while executing this line:
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/build.xml:1216: Tests failed!

Total time: 83 minutes 7 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
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.server.quorum.StandaloneDisabledTest.startSingleServerTest

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.


FAILED:  org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:719)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)


FAILED:  org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower

Error Message:
client could not connect to reestablished quorum: giving up after 30+ seconds.

Stack Trace:
junit.framework.AssertionFailedError: client could not connect to reestablished quorum: giving up after 30+ seconds.
	at org.apache.zookeeper.test.ReconfigTest.testNormalOperation(ReconfigTest.java:183)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:796)
	at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:715)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)