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/12/30 17:13:03 UTC
ZooKeeper_branch35_solaris - Build # 375 - Still Failing
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/375/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 464814 lines...]
[junit] 2016-12-30 17:14:22,532 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-12-30 17:14:22,532 [myid:] - INFO [main:NIOServerCnxnFactory@673] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2016-12-30 17:14:22,533 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-12-30 17:14:22,533 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-12-30 17:14:22,534 [myid:] - INFO [main:ZooKeeperServer@893] - minSessionTimeout set to 6000
[junit] 2016-12-30 17:14:22,534 [myid:] - INFO [main:ZooKeeperServer@902] - maxSessionTimeout set to 60000
[junit] 2016-12-30 17:14:22,534 [myid:] - INFO [main:ZooKeeperServer@159] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test1591494878537516601.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test1591494878537516601.junit.dir/version-2
[junit] 2016-12-30 17:14:22,535 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test1591494878537516601.junit.dir/version-2/snapshot.b
[junit] 2016-12-30 17:14:22,537 [myid:] - INFO [main:FileTxnSnapLog@306] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test1591494878537516601.junit.dir/version-2/snapshot.b
[junit] 2016-12-30 17:14:22,538 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-12-30 17:14:22,538 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-12-30 17:14:22,539 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:60197
[junit] 2016-12-30 17:14:22,539 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:60197
[junit] 2016-12-30 17:14:22,539 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-12-30 17:14:22,540 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:60197 (no session established for client)
[junit] 2016-12-30 17:14:22,540 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-12-30 17:14:22,541 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-12-30 17:14:22,542 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-12-30 17:14:22,542 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-12-30 17:14:22,542 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-12-30 17:14:22,542 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17749
[junit] 2016-12-30 17:14:22,543 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-12-30 17:14:22,543 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-12-30 17:14:22,543 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-12-30 17:14:22,622 [myid:] - INFO [main:ZooKeeper@1311] - Session: 0x125cdb354f60000 closed
[junit] 2016-12-30 17:14:22,622 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x125cdb354f60000
[junit] 2016-12-30 17:14:22,622 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-12-30 17:14:22,622 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-12-30 17:14:22,623 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-12-30 17:14:22,622 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-12-30 17:14:22,623 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-12-30 17:14:22,623 [myid:] - INFO [main:ZooKeeperServer@533] - shutting down
[junit] 2016-12-30 17:14:22,623 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-12-30 17:14:22,623 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-12-30 17:14:22,624 [myid:] - INFO [main:PrepRequestProcessor@974] - Shutting down
[junit] 2016-12-30 17:14:22,624 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-12-30 17:14:22,624 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-12-30 17:14:22,624 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-12-30 17:14:22,624 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-12-30 17:14:22,624 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-12-30 17:14:22,625 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-12-30 17:14:22,625 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-12-30 17:14:22,625 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-12-30 17:14:22,629 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 60 at start it was 43
[junit] 2016-12-30 17:14:22,630 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-12-30 17:14:22,631 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-12-30 17:14:22,631 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.202 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build.xml:1234: Tests failed!
Total time: 65 minutes 22 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_branch35_solaris - Build # 387 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/387/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 164941 lines...]
[junit] 2017-01-07 17:07:33,207 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-07 17:07:33,207 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:/127.0.0.1:11273:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2017-01-07 17:07:33,207 [myid:] - WARN [LearnerHandler-/127.0.0.1:62182:LearnerHandler@619] - ******* GOODBYE /127.0.0.1:62182 ********
[junit] 2017-01-07 17:07:33,209 [myid:] - WARN [LearnerHandler-/127.0.0.1:62182:LearnerHandler@903] - Ignoring unexpected exception
[junit] java.lang.InterruptedException
[junit] at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1219)
[junit] at java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:340)
[junit] at java.util.concurrent.LinkedBlockingQueue.put(LinkedBlockingQueue.java:338)
[junit] at org.apache.zookeeper.server.quorum.LearnerHandler.shutdown(LearnerHandler.java:901)
[junit] at org.apache.zookeeper.server.quorum.LearnerHandler.run(LearnerHandler.java:622)
[junit] 2017-01-07 17:07:33,209 [myid:] - INFO [/127.0.0.1:11275:QuorumCnxManager$Listener@661] - Leaving listener
[junit] 2017-01-07 17:07:33,209 [myid:] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:11273)(secure=disabled):MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=ReplicatedServer_id3,name1=replica.3,name2=Leader]
[junit] 2017-01-07 17:07:33,210 [myid:] - INFO [main:QuorumUtil@254] - Shutting down leader election QuorumPeer[myid=3](plain=/127.0.0.1:11273)(secure=disabled)
[junit] 2017-01-07 17:07:33,210 [myid:] - WARN [QuorumPeer[myid=3](plain=/127.0.0.1:11273)(secure=disabled):QuorumPeer@1133] - Unexpected exception
[junit] java.lang.InterruptedException
[junit] at java.lang.Object.wait(Native Method)
[junit] at org.apache.zookeeper.server.quorum.Leader.lead(Leader.java:563)
[junit] at org.apache.zookeeper.server.quorum.QuorumPeer.run(QuorumPeer.java:1130)
[junit] 2017-01-07 17:07:33,210 [myid:] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:11273)(secure=disabled):Leader@625] - Shutting down
[junit] 2017-01-07 17:07:33,210 [myid:] - WARN [QuorumPeer[myid=3](plain=/127.0.0.1:11273)(secure=disabled):QuorumPeer@1164] - PeerState set to LOOKING
[junit] 2017-01-07 17:07:33,210 [myid:] - WARN [QuorumPeer[myid=3](plain=/127.0.0.1:11273)(secure=disabled):QuorumPeer@1146] - QuorumPeer main thread exited
[junit] 2017-01-07 17:07:33,210 [myid:] - INFO [main:QuorumUtil@259] - Waiting for QuorumPeer[myid=3](plain=/127.0.0.1:11273)(secure=disabled) to exit thread
[junit] 2017-01-07 17:07:33,210 [myid:] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:11273)(secure=disabled):MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=ReplicatedServer_id3]
[junit] 2017-01-07 17:07:33,210 [myid:] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:11273)(secure=disabled):MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=ReplicatedServer_id3,name1=replica.3]
[junit] 2017-01-07 17:07:33,210 [myid:] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:11273)(secure=disabled):MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=ReplicatedServer_id3,name1=replica.1]
[junit] 2017-01-07 17:07:33,210 [myid:] - INFO [QuorumPeer[myid=3](plain=/127.0.0.1:11273)(secure=disabled):MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=ReplicatedServer_id3,name1=replica.2]
[junit] 2017-01-07 17:07:33,211 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11267
[junit] 2017-01-07 17:07:33,211 [myid:] - INFO [main:QuorumUtil@243] - 127.0.0.1:11267 is no longer accepting client connections
[junit] 2017-01-07 17:07:33,211 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11270
[junit] 2017-01-07 17:07:33,211 [myid:] - INFO [main:QuorumUtil@243] - 127.0.0.1:11270 is no longer accepting client connections
[junit] 2017-01-07 17:07:33,211 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11273
[junit] 2017-01-07 17:07:33,212 [myid:] - INFO [main:QuorumUtil@243] - 127.0.0.1:11273 is no longer accepting client connections
[junit] 2017-01-07 17:07:33,212 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 175112
[junit] 2017-01-07 17:07:33,212 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 29
[junit] 2017-01-07 17:07:33,212 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testFollowerWatcherResync
[junit] 2017-01-07 17:07:33,212 [myid:] - INFO [main:FollowerResyncConcurrencyTest@79] - Error count 0
[junit] 2017-01-07 17:07:33,212 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testFollowerWatcherResync
[junit] 2017-01-07 17:07:33,212 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testFollowerWatcherResync
[junit] 2017-01-07 17:07:33,751 [myid:] - INFO [WorkerSender[myid=3]:FastLeaderElection$Messenger$WorkerSender@470] - WorkerSender is down
[junit] 2017-01-07 17:07:33,751 [myid:] - INFO [WorkerSender[myid=2]:FastLeaderElection$Messenger$WorkerSender@470] - WorkerSender is down
[junit] 2017-01-07 17:07:33,751 [myid:] - INFO [WorkerSender[myid=1]:FastLeaderElection$Messenger$WorkerSender@470] - WorkerSender is down
[junit] 2017-01-07 17:07:33,821 [myid:] - INFO [WorkerReceiver[myid=1]:FastLeaderElection$Messenger$WorkerReceiver@440] - WorkerReceiver is down
[junit] 2017-01-07 17:07:33,821 [myid:] - INFO [WorkerReceiver[myid=2]:FastLeaderElection$Messenger$WorkerReceiver@440] - WorkerReceiver is down
[junit] 2017-01-07 17:07:33,821 [myid:] - INFO [WorkerReceiver[myid=3]:FastLeaderElection$Messenger$WorkerReceiver@440] - WorkerReceiver is down
[junit] 2017-01-07 17:07:34,261 [myid:] - INFO [SessionTracker:SessionTrackerImpl@158] - SessionTrackerImpl exited loop!
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 175.174 sec
[junit] Running org.apache.zookeeper.test.FourLetterWordsQuorumTest
[junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build.xml:1220: Process fork failed.
Total time: 58 minutes 3 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.ReconfigRecoveryTest.testCurrentObserverIsParticipantInNewConfig
Error Message:
waiting for server 2 being up
Stack Trace:
junit.framework.AssertionFailedError: waiting for server 2 being up
at org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testCurrentObserverIsParticipantInNewConfig(ReconfigRecoveryTest.java:529)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
FAILED: org.apache.zookeeper.test.CnxManagerTest.testWorkerThreads
Error Message:
Unable to run quorum server
Stack Trace:
java.lang.RuntimeException: Unable to run quorum server
at org.apache.zookeeper.server.quorum.QuorumPeer.loadDataBase(QuorumPeer.java:807)
at org.apache.zookeeper.server.quorum.QuorumPeer.start(QuorumPeer.java:756)
at org.apache.zookeeper.test.CnxManagerTest.testWorkerThreads(CnxManagerTest.java:398)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
Caused by: java.io.IOException: The accepted epoch, 0 is less than the current epoch, 1
at org.apache.zookeeper.server.quorum.QuorumPeer.loadDataBase(QuorumPeer.java:803)
FAILED: org.apache.zookeeper.test.FourLetterWordsQuorumTest.unknown
Error Message:
Forked Java VM exited abnormally. Please note the time in the report does not reflect the time until the VM exit.
Stack Trace:
junit.framework.AssertionFailedError: Forked Java VM exited abnormally. Please note the time in the report does not reflect the time until the VM exit.
ZooKeeper_branch35_solaris - Build # 386 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/386/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 461003 lines...]
[junit] 2017-01-07 03:00:25,110 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2017-01-07 03:00:25,110 [myid:] - INFO [main:NIOServerCnxnFactory@673] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2017-01-07 03:00:25,111 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2017-01-07 03:00:25,112 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2017-01-07 03:00:25,112 [myid:] - INFO [main:ZooKeeperServer@893] - minSessionTimeout set to 6000
[junit] 2017-01-07 03:00:25,112 [myid:] - INFO [main:ZooKeeperServer@902] - maxSessionTimeout set to 60000
[junit] 2017-01-07 03:00:25,112 [myid:] - INFO [main:ZooKeeperServer@159] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test256701899436992511.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test256701899436992511.junit.dir/version-2
[junit] 2017-01-07 03:00:25,113 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test256701899436992511.junit.dir/version-2/snapshot.b
[junit] 2017-01-07 03:00:25,115 [myid:] - INFO [main:FileTxnSnapLog@320] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test256701899436992511.junit.dir/version-2/snapshot.b
[junit] 2017-01-07 03:00:25,116 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-07 03:00:25,116 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-07 03:00:25,117 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:59951
[junit] 2017-01-07 03:00:25,117 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:59951
[junit] 2017-01-07 03:00:25,118 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2017-01-07 03:00:25,118 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:59951 (no session established for client)
[junit] 2017-01-07 03:00:25,118 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2017-01-07 03:00:25,119 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2017-01-07 03:00:25,120 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2017-01-07 03:00:25,120 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2017-01-07 03:00:25,120 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2017-01-07 03:00:25,120 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17888
[junit] 2017-01-07 03:00:25,120 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2017-01-07 03:00:25,120 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2017-01-07 03:00:25,121 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2017-01-07 03:00:25,192 [myid:] - INFO [main:ZooKeeper@1311] - Session: 0x125f3d842530000 closed
[junit] 2017-01-07 03:00:25,192 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x125f3d842530000
[junit] 2017-01-07 03:00:25,192 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2017-01-07 03:00:25,192 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2017-01-07 03:00:25,193 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-07 03:00:25,193 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2017-01-07 03:00:25,192 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-07 03:00:25,193 [myid:] - INFO [main:ZooKeeperServer@533] - shutting down
[junit] 2017-01-07 03:00:25,193 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-07 03:00:25,193 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2017-01-07 03:00:25,194 [myid:] - INFO [main:PrepRequestProcessor@974] - Shutting down
[junit] 2017-01-07 03:00:25,194 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2017-01-07 03:00:25,194 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2017-01-07 03:00:25,194 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2017-01-07 03:00:25,194 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2017-01-07 03:00:25,194 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2017-01-07 03:00:25,195 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2017-01-07 03:00:25,195 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-07 03:00:25,195 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2017-01-07 03:00:25,199 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 60 at start it was 43
[junit] 2017-01-07 03:00:25,199 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2017-01-07 03:00:25,201 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2017-01-07 03:00:25,201 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.304 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build.xml:1234: Tests failed!
Total time: 68 minutes 23 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_branch35_solaris - Build # 385 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/385/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 467923 lines...]
[junit] 2017-01-06 17:46:59,478 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2017-01-06 17:46:59,478 [myid:] - INFO [main:NIOServerCnxnFactory@673] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2017-01-06 17:46:59,479 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2017-01-06 17:46:59,480 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2017-01-06 17:46:59,481 [myid:] - INFO [main:ZooKeeperServer@893] - minSessionTimeout set to 6000
[junit] 2017-01-06 17:46:59,481 [myid:] - INFO [main:ZooKeeperServer@902] - maxSessionTimeout set to 60000
[junit] 2017-01-06 17:46:59,481 [myid:] - INFO [main:ZooKeeperServer@159] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test7644076561618355066.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test7644076561618355066.junit.dir/version-2
[junit] 2017-01-06 17:46:59,482 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test7644076561618355066.junit.dir/version-2/snapshot.b
[junit] 2017-01-06 17:46:59,484 [myid:] - INFO [main:FileTxnSnapLog@306] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test7644076561618355066.junit.dir/version-2/snapshot.b
[junit] 2017-01-06 17:46:59,485 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-06 17:46:59,485 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-06 17:46:59,486 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:55427
[junit] 2017-01-06 17:46:59,486 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:55427
[junit] 2017-01-06 17:46:59,487 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2017-01-06 17:46:59,487 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:55427 (no session established for client)
[junit] 2017-01-06 17:46:59,487 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2017-01-06 17:46:59,488 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2017-01-06 17:46:59,489 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2017-01-06 17:46:59,489 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2017-01-06 17:46:59,489 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2017-01-06 17:46:59,489 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 18006
[junit] 2017-01-06 17:46:59,489 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2017-01-06 17:46:59,490 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2017-01-06 17:46:59,490 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2017-01-06 17:46:59,562 [myid:] - INFO [main:ZooKeeper@1311] - Session: 0x125f1dd959c0000 closed
[junit] 2017-01-06 17:46:59,562 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x125f1dd959c0000
[junit] 2017-01-06 17:46:59,562 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2017-01-06 17:46:59,562 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2017-01-06 17:46:59,562 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-06 17:46:59,562 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-06 17:46:59,562 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2017-01-06 17:46:59,563 [myid:] - INFO [main:ZooKeeperServer@533] - shutting down
[junit] 2017-01-06 17:46:59,563 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-06 17:46:59,563 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2017-01-06 17:46:59,563 [myid:] - INFO [main:PrepRequestProcessor@974] - Shutting down
[junit] 2017-01-06 17:46:59,564 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2017-01-06 17:46:59,564 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2017-01-06 17:46:59,564 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2017-01-06 17:46:59,564 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2017-01-06 17:46:59,564 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2017-01-06 17:46:59,565 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2017-01-06 17:46:59,565 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-06 17:46:59,565 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2017-01-06 17:46:59,569 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 60 at start it was 43
[junit] 2017-01-06 17:46:59,570 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2017-01-06 17:46:59,571 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2017-01-06 17:46:59,571 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.061 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build.xml:1234: Tests failed!
Total time: 65 minutes 49 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.ReconfigRecoveryTest.testCurrentServersAreObserversInNextConfig
Error Message:
waiting for server 4 being up
Stack Trace:
junit.framework.AssertionFailedError: waiting for server 4 being up
at org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testCurrentServersAreObserversInNextConfig(ReconfigRecoveryTest.java:217)
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_branch35_solaris - Build # 384 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/384/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 506704 lines...]
[junit] 2017-01-06 02:30:01,371 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2017-01-06 02:30:01,371 [myid:] - INFO [main:NIOServerCnxnFactory@673] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2017-01-06 02:30:01,372 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2017-01-06 02:30:01,373 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2017-01-06 02:30:01,373 [myid:] - INFO [main:ZooKeeperServer@893] - minSessionTimeout set to 6000
[junit] 2017-01-06 02:30:01,373 [myid:] - INFO [main:ZooKeeperServer@902] - maxSessionTimeout set to 60000
[junit] 2017-01-06 02:30:01,373 [myid:] - INFO [main:ZooKeeperServer@159] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test330933317364274896.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test330933317364274896.junit.dir/version-2
[junit] 2017-01-06 02:30:01,374 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test330933317364274896.junit.dir/version-2/snapshot.b
[junit] 2017-01-06 02:30:01,376 [myid:] - INFO [main:FileTxnSnapLog@306] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test330933317364274896.junit.dir/version-2/snapshot.b
[junit] 2017-01-06 02:30:01,377 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-06 02:30:01,377 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-06 02:30:01,378 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:42948
[junit] 2017-01-06 02:30:01,378 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:42948
[junit] 2017-01-06 02:30:01,379 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2017-01-06 02:30:01,379 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:42948 (no session established for client)
[junit] 2017-01-06 02:30:01,379 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2017-01-06 02:30:01,380 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2017-01-06 02:30:01,380 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2017-01-06 02:30:01,381 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2017-01-06 02:30:01,381 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2017-01-06 02:30:01,381 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17865
[junit] 2017-01-06 02:30:01,381 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2017-01-06 02:30:01,381 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2017-01-06 02:30:01,381 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2017-01-06 02:30:01,462 [myid:] - INFO [main:ZooKeeper@1311] - Session: 0x125ee9612250000 closed
[junit] 2017-01-06 02:30:01,462 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x125ee9612250000
[junit] 2017-01-06 02:30:01,462 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2017-01-06 02:30:01,462 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2017-01-06 02:30:01,462 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-06 02:30:01,462 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-06 02:30:01,462 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2017-01-06 02:30:01,463 [myid:] - INFO [main:ZooKeeperServer@533] - shutting down
[junit] 2017-01-06 02:30:01,463 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-06 02:30:01,463 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2017-01-06 02:30:01,463 [myid:] - INFO [main:PrepRequestProcessor@974] - Shutting down
[junit] 2017-01-06 02:30:01,464 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2017-01-06 02:30:01,464 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2017-01-06 02:30:01,464 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2017-01-06 02:30:01,464 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2017-01-06 02:30:01,464 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2017-01-06 02:30:01,465 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2017-01-06 02:30:01,465 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-06 02:30:01,465 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2017-01-06 02:30:01,482 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 60 at start it was 43
[junit] 2017-01-06 02:30:01,482 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2017-01-06 02:30:01,483 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2017-01-06 02:30:01,484 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.291 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build.xml:1234: Tests failed!
Total time: 72 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) ##############################
3 tests failed.
FAILED: org.apache.zookeeper.test.NettyNettySuiteTest.testRemoveAddTwo
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_branch35_solaris - Build # 383 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/383/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 468599 lines...]
[junit] 2017-01-05 17:14:37,734 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2017-01-05 17:14:37,734 [myid:] - INFO [main:NIOServerCnxnFactory@673] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2017-01-05 17:14:37,735 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2017-01-05 17:14:37,736 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2017-01-05 17:14:37,736 [myid:] - INFO [main:ZooKeeperServer@893] - minSessionTimeout set to 6000
[junit] 2017-01-05 17:14:37,736 [myid:] - INFO [main:ZooKeeperServer@902] - maxSessionTimeout set to 60000
[junit] 2017-01-05 17:14:37,736 [myid:] - INFO [main:ZooKeeperServer@159] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test7799854385634025816.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test7799854385634025816.junit.dir/version-2
[junit] 2017-01-05 17:14:37,737 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test7799854385634025816.junit.dir/version-2/snapshot.b
[junit] 2017-01-05 17:14:37,739 [myid:] - INFO [main:FileTxnSnapLog@306] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test7799854385634025816.junit.dir/version-2/snapshot.b
[junit] 2017-01-05 17:14:37,740 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-05 17:14:37,740 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-05 17:14:37,741 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:61043
[junit] 2017-01-05 17:14:37,741 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:61043
[junit] 2017-01-05 17:14:37,742 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2017-01-05 17:14:37,742 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:61043 (no session established for client)
[junit] 2017-01-05 17:14:37,742 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2017-01-05 17:14:37,743 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2017-01-05 17:14:37,743 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2017-01-05 17:14:37,743 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2017-01-05 17:14:37,744 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2017-01-05 17:14:37,744 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17869
[junit] 2017-01-05 17:14:37,744 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2017-01-05 17:14:37,744 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2017-01-05 17:14:37,744 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2017-01-05 17:14:37,822 [myid:] - INFO [main:ZooKeeper@1311] - Session: 0x125ec99a1450000 closed
[junit] 2017-01-05 17:14:37,822 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2017-01-05 17:14:37,822 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x125ec99a1450000
[junit] 2017-01-05 17:14:37,822 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2017-01-05 17:14:37,823 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-05 17:14:37,823 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-05 17:14:37,823 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2017-01-05 17:14:37,823 [myid:] - INFO [main:ZooKeeperServer@533] - shutting down
[junit] 2017-01-05 17:14:37,823 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-05 17:14:37,824 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2017-01-05 17:14:37,824 [myid:] - INFO [main:PrepRequestProcessor@974] - Shutting down
[junit] 2017-01-05 17:14:37,824 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2017-01-05 17:14:37,824 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2017-01-05 17:14:37,824 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2017-01-05 17:14:37,825 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2017-01-05 17:14:37,825 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2017-01-05 17:14:37,825 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2017-01-05 17:14:37,826 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-05 17:14:37,826 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2017-01-05 17:14:37,831 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 60 at start it was 43
[junit] 2017-01-05 17:14:37,831 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2017-01-05 17:14:37,833 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2017-01-05 17:14:37,833 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.122 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build.xml:1234: Tests failed!
Total time: 65 minutes 29 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_branch35_solaris - Build # 382 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/382/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 481146 lines...]
[junit] 2017-01-04 17:17:37,180 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:47629
[junit] 2017-01-04 17:17:37,180 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2017-01-04 17:17:37,181 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:47629 (no session established for client)
[junit] 2017-01-04 17:17:37,181 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2017-01-04 17:17:37,182 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2017-01-04 17:17:37,182 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2017-01-04 17:17:37,183 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2017-01-04 17:17:37,183 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2017-01-04 17:17:37,183 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17867
[junit] 2017-01-04 17:17:37,183 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2017-01-04 17:17:37,183 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2017-01-04 17:17:37,183 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2017-01-04 17:17:37,261 [myid:] - INFO [SessionTracker:SessionTrackerImpl@158] - SessionTrackerImpl exited loop!
[junit] 2017-01-04 17:17:37,261 [myid:] - INFO [SessionTracker:SessionTrackerImpl@158] - SessionTrackerImpl exited loop!
[junit] 2017-01-04 17:17:38,951 [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-01-04 17:17:38,951 [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-01-04 17:17:38,951 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:47630
[junit] 2017-01-04 17:17:38,952 [myid:] - INFO [NIOWorkerThread-2:ZooKeeperServer@1004] - Client attempting to renew session 0x125e77601aa0000 at /127.0.0.1:47630
[junit] 2017-01-04 17:17:38,953 [myid:] - INFO [NIOWorkerThread-2:ZooKeeperServer@713] - Established session 0x125e77601aa0000 with negotiated timeout 30000 for client /127.0.0.1:47630
[junit] 2017-01-04 17:17:38,953 [myid:127.0.0.1:11222] - INFO [main-SendThread(127.0.0.1:11222):ClientCnxn$SendThread@1381] - Session establishment complete on server null, sessionid = 0x125e77601aa0000, negotiated timeout = 30000
[junit] 2017-01-04 17:17:38,954 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@656] - Processed session termination for sessionid: 0x125e77601aa0000
[junit] 2017-01-04 17:17:38,954 [myid:] - INFO [SyncThread:0:FileTxnLog@204] - Creating new log file: log.c
[junit] 2017-01-04 17:17:38,957 [myid:] - INFO [NIOWorkerThread-5:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=Connections,name2=127.0.0.1,name3=0x125e77601aa0000]
[junit] 2017-01-04 17:17:38,957 [myid:] - INFO [main:ZooKeeper@1311] - Session: 0x125e77601aa0000 closed
[junit] 2017-01-04 17:17:38,958 [myid:] - INFO [NIOWorkerThread-5:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:47630 which had sessionid 0x125e77601aa0000
[junit] 2017-01-04 17:17:38,958 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x125e77601aa0000
[junit] 2017-01-04 17:17:38,958 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2017-01-04 17:17:38,959 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2017-01-04 17:17:38,959 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-04 17:17:38,959 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2017-01-04 17:17:38,959 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-04 17:17:38,959 [myid:] - INFO [main:ZooKeeperServer@533] - shutting down
[junit] 2017-01-04 17:17:38,959 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-04 17:17:38,960 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2017-01-04 17:17:38,960 [myid:] - INFO [main:PrepRequestProcessor@974] - Shutting down
[junit] 2017-01-04 17:17:38,960 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2017-01-04 17:17:38,960 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2017-01-04 17:17:38,960 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2017-01-04 17:17:38,960 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2017-01-04 17:17:38,961 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2017-01-04 17:17:38,961 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2017-01-04 17:17:38,962 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-04 17:17:38,962 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2017-01-04 17:17:39,013 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 60 at start it was 43
[junit] 2017-01-04 17:17:39,014 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2017-01-04 17:17:39,015 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2017-01-04 17:17:39,015 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 2.702 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build.xml:1234: Tests failed!
Total time: 67 minutes 24 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.QuorumPeerMainTest.testHighestZxidJoinLate
Error Message:
Waiting too long
Stack Trace:
java.lang.RuntimeException: Waiting too long
at org.apache.zookeeper.server.quorum.QuorumPeerMainTest.waitForAll(QuorumPeerMainTest.java:354)
at org.apache.zookeeper.server.quorum.QuorumPeerMainTest.LaunchServers(QuorumPeerMainTest.java:401)
at org.apache.zookeeper.server.quorum.QuorumPeerMainTest.testHighestZxidJoinLate(QuorumPeerMainTest.java:248)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
FAILED: org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testCurrentServersAreObserversInNextConfig
Error Message:
waiting for server 0 being up
Stack Trace:
junit.framework.AssertionFailedError: waiting for server 0 being up
at org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testCurrentServersAreObserversInNextConfig(ReconfigRecoveryTest.java:217)
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_branch35_solaris - Build # 381 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/381/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 470117 lines...]
[junit] 2017-01-03 17:14:20,315 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2017-01-03 17:14:20,316 [myid:] - INFO [main:NIOServerCnxnFactory@673] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2017-01-03 17:14:20,317 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2017-01-03 17:14:20,318 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2017-01-03 17:14:20,318 [myid:] - INFO [main:ZooKeeperServer@893] - minSessionTimeout set to 6000
[junit] 2017-01-03 17:14:20,318 [myid:] - INFO [main:ZooKeeperServer@902] - maxSessionTimeout set to 60000
[junit] 2017-01-03 17:14:20,319 [myid:] - INFO [main:ZooKeeperServer@159] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test790271214420757380.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test790271214420757380.junit.dir/version-2
[junit] 2017-01-03 17:14:20,319 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test790271214420757380.junit.dir/version-2/snapshot.b
[junit] 2017-01-03 17:14:20,324 [myid:] - INFO [main:FileTxnSnapLog@306] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test790271214420757380.junit.dir/version-2/snapshot.b
[junit] 2017-01-03 17:14:20,327 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-03 17:14:20,328 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-03 17:14:20,328 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:57752
[junit] 2017-01-03 17:14:20,330 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:57752
[junit] 2017-01-03 17:14:20,330 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2017-01-03 17:14:20,330 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:57752 (no session established for client)
[junit] 2017-01-03 17:14:20,331 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2017-01-03 17:14:20,332 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2017-01-03 17:14:20,332 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2017-01-03 17:14:20,333 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2017-01-03 17:14:20,333 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2017-01-03 17:14:20,333 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17822
[junit] 2017-01-03 17:14:20,333 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2017-01-03 17:14:20,333 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2017-01-03 17:14:20,334 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2017-01-03 17:14:20,402 [myid:] - INFO [main:ZooKeeper@1311] - Session: 0x125e24cad3f0000 closed
[junit] 2017-01-03 17:14:20,402 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x125e24cad3f0000
[junit] 2017-01-03 17:14:20,402 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2017-01-03 17:14:20,402 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2017-01-03 17:14:20,403 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-03 17:14:20,402 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2017-01-03 17:14:20,403 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-03 17:14:20,403 [myid:] - INFO [main:ZooKeeperServer@533] - shutting down
[junit] 2017-01-03 17:14:20,404 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-03 17:14:20,404 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2017-01-03 17:14:20,404 [myid:] - INFO [main:PrepRequestProcessor@974] - Shutting down
[junit] 2017-01-03 17:14:20,404 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2017-01-03 17:14:20,404 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2017-01-03 17:14:20,404 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2017-01-03 17:14:20,404 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2017-01-03 17:14:20,405 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2017-01-03 17:14:20,405 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2017-01-03 17:14:20,405 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-03 17:14:20,406 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2017-01-03 17:14:20,410 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 60 at start it was 43
[junit] 2017-01-03 17:14:20,410 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2017-01-03 17:14:20,411 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2017-01-03 17:14:20,411 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.108 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build.xml:1234: Tests failed!
Total time: 65 minutes 15 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_branch35_solaris - Build # 380 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/380/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 459981 lines...]
[junit] 2017-01-02 17:16:32,061 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2017-01-02 17:16:32,061 [myid:] - INFO [main:NIOServerCnxnFactory@673] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2017-01-02 17:16:32,062 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2017-01-02 17:16:32,063 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2017-01-02 17:16:32,063 [myid:] - INFO [main:ZooKeeperServer@893] - minSessionTimeout set to 6000
[junit] 2017-01-02 17:16:32,063 [myid:] - INFO [main:ZooKeeperServer@902] - maxSessionTimeout set to 60000
[junit] 2017-01-02 17:16:32,063 [myid:] - INFO [main:ZooKeeperServer@159] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test4824264833257418309.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test4824264833257418309.junit.dir/version-2
[junit] 2017-01-02 17:16:32,064 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test4824264833257418309.junit.dir/version-2/snapshot.b
[junit] 2017-01-02 17:16:32,066 [myid:] - INFO [main:FileTxnSnapLog@306] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test4824264833257418309.junit.dir/version-2/snapshot.b
[junit] 2017-01-02 17:16:32,067 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-02 17:16:32,067 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-02 17:16:32,068 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:43787
[junit] 2017-01-02 17:16:32,068 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:43787
[junit] 2017-01-02 17:16:32,068 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2017-01-02 17:16:32,069 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:43787 (no session established for client)
[junit] 2017-01-02 17:16:32,069 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2017-01-02 17:16:32,070 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2017-01-02 17:16:32,070 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2017-01-02 17:16:32,070 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2017-01-02 17:16:32,071 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2017-01-02 17:16:32,071 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17868
[junit] 2017-01-02 17:16:32,071 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2017-01-02 17:16:32,071 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2017-01-02 17:16:32,071 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2017-01-02 17:16:32,152 [myid:] - INFO [main:ZooKeeper@1311] - Session: 0x125dd2853ee0000 closed
[junit] 2017-01-02 17:16:32,152 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2017-01-02 17:16:32,152 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x125dd2853ee0000
[junit] 2017-01-02 17:16:32,152 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-02 17:16:32,152 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2017-01-02 17:16:32,153 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-02 17:16:32,152 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2017-01-02 17:16:32,153 [myid:] - INFO [main:ZooKeeperServer@533] - shutting down
[junit] 2017-01-02 17:16:32,153 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-02 17:16:32,153 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2017-01-02 17:16:32,154 [myid:] - INFO [main:PrepRequestProcessor@974] - Shutting down
[junit] 2017-01-02 17:16:32,154 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2017-01-02 17:16:32,154 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2017-01-02 17:16:32,154 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2017-01-02 17:16:32,154 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2017-01-02 17:16:32,155 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2017-01-02 17:16:32,155 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2017-01-02 17:16:32,155 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-02 17:16:32,155 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2017-01-02 17:16:32,159 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 60 at start it was 43
[junit] 2017-01-02 17:16:32,159 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2017-01-02 17:16:32,160 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2017-01-02 17:16:32,161 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.768 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build.xml:1234: Tests failed!
Total time: 65 minutes 48 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_branch35_solaris - Build # 379 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/379/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 469989 lines...]
[junit] 2017-01-01 17:15:14,382 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2017-01-01 17:15:14,382 [myid:] - INFO [main:NIOServerCnxnFactory@673] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2017-01-01 17:15:14,383 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2017-01-01 17:15:14,383 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2017-01-01 17:15:14,383 [myid:] - INFO [main:ZooKeeperServer@893] - minSessionTimeout set to 6000
[junit] 2017-01-01 17:15:14,384 [myid:] - INFO [main:ZooKeeperServer@902] - maxSessionTimeout set to 60000
[junit] 2017-01-01 17:15:14,384 [myid:] - INFO [main:ZooKeeperServer@159] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test8995428715432271690.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test8995428715432271690.junit.dir/version-2
[junit] 2017-01-01 17:15:14,384 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test8995428715432271690.junit.dir/version-2/snapshot.b
[junit] 2017-01-01 17:15:14,386 [myid:] - INFO [main:FileTxnSnapLog@306] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test8995428715432271690.junit.dir/version-2/snapshot.b
[junit] 2017-01-01 17:15:14,388 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-01 17:15:14,388 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-01 17:15:14,388 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:62717
[junit] 2017-01-01 17:15:14,389 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:62717
[junit] 2017-01-01 17:15:14,389 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2017-01-01 17:15:14,389 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:62717 (no session established for client)
[junit] 2017-01-01 17:15:14,389 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2017-01-01 17:15:14,391 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2017-01-01 17:15:14,391 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2017-01-01 17:15:14,391 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2017-01-01 17:15:14,391 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2017-01-01 17:15:14,391 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17869
[junit] 2017-01-01 17:15:14,392 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2017-01-01 17:15:14,392 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2017-01-01 17:15:14,392 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2017-01-01 17:15:14,472 [myid:] - INFO [main:ZooKeeper@1311] - Session: 0x125d800d0190000 closed
[junit] 2017-01-01 17:15:14,472 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x125d800d0190000
[junit] 2017-01-01 17:15:14,472 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2017-01-01 17:15:14,472 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2017-01-01 17:15:14,473 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-01 17:15:14,473 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2017-01-01 17:15:14,472 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2017-01-01 17:15:14,473 [myid:] - INFO [main:ZooKeeperServer@533] - shutting down
[junit] 2017-01-01 17:15:14,473 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-01-01 17:15:14,473 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2017-01-01 17:15:14,473 [myid:] - INFO [main:PrepRequestProcessor@974] - Shutting down
[junit] 2017-01-01 17:15:14,474 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2017-01-01 17:15:14,474 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2017-01-01 17:15:14,474 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2017-01-01 17:15:14,474 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2017-01-01 17:15:14,475 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2017-01-01 17:15:14,475 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2017-01-01 17:15:14,475 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2017-01-01 17:15:14,475 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2017-01-01 17:15:14,480 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 60 at start it was 43
[junit] 2017-01-01 17:15:14,480 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2017-01-01 17:15:14,482 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2017-01-01 17:15:14,482 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.066 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build.xml:1234: Tests failed!
Total time: 65 minutes 53 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_branch35_solaris - Build # 378 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/378/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 199 lines...]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
at ......remote call to solaris1(Native Method)
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1416)
at hudson.remoting.UserResponse.retrieve(UserRequest.java:253)
at hudson.remoting.Channel.call(Channel.java:781)
at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.execute(RemoteGitImpl.java:145)
at sun.reflect.GeneratedMethodAccessor761.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.invoke(RemoteGitImpl.java:131)
at com.sun.proxy.$Proxy175.execute(Unknown Source)
at hudson.plugins.git.GitSCM.retrieveChanges(GitSCM.java:1046)
at hudson.plugins.git.GitSCM.checkout(GitSCM.java:1086)
at hudson.scm.SCM.checkout(SCM.java:485)
at hudson.model.AbstractProject.checkout(AbstractProject.java:1269)
at hudson.model.AbstractBuild$AbstractBuildExecution.defaultCheckout(AbstractBuild.java:604)
at jenkins.scm.SCMCheckoutStrategy.checkout(SCMCheckoutStrategy.java:86)
at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:529)
at hudson.model.Run.execute(Run.java:1741)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:98)
at hudson.model.Executor.run(Executor.java:410)
Caused by: hudson.plugins.git.GitException: Error performing command: /opt/csw/bin/git init /export/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris
at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:1730)
at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:1699)
at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:1695)
at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommand(CliGitAPIImpl.java:1317)
at org.jenkinsci.plugins.gitclient.CliGitAPIImpl$5.execute(CliGitAPIImpl.java:650)
at org.jenkinsci.plugins.gitclient.CliGitAPIImpl$2.execute(CliGitAPIImpl.java:463)
at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler$1.call(RemoteGitImpl.java:152)
at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler$1.call(RemoteGitImpl.java:145)
at hudson.remoting.UserRequest.perform(UserRequest.java:153)
at hudson.remoting.UserRequest.perform(UserRequest.java:50)
at hudson.remoting.Request$2.run(Request.java:332)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:68)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.io.IOException: Cannot run program "/opt/csw/bin/git" (in directory "/export/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris"): error=12, Not enough space
at java.lang.ProcessBuilder.start(ProcessBuilder.java:1047)
at hudson.Proc$LocalProc.<init>(Proc.java:240)
at hudson.Proc$LocalProc.<init>(Proc.java:212)
at hudson.Launcher$LocalLauncher.launch(Launcher.java:815)
at hudson.Launcher$ProcStarter.start(Launcher.java:381)
at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:1719)
... 15 more
Caused by: java.io.IOException: error=12, Not enough space
at java.lang.UNIXProcess.forkAndExec(Native Method)
at java.lang.UNIXProcess.<init>(UNIXProcess.java:136)
at java.lang.ProcessImpl.start(ProcessImpl.java:130)
at java.lang.ProcessBuilder.start(ProcessBuilder.java:1028)
... 20 more
ERROR: null
Recording test results
ERROR: Step ?Publish JUnit test result report? failed: No test report files were found. Configuration error?
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
No tests ran.
ZooKeeper_branch35_solaris - Build # 377 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/377/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 469269 lines...]
[junit] 2016-12-31 03:19:09,317 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-12-31 03:19:09,317 [myid:] - INFO [main:NIOServerCnxnFactory@673] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2016-12-31 03:19:09,318 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-12-31 03:19:09,318 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-12-31 03:19:09,319 [myid:] - INFO [main:ZooKeeperServer@893] - minSessionTimeout set to 6000
[junit] 2016-12-31 03:19:09,319 [myid:] - INFO [main:ZooKeeperServer@902] - maxSessionTimeout set to 60000
[junit] 2016-12-31 03:19:09,319 [myid:] - INFO [main:ZooKeeperServer@159] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test7701781560356468740.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test7701781560356468740.junit.dir/version-2
[junit] 2016-12-31 03:19:09,320 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test7701781560356468740.junit.dir/version-2/snapshot.b
[junit] 2016-12-31 03:19:09,322 [myid:] - INFO [main:FileTxnSnapLog@306] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test7701781560356468740.junit.dir/version-2/snapshot.b
[junit] 2016-12-31 03:19:09,323 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-12-31 03:19:09,323 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-12-31 03:19:09,324 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:41176
[junit] 2016-12-31 03:19:09,324 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:41176
[junit] 2016-12-31 03:19:09,324 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-12-31 03:19:09,325 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:41176 (no session established for client)
[junit] 2016-12-31 03:19:09,325 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-12-31 03:19:09,326 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-12-31 03:19:09,326 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-12-31 03:19:09,326 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-12-31 03:19:09,327 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-12-31 03:19:09,327 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17870
[junit] 2016-12-31 03:19:09,327 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-12-31 03:19:09,327 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-12-31 03:19:09,327 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-12-31 03:19:09,402 [myid:] - INFO [main:ZooKeeper@1311] - Session: 0x125cfdd03820000 closed
[junit] 2016-12-31 03:19:09,402 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x125cfdd03820000
[junit] 2016-12-31 03:19:09,402 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-12-31 03:19:09,402 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-12-31 03:19:09,403 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-12-31 03:19:09,403 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-12-31 03:19:09,402 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-12-31 03:19:09,403 [myid:] - INFO [main:ZooKeeperServer@533] - shutting down
[junit] 2016-12-31 03:19:09,403 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-12-31 03:19:09,403 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-12-31 03:19:09,404 [myid:] - INFO [main:PrepRequestProcessor@974] - Shutting down
[junit] 2016-12-31 03:19:09,404 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-12-31 03:19:09,404 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-12-31 03:19:09,404 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-12-31 03:19:09,404 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-12-31 03:19:09,404 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-12-31 03:19:09,405 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-12-31 03:19:09,405 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-12-31 03:19:09,405 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-12-31 03:19:09,423 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 60 at start it was 43
[junit] 2016-12-31 03:19:09,423 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-12-31 03:19:09,425 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-12-31 03:19:09,425 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.649 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build.xml:1234: Tests failed!
Total time: 70 minutes 3 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_branch35_solaris - Build # 376 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/376/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 471768 lines...]
[junit] 2016-12-30 23:23:31,323 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-12-30 23:23:31,324 [myid:] - INFO [main:NIOServerCnxnFactory@673] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2016-12-30 23:23:31,325 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-12-30 23:23:31,325 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-12-30 23:23:31,326 [myid:] - INFO [main:ZooKeeperServer@893] - minSessionTimeout set to 6000
[junit] 2016-12-30 23:23:31,326 [myid:] - INFO [main:ZooKeeperServer@902] - maxSessionTimeout set to 60000
[junit] 2016-12-30 23:23:31,326 [myid:] - INFO [main:ZooKeeperServer@159] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test9046428575656310129.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test9046428575656310129.junit.dir/version-2
[junit] 2016-12-30 23:23:31,327 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test9046428575656310129.junit.dir/version-2/snapshot.b
[junit] 2016-12-30 23:23:31,329 [myid:] - INFO [main:FileTxnSnapLog@306] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build/test/tmp/test9046428575656310129.junit.dir/version-2/snapshot.b
[junit] 2016-12-30 23:23:31,330 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-12-30 23:23:31,330 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-12-30 23:23:31,331 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:49137
[junit] 2016-12-30 23:23:31,338 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:49137
[junit] 2016-12-30 23:23:31,338 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-12-30 23:23:31,338 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:49137 (no session established for client)
[junit] 2016-12-30 23:23:31,338 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-12-30 23:23:31,340 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-12-30 23:23:31,340 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-12-30 23:23:31,340 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-12-30 23:23:31,340 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-12-30 23:23:31,340 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 18005
[junit] 2016-12-30 23:23:31,341 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-12-30 23:23:31,341 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-12-30 23:23:31,341 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-12-30 23:23:31,412 [myid:] - INFO [main:ZooKeeper@1311] - Session: 0x125cf054a3b0000 closed
[junit] 2016-12-30 23:23:31,412 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x125cf054a3b0000
[junit] 2016-12-30 23:23:31,412 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-12-30 23:23:31,413 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-12-30 23:23:31,413 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-12-30 23:23:31,413 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-12-30 23:23:31,413 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-12-30 23:23:31,413 [myid:] - INFO [main:ZooKeeperServer@533] - shutting down
[junit] 2016-12-30 23:23:31,414 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-12-30 23:23:31,414 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-12-30 23:23:31,414 [myid:] - INFO [main:PrepRequestProcessor@974] - Shutting down
[junit] 2016-12-30 23:23:31,414 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-12-30 23:23:31,414 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-12-30 23:23:31,414 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-12-30 23:23:31,415 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-12-30 23:23:31,415 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-12-30 23:23:31,415 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-12-30 23:23:31,416 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-12-30 23:23:31,416 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-12-30 23:23:31,421 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 60 at start it was 43
[junit] 2016-12-30 23:23:31,421 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-12-30 23:23:31,422 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-12-30 23:23:31,423 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.518 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/build.xml:1234: Tests failed!
Total time: 73 minutes 20 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.SessionTrackerTest.testAddSessionAfterSessionExpiry
Error Message:
Should throw session expiry exception as the session has expired and closed
Stack Trace:
junit.framework.AssertionFailedError: Should throw session expiry exception as the session has expired and closed
at org.apache.zookeeper.server.SessionTrackerTest.testAddSessionAfterSessionExpiry(SessionTrackerTest.java:74)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.lang.Thread.run(Thread.java:745)
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)