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/08/13 18:29:36 UTC
ZooKeeper_branch35_solaris - Build # 209 - Still Failing
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/209/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 12404 lines...]
[junit] Removing file: Aug 13, 2016 6:30:52 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test1796438771629162171.junit.dir/version-2/log.3
[junit] Removing file: Aug 13, 2016 6:30:52 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test1796438771629162171.junit.dir/version-2/snapshot.2
[junit] Removing file: Aug 13, 2016 6:30:52 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test1796438771629162171.junit.dir/version-2/snapshot.0
[junit] 2016-08-13 18:30:52,951 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 7478
[junit] 2016-08-13 18:30:52,951 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 4
[junit] 2016-08-13 18:30:52,951 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testSnapFilesLessThanToRetain
[junit] 2016-08-13 18:30:53,184 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testSnapFilesLessThanToRetain
[junit] 2016-08-13 18:30:53,184 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testSnapFilesLessThanToRetain
[junit] 2016-08-13 18:30:53,185 [myid:] - INFO [main:ZKTestCase$1@55] - STARTING testPurgeTxnLogWithDataDir
[junit] 2016-08-13 18:30:53,185 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@77] - RUNNING TEST METHOD testPurgeTxnLogWithDataDir
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataLogDir/version-2/log.2
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataLogDir/version-2/log.8
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataLogDir/version-2/log.5
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataLogDir/version-2/log.1
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataLogDir/version-2/log.6
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataLogDir/version-2/log.4
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataLogDir/version-2/log.9
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataLogDir/version-2/log.3
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataLogDir/version-2/log.7
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataLogDir/version-2/log.0
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataDir/version-2/snapshot.0
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataDir/version-2/snapshot.7
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataDir/version-2/snapshot.9
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataDir/version-2/snapshot.3
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataDir/version-2/snapshot.4
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataDir/version-2/snapshot.6
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataDir/version-2/snapshot.1
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataDir/version-2/snapshot.5
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataDir/version-2/snapshot.2
[junit] Removing file: Aug 13, 2016 6:30:53 PM /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test9080170508663014892.junit.dir/dataDir/version-2/snapshot.8
[junit] 2016-08-13 18:30:53,339 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 7906
[junit] 2016-08-13 18:30:53,340 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 4
[junit] 2016-08-13 18:30:53,340 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testPurgeTxnLogWithDataDir
[junit] 2016-08-13 18:30:53,340 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testPurgeTxnLogWithDataDir
[junit] 2016-08-13 18:30:53,340 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testPurgeTxnLogWithDataDir
[junit] 2016-08-13 18:30:53,340 [myid:] - INFO [main:ZKTestCase$1@55] - STARTING testFindNRecentSnapshots
[junit] 2016-08-13 18:30:53,340 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@77] - RUNNING TEST METHOD testFindNRecentSnapshots
[junit] 2016-08-13 18:30:53,346 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 8334
[junit] 2016-08-13 18:30:53,346 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 4
[junit] 2016-08-13 18:30:53,346 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testFindNRecentSnapshots
[junit] 2016-08-13 18:30:53,388 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testFindNRecentSnapshots
[junit] 2016-08-13 18:30:53,388 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testFindNRecentSnapshots
[junit] Tests run: 8, Failures: 0, Errors: 0, Time elapsed: 44.838 sec
[junit] Running org.apache.zookeeper.server.ReferenceCountedACLCacheTest
[junit] 2016-08-13 18:31:05,795 [myid:] - INFO [main:ReferenceCountedACLCache@155] - Ignoring acl 1 as it does not exist in the cache
[junit] Tests run: 10, Failures: 0, Errors: 0, Time elapsed: 4.236 sec
[junit] Running org.apache.zookeeper.server.SerializationPerfTest
[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/branch-3.5/build.xml:1219: Process fork failed.
Total time: 11 minutes 42 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
FAILED: org.apache.zookeeper.server.SerializationPerfTest.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 # 222 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/222/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 440562 lines...]
[junit] 2016-08-24 21:49:23,510 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-08-24 21:49:23,510 [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-08-24 21:49:23,511 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-08-24 21:49:23,511 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-08-24 21:49:23,512 [myid:] - INFO [main:ZooKeeperServer@889] - minSessionTimeout set to 6000
[junit] 2016-08-24 21:49:23,512 [myid:] - INFO [main:ZooKeeperServer@898] - maxSessionTimeout set to 60000
[junit] 2016-08-24 21:49:23,512 [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/branch-3.5/build/test/tmp/test8469794341780952165.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test8469794341780952165.junit.dir/version-2
[junit] 2016-08-24 21:49:23,513 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test8469794341780952165.junit.dir/version-2/snapshot.b
[junit] 2016-08-24 21:49:23,514 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test8469794341780952165.junit.dir/version-2/snapshot.b
[junit] 2016-08-24 21:49:23,516 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-24 21:49:23,516 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-24 21:49:23,516 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:33575
[junit] 2016-08-24 21:49:23,517 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:33575
[junit] 2016-08-24 21:49:23,517 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-08-24 21:49:23,518 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:33575 (no session established for client)
[junit] 2016-08-24 21:49:23,518 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-08-24 21:49:23,519 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-08-24 21:49:23,519 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-08-24 21:49:23,519 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-08-24 21:49:23,520 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-08-24 21:49:23,520 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 18067
[junit] 2016-08-24 21:49:23,520 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-08-24 21:49:23,520 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-08-24 21:49:23,520 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-08-24 21:49:23,602 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x1233b8321b40000 closed
[junit] 2016-08-24 21:49:23,602 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x1233b8321b40000
[junit] 2016-08-24 21:49:23,602 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-08-24 21:49:23,603 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-24 21:49:23,603 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-24 21:49:23,603 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-24 21:49:23,603 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-24 21:49:23,603 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-24 21:49:23,604 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-24 21:49:23,604 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-24 21:49:23,604 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-24 21:49:23,604 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-24 21:49:23,604 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-24 21:49:23,604 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-24 21:49:23,604 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-24 21:49:23,605 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-08-24 21:49:23,605 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-08-24 21:49:23,605 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-24 21:49:23,606 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-08-24 21:49:23,610 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-08-24 21:49:23,610 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-08-24 21:49:23,611 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-08-24 21:49:23,611 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.954 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build.xml:1233: Tests failed!
Total time: 74 minutes 1 second
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.ReconfigRecoveryTest.testCurrentServersAreObserversInNextConfig
Error Message:
waiting for server 3 being up
Stack Trace:
junit.framework.AssertionFailedError: waiting for server 3 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.SessionTest.testSessionTimeout
Error Message:
KeeperErrorCode = ConnectionLoss for /stest
Stack Trace:
org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /stest
at org.apache.zookeeper.KeeperException.create(KeeperException.java:99)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1846)
at org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1874)
at org.apache.zookeeper.test.SessionTest.testSessionTimeout(SessionTest.java:300)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:662)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:658)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
ZooKeeper_branch35_solaris - Build # 221 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/221/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 437073 lines...]
[junit] 2016-08-24 17:20:45,499 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-08-24 17:20:45,500 [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-08-24 17:20:45,500 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-08-24 17:20:45,501 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-08-24 17:20:45,501 [myid:] - INFO [main:ZooKeeperServer@889] - minSessionTimeout set to 6000
[junit] 2016-08-24 17:20:45,502 [myid:] - INFO [main:ZooKeeperServer@898] - maxSessionTimeout set to 60000
[junit] 2016-08-24 17:20:45,502 [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/branch-3.5/build/test/tmp/test5832146599598065347.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test5832146599598065347.junit.dir/version-2
[junit] 2016-08-24 17:20:45,502 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test5832146599598065347.junit.dir/version-2/snapshot.b
[junit] 2016-08-24 17:20:45,504 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test5832146599598065347.junit.dir/version-2/snapshot.b
[junit] 2016-08-24 17:20:45,506 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-24 17:20:45,506 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-24 17:20:45,506 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:62938
[junit] 2016-08-24 17:20:45,507 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:62938
[junit] 2016-08-24 17:20:45,507 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-08-24 17:20:45,508 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:62938 (no session established for client)
[junit] 2016-08-24 17:20:45,508 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-08-24 17:20:45,509 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-08-24 17:20:45,509 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-08-24 17:20:45,509 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-08-24 17:20:45,509 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-08-24 17:20:45,510 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 18068
[junit] 2016-08-24 17:20:45,510 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-08-24 17:20:45,510 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-08-24 17:20:45,510 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-08-24 17:20:45,592 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x1233a8d2fc90000 closed
[junit] 2016-08-24 17:20:45,592 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-08-24 17:20:45,592 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x1233a8d2fc90000
[junit] 2016-08-24 17:20:45,593 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-24 17:20:45,593 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-24 17:20:45,593 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-24 17:20:45,593 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-24 17:20:45,601 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-24 17:20:45,602 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-24 17:20:45,602 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-24 17:20:45,602 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-24 17:20:45,602 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-24 17:20:45,602 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-24 17:20:45,602 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-24 17:20:45,602 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-24 17:20:45,603 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-08-24 17:20:45,603 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-08-24 17:20:45,603 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-24 17:20:45,604 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-08-24 17:20:45,623 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-08-24 17:20:45,623 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-08-24 17:20:45,624 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-08-24 17:20:45,625 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 3.149 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build.xml:1233: Tests failed!
Total time: 68 minutes 52 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.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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:662)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:658)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
ZooKeeper_branch35_solaris - Build # 220 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/220/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 183 lines...]
[ivy:retrieve] found antlr#antlr;2.7.7 in maven2
[ivy:retrieve] found org.antlr#antlr4-runtime;4.5.1-1 in maven2
[ivy:retrieve] found commons-beanutils#commons-beanutils;1.9.2 in maven2
[ivy:retrieve] found commons-logging#commons-logging;1.1.1 in maven2
[ivy:retrieve] found commons-cli#commons-cli;1.3.1 in maven2
[ivy:retrieve] found com.google.guava#guava;18.0 in maven2
[ivy:retrieve] found commons-collections#commons-collections;3.2.2 in maven2
[ivy:retrieve] :: resolution report :: resolve 2580ms :: artifacts dl 12ms
[ivy:retrieve] :: evicted modules:
[ivy:retrieve] commons-collections#commons-collections;3.2.1 by [commons-collections#commons-collections;3.2.2] in [test]
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| test | 13 | 0 | 0 | 1 || 12 | 0 |
---------------------------------------------------------------------
[ivy:retrieve] :: retrieving :: org.apache.zookeeper#zookeeper
[ivy:retrieve] confs: [test]
[ivy:retrieve] 12 artifacts copied, 0 already retrieved (7025kB/2755ms)
compile-test:
[mkdir] Created dir: /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/classes
[javac] Compiling 191 source files to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/classes
[javac] Note: Some input files use or override a deprecated API.
[javac] Note: Recompile with -Xlint:deprecation for details.
[javac] Note: Some input files use unchecked or unsafe operations.
[javac] Note: Recompile with -Xlint:unchecked for details.
[javac] Compiling 11 source files to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/classes
test-init:
[mkdir] Created dir: /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/logs
[mkdir] Created dir: /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp
[mkdir] Created dir: /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/data
[mkdir] Created dir: /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/data/invalidsnap
[copy] Copying 8 files to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/data/invalidsnap
[mkdir] Created dir: /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/data/buffersize
[copy] Copying 7 files to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/data/buffersize
[mkdir] Created dir: /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/data/ssl
[copy] Copying 3 files to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/data/ssl
test-category:
junit-init:
junit.run-single:
[echo] Running single JUnit process. Upgrade to Ant 1.9.4 or later to run multiple JUnit processes.
[junit] Running org.apache.jute.BinaryInputArchiveTest
[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/branch-3.5/build.xml:1219: Process fork failed.
Total time: 6 minutes 43 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
FAILED: org.apache.jute.BinaryInputArchiveTest.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.
$PROJECT_NAME - Build # $BUILD_NUMBER - $BUILD_STATUS
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See ${BUILD_URL}
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
${BUILD_LOG, maxLines=60}
###################################################################################
############################## FAILED TESTS (if any) ##############################
${FAILED_TESTS}
ZooKeeper_branch35_solaris - Build # 218 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/218/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 422576 lines...]
[junit] 2016-08-22 17:16:50,667 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-08-22 17:16:50,667 [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-08-22 17:16:50,668 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-08-22 17:16:50,669 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-08-22 17:16:50,669 [myid:] - INFO [main:ZooKeeperServer@889] - minSessionTimeout set to 6000
[junit] 2016-08-22 17:16:50,669 [myid:] - INFO [main:ZooKeeperServer@898] - maxSessionTimeout set to 60000
[junit] 2016-08-22 17:16:50,669 [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/branch-3.5/build/test/tmp/test2824056786492685303.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test2824056786492685303.junit.dir/version-2
[junit] 2016-08-22 17:16:50,670 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test2824056786492685303.junit.dir/version-2/snapshot.b
[junit] 2016-08-22 17:16:50,672 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test2824056786492685303.junit.dir/version-2/snapshot.b
[junit] 2016-08-22 17:16:50,673 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-22 17:16:50,674 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-22 17:16:50,674 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:53588
[junit] 2016-08-22 17:16:50,675 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:53588
[junit] 2016-08-22 17:16:50,675 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-08-22 17:16:50,675 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:53588 (no session established for client)
[junit] 2016-08-22 17:16:50,675 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-08-22 17:16:50,677 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-08-22 17:16:50,677 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-08-22 17:16:50,677 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-08-22 17:16:50,677 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-08-22 17:16:50,677 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 18067
[junit] 2016-08-22 17:16:50,678 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-08-22 17:16:50,678 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-08-22 17:16:50,678 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-08-22 17:16:50,752 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x123303cea4d0000 closed
[junit] 2016-08-22 17:16:50,752 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x123303cea4d0000
[junit] 2016-08-22 17:16:50,752 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-08-22 17:16:50,753 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-22 17:16:50,753 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-22 17:16:50,753 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-22 17:16:50,753 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-22 17:16:50,753 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-22 17:16:50,753 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-22 17:16:50,754 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-22 17:16:50,754 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-22 17:16:50,754 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-22 17:16:50,754 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-22 17:16:50,754 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-22 17:16:50,754 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-22 17:16:50,755 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-08-22 17:16:50,755 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-08-22 17:16:50,755 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-22 17:16:50,756 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-08-22 17:16:50,760 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-08-22 17:16:50,760 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-08-22 17:16:50,762 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-08-22 17:16:50,762 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.134 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build.xml:1233: Tests failed!
Total time: 65 minutes 46 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:662)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:658)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
ZooKeeper_branch35_solaris - Build # 217 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/217/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 415888 lines...]
[junit] 2016-08-21 17:16:44,356 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-08-21 17:16:44,356 [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-08-21 17:16:44,357 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-08-21 17:16:44,358 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-08-21 17:16:44,358 [myid:] - INFO [main:ZooKeeperServer@889] - minSessionTimeout set to 6000
[junit] 2016-08-21 17:16:44,358 [myid:] - INFO [main:ZooKeeperServer@898] - maxSessionTimeout set to 60000
[junit] 2016-08-21 17:16:44,358 [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/branch-3.5/build/test/tmp/test6119586837894604685.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test6119586837894604685.junit.dir/version-2
[junit] 2016-08-21 17:16:44,359 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test6119586837894604685.junit.dir/version-2/snapshot.b
[junit] 2016-08-21 17:16:44,361 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test6119586837894604685.junit.dir/version-2/snapshot.b
[junit] 2016-08-21 17:16:44,362 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-21 17:16:44,363 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-21 17:16:44,363 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:44973
[junit] 2016-08-21 17:16:44,364 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:44973
[junit] 2016-08-21 17:16:44,364 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-08-21 17:16:44,364 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:44973 (no session established for client)
[junit] 2016-08-21 17:16:44,364 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-08-21 17:16:44,366 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-08-21 17:16:44,366 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-08-21 17:16:44,366 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-08-21 17:16:44,366 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-08-21 17:16:44,366 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 18066
[junit] 2016-08-21 17:16:44,366 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-08-21 17:16:44,367 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-08-21 17:16:44,367 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-08-21 17:16:44,432 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x1232b1675e50000 closed
[junit] 2016-08-21 17:16:44,432 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x1232b1675e50000
[junit] 2016-08-21 17:16:44,432 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-08-21 17:16:44,432 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-21 17:16:44,433 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-21 17:16:44,432 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-21 17:16:44,432 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-21 17:16:44,433 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-21 17:16:44,433 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-21 17:16:44,433 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-21 17:16:44,434 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-21 17:16:44,434 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-21 17:16:44,434 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-21 17:16:44,434 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-21 17:16:44,434 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-21 17:16:44,434 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-08-21 17:16:44,435 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-08-21 17:16:44,435 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-21 17:16:44,435 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-08-21 17:16:44,463 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-08-21 17:16:44,463 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-08-21 17:16:44,464 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-08-21 17:16:44,464 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 2.431 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build.xml:1233: Tests failed!
Total time: 66 minutes 9 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
5 tests failed.
FAILED: org.apache.zookeeper.test.AsyncHammerTest.testHammer
Error Message:
null
Stack Trace:
junit.framework.AssertionFailedError
at org.apache.zookeeper.test.AsyncHammerTest.testHammer(AsyncHammerTest.java:186)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
FAILED: org.apache.zookeeper.test.SSLTest.testSecureQuorumServer
Error Message:
waiting for server 0 being up
Stack Trace:
junit.framework.AssertionFailedError: waiting for server 0 being up
at org.apache.zookeeper.test.SSLTest.testSecureQuorumServer(SSLTest.java:100)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
FAILED: org.apache.zookeeper.test.SSLTest.testSecureStandaloneServer
Error Message:
Timeout connecting to ZK server secure port
Stack Trace:
junit.framework.AssertionFailedError: Timeout connecting to ZK server secure port
at org.apache.zookeeper.test.SSLTest.testSecureStandaloneServer(SSLTest.java:153)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:662)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:658)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
ZooKeeper_branch35_solaris - Build # 216 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/216/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 423748 lines...]
[junit] 2016-08-20 17:17:13,976 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-08-20 17:17:13,976 [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-08-20 17:17:13,977 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-08-20 17:17:13,978 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-08-20 17:17:13,978 [myid:] - INFO [main:ZooKeeperServer@889] - minSessionTimeout set to 6000
[junit] 2016-08-20 17:17:13,978 [myid:] - INFO [main:ZooKeeperServer@898] - maxSessionTimeout set to 60000
[junit] 2016-08-20 17:17:13,978 [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/branch-3.5/build/test/tmp/test2451416131180862187.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test2451416131180862187.junit.dir/version-2
[junit] 2016-08-20 17:17:13,979 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test2451416131180862187.junit.dir/version-2/snapshot.b
[junit] 2016-08-20 17:17:13,981 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test2451416131180862187.junit.dir/version-2/snapshot.b
[junit] 2016-08-20 17:17:13,982 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-20 17:17:13,983 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-20 17:17:13,983 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:36450
[junit] 2016-08-20 17:17:13,984 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:36450
[junit] 2016-08-20 17:17:13,984 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-08-20 17:17:13,984 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:36450 (no session established for client)
[junit] 2016-08-20 17:17:13,984 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-08-20 17:17:13,986 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-08-20 17:17:13,986 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-08-20 17:17:13,986 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-08-20 17:17:13,986 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-08-20 17:17:13,986 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 18067
[junit] 2016-08-20 17:17:13,987 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-08-20 17:17:13,987 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-08-20 17:17:13,987 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-08-20 17:17:14,062 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x12325f096470000 closed
[junit] 2016-08-20 17:17:14,062 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x12325f096470000
[junit] 2016-08-20 17:17:14,062 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-08-20 17:17:14,063 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-20 17:17:14,063 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-20 17:17:14,063 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-20 17:17:14,063 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-20 17:17:14,063 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-20 17:17:14,064 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-20 17:17:14,064 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-20 17:17:14,064 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-20 17:17:14,064 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-20 17:17:14,064 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-20 17:17:14,064 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-20 17:17:14,065 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-20 17:17:14,065 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-08-20 17:17:14,065 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-08-20 17:17:14,065 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-20 17:17:14,066 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-08-20 17:17:14,071 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-08-20 17:17:14,071 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-08-20 17:17:14,072 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-08-20 17:17:14,072 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.203 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build.xml:1233: Tests failed!
Total time: 65 minutes 58 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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:662)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:658)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
ZooKeeper_branch35_solaris - Build # 215 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/215/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 427088 lines...]
[junit] 2016-08-19 17:23:03,327 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-08-19 17:23:03,327 [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-08-19 17:23:03,328 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-08-19 17:23:03,328 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-08-19 17:23:03,329 [myid:] - INFO [main:ZooKeeperServer@889] - minSessionTimeout set to 6000
[junit] 2016-08-19 17:23:03,329 [myid:] - INFO [main:ZooKeeperServer@898] - maxSessionTimeout set to 60000
[junit] 2016-08-19 17:23:03,329 [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/branch-3.5/build/test/tmp/test5053141155780035619.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test5053141155780035619.junit.dir/version-2
[junit] 2016-08-19 17:23:03,329 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test5053141155780035619.junit.dir/version-2/snapshot.b
[junit] 2016-08-19 17:23:03,331 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test5053141155780035619.junit.dir/version-2/snapshot.b
[junit] 2016-08-19 17:23:03,333 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-19 17:23:03,333 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-19 17:23:03,333 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:60489
[junit] 2016-08-19 17:23:03,334 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:60489
[junit] 2016-08-19 17:23:03,334 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-08-19 17:23:03,335 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:60489 (no session established for client)
[junit] 2016-08-19 17:23:03,335 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-08-19 17:23:03,336 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-08-19 17:23:03,336 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-08-19 17:23:03,337 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-08-19 17:23:03,337 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-08-19 17:23:03,337 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17913
[junit] 2016-08-19 17:23:03,337 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-08-19 17:23:03,337 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-08-19 17:23:03,337 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-08-19 17:23:03,402 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x12320cf8ce20000 closed
[junit] 2016-08-19 17:23:03,402 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-08-19 17:23:03,402 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x12320cf8ce20000
[junit] 2016-08-19 17:23:03,402 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-19 17:23:03,402 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-19 17:23:03,402 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-19 17:23:03,402 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-19 17:23:03,403 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-19 17:23:03,403 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-19 17:23:03,403 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-19 17:23:03,403 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-19 17:23:03,403 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-19 17:23:03,403 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-19 17:23:03,404 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-19 17:23:03,404 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-19 17:23:03,404 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-08-19 17:23:03,404 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-08-19 17:23:03,405 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-19 17:23:03,405 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-08-19 17:23:03,409 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-08-19 17:23:03,409 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-08-19 17:23:03,411 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-08-19 17:23:03,411 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.421 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build.xml:1233: Tests failed!
Total time: 71 minutes 54 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.test.NonRecoverableErrorTest.testZooKeeperServiceAvailableOnLeader
Error Message:
test timed out after 30000 milliseconds
Stack Trace:
at java.lang.Thread.sleep(Native Method)
at org.apache.zookeeper.test.ClientBase.waitForServerUp(ClientBase.java:257)
at org.apache.zookeeper.test.ClientBase.waitForServerUp(ClientBase.java:232)
at org.apache.zookeeper.test.NonRecoverableErrorTest.testZooKeeperServiceAvailableOnLeader(NonRecoverableErrorTest.java:77)
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.QuorumTest.testNoLogBeforeLeaderEstablishment
Error Message:
Not following
Stack Trace:
junit.framework.AssertionFailedError: Not following
at org.apache.zookeeper.test.QuorumTest.testNoLogBeforeLeaderEstablishment(QuorumTest.java:411)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:662)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:658)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
ZooKeeper_branch35_solaris - Build # 214 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/214/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 180446 lines...]
[junit] 2016-08-18 16:58:21,560 [myid:] - INFO [main:Environment@109] - Client environment:java.io.tmpdir=/var/tmp/
[junit] 2016-08-18 16:58:21,560 [myid:] - INFO [main:Environment@109] - Client environment:java.compiler=<NA>
[junit] 2016-08-18 16:58:21,560 [myid:] - INFO [main:Environment@109] - Client environment:os.name=SunOS
[junit] 2016-08-18 16:58:21,560 [myid:] - INFO [main:Environment@109] - Client environment:os.arch=x86
[junit] 2016-08-18 16:58:21,560 [myid:] - INFO [main:Environment@109] - Client environment:os.version=5.10
[junit] 2016-08-18 16:58:21,560 [myid:] - INFO [main:Environment@109] - Client environment:user.name=hudson
[junit] 2016-08-18 16:58:21,560 [myid:] - INFO [main:Environment@109] - Client environment:user.home=/export/home/hudson
[junit] 2016-08-18 16:58:21,560 [myid:] - INFO [main:Environment@109] - Client environment:user.dir=/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test
[junit] 2016-08-18 16:58:21,561 [myid:] - INFO [main:Environment@109] - Client environment:os.memory.free=68MB
[junit] 2016-08-18 16:58:21,561 [myid:] - INFO [main:Environment@109] - Client environment:os.memory.max=454MB
[junit] 2016-08-18 16:58:21,561 [myid:] - INFO [main:Environment@109] - Client environment:os.memory.total=77MB
[junit] 2016-08-18 16:58:21,604 [myid:] - INFO [main:ZooKeeper@855] - Initiating client connection, connectString=127.0.0.1:11222 sessionTimeout=20000 watcher=org.apache.zookeeper.test.InvalidSnapshotTest@1f1ca93
[junit] 2016-08-18 16:58:21,860 [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] 2016-08-18 16:58:21,861 [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] 2016-08-18 16:58:21,861 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:38356
[junit] 2016-08-18 16:58:21,882 [myid:] - INFO [NIOWorkerThread-2:ZooKeeperServer@995] - Client attempting to establish new session at /127.0.0.1:38356
[junit] 2016-08-18 16:58:21,890 [myid:] - INFO [SyncThread:0:FileTxnLog@204] - Creating new log file: log.840
[junit] 2016-08-18 16:58:22,568 [myid:] - INFO [SyncThread:0:ZooKeeperServer@709] - Established session 0x1231b9294510000 with negotiated timeout 20000 for client /127.0.0.1:38356
[junit] 2016-08-18 16:58:22,643 [myid:127.0.0.1:11222] - INFO [main-SendThread(127.0.0.1:11222):ClientCnxn$SendThread@1381] - Session establishment complete on server null, sessionid = 0x1231b9294510000, negotiated timeout = 20000
[junit] 2016-08-18 16:58:22,702 [myid:] - INFO [main-EventThread:InvalidSnapshotTest@117] - Event:SyncConnected None null
[junit] 2016-08-18 16:58:22,808 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@647] - Processed session termination for sessionid: 0x1231b9294510000
[junit] 2016-08-18 16:58:22,810 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x1231b9294510000 closed
[junit] 2016-08-18 16:58:22,810 [myid:] - INFO [NIOWorkerThread-7:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=Connections,name2=127.0.0.1,name3=0x1231b9294510000]
[junit] 2016-08-18 16:58:22,811 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-18 16:58:22,810 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x1231b9294510000
[junit] 2016-08-18 16:58:22,811 [myid:] - INFO [NIOWorkerThread-7:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:38356 which had sessionid 0x1231b9294510000
[junit] 2016-08-18 16:58:22,811 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-18 16:58:22,812 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-18 16:58:22,812 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-18 16:58:22,813 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-18 16:58:22,813 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-18 16:58:22,813 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-18 16:58:22,813 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-18 16:58:22,813 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-18 16:58:22,813 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-18 16:58:22,813 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-18 16:58:22,814 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-18 16:58:22,814 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-08-18 16:58:22,814 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-08-18 16:58:22,815 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-18 16:58:22,815 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 12589
[junit] 2016-08-18 16:58:22,815 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 6
[junit] 2016-08-18 16:58:22,815 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testSnapshot
[junit] 2016-08-18 16:58:22,815 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testSnapshot
[junit] 2016-08-18 16:58:22,816 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testSnapshot
[junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 16.802 sec
[junit] Running org.apache.zookeeper.test.KeeperStateTest
[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/branch-3.5/build.xml:1219: Process fork failed.
Total time: 43 minutes 50 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
FAILED: org.apache.zookeeper.test.KeeperStateTest.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 # 213 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/213/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 418746 lines...]
[junit] 2016-08-17 17:23:54,888 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-08-17 17:23:54,888 [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-08-17 17:23:54,889 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-08-17 17:23:54,890 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-08-17 17:23:54,890 [myid:] - INFO [main:ZooKeeperServer@889] - minSessionTimeout set to 6000
[junit] 2016-08-17 17:23:54,890 [myid:] - INFO [main:ZooKeeperServer@898] - maxSessionTimeout set to 60000
[junit] 2016-08-17 17:23:54,890 [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/branch-3.5/build/test/tmp/test4215328810066866765.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test4215328810066866765.junit.dir/version-2
[junit] 2016-08-17 17:23:54,891 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test4215328810066866765.junit.dir/version-2/snapshot.b
[junit] 2016-08-17 17:23:54,893 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test4215328810066866765.junit.dir/version-2/snapshot.b
[junit] 2016-08-17 17:23:54,895 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-17 17:23:54,895 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-17 17:23:54,895 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:38186
[junit] 2016-08-17 17:23:54,896 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:38186
[junit] 2016-08-17 17:23:54,896 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-08-17 17:23:54,896 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:38186 (no session established for client)
[junit] 2016-08-17 17:23:54,896 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-08-17 17:23:54,898 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-08-17 17:23:54,898 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-08-17 17:23:54,898 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-08-17 17:23:54,898 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-08-17 17:23:54,898 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 18067
[junit] 2016-08-17 17:23:54,899 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-08-17 17:23:54,899 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-08-17 17:23:54,899 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-08-17 17:23:54,972 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x1231683a8420000 closed
[junit] 2016-08-17 17:23:54,972 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x1231683a8420000
[junit] 2016-08-17 17:23:54,972 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-08-17 17:23:54,972 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-17 17:23:54,973 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-17 17:23:54,973 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-17 17:23:54,973 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-17 17:23:54,973 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-17 17:23:54,973 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-17 17:23:54,974 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-17 17:23:54,974 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-17 17:23:54,974 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-17 17:23:54,974 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-17 17:23:54,974 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-17 17:23:54,974 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-17 17:23:54,975 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-08-17 17:23:54,975 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-08-17 17:23:54,975 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-17 17:23:54,976 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-08-17 17:23:54,980 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-08-17 17:23:54,980 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-08-17 17:23:54,982 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-08-17 17:23:54,982 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.926 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build.xml:1233: Tests failed!
Total time: 71 minutes 28 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:662)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:658)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
ZooKeeper_branch35_solaris - Build # 212 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/212/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 420942 lines...]
[junit] 2016-08-16 17:22:50,062 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-08-16 17:22:50,063 [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-08-16 17:22:50,063 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-08-16 17:22:50,064 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-08-16 17:22:50,064 [myid:] - INFO [main:ZooKeeperServer@889] - minSessionTimeout set to 6000
[junit] 2016-08-16 17:22:50,065 [myid:] - INFO [main:ZooKeeperServer@898] - maxSessionTimeout set to 60000
[junit] 2016-08-16 17:22:50,065 [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/branch-3.5/build/test/tmp/test5329041218873960675.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test5329041218873960675.junit.dir/version-2
[junit] 2016-08-16 17:22:50,065 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test5329041218873960675.junit.dir/version-2/snapshot.b
[junit] 2016-08-16 17:22:50,067 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test5329041218873960675.junit.dir/version-2/snapshot.b
[junit] 2016-08-16 17:22:50,069 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-16 17:22:50,069 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-16 17:22:50,069 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:53999
[junit] 2016-08-16 17:22:50,070 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:53999
[junit] 2016-08-16 17:22:50,070 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-08-16 17:22:50,070 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:53999 (no session established for client)
[junit] 2016-08-16 17:22:50,071 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-08-16 17:22:50,072 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-08-16 17:22:50,072 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-08-16 17:22:50,072 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-08-16 17:22:50,072 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-08-16 17:22:50,073 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17812
[junit] 2016-08-16 17:22:50,073 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-08-16 17:22:50,073 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-08-16 17:22:50,073 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-08-16 17:22:50,152 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x123115c56c00000 closed
[junit] 2016-08-16 17:22:50,152 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x123115c56c00000
[junit] 2016-08-16 17:22:50,152 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-08-16 17:22:50,152 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-16 17:22:50,152 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-16 17:22:50,152 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-16 17:22:50,152 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-16 17:22:50,153 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-16 17:22:50,153 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-16 17:22:50,153 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-16 17:22:50,154 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-16 17:22:50,154 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-16 17:22:50,154 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-16 17:22:50,154 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-16 17:22:50,154 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-16 17:22:50,155 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-08-16 17:22:50,155 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-08-16 17:22:50,155 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-16 17:22:50,156 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-08-16 17:22:50,160 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-08-16 17:22:50,160 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-08-16 17:22:50,162 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-08-16 17:22:50,162 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.16 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build.xml:1233: Tests failed!
Total time: 72 minutes 2 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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:662)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:658)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
ZooKeeper_branch35_solaris - Build # 211 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/211/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 198436 lines...]
[junit] 2016-08-15 17:15:17,484 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:45900 which had sessionid 0x1230c2f0a22001a
[junit] 2016-08-15 17:15:17,405 [myid:] - INFO [NIOWorkerThread-4:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:45887 which had sessionid 0x1230c2f0a220006
[junit] 2016-08-15 17:15:17,405 [myid:] - INFO [NIOWorkerThread-3:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:45893 which had sessionid 0x1230c2f0a220005
[junit] 2016-08-15 17:15:17,405 [myid:] - INFO [NIOWorkerThread-10:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:45890 which had sessionid 0x1230c2f0a220013
[junit] 2016-08-15 17:15:17,404 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 35
[junit] 2016-08-15 17:15:17,404 [myid:] - INFO [NIOWorkerThread-15:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=Connections,name2=127.0.0.1,name3=0x1230c2f0a220008]
[junit] 2016-08-15 17:15:17,404 [myid:] - INFO [NIOWorkerThread-7:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=Connections,name2=127.0.0.1,name3=0x1230c2f0a22000e]
[junit] 2016-08-15 17:15:17,485 [myid:] - INFO [NIOWorkerThread-15:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:45897 which had sessionid 0x1230c2f0a220008
[junit] 2016-08-15 17:15:17,485 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testMaxCnxns
[junit] 2016-08-15 17:15:17,484 [myid:] - INFO [NIOWorkerThread-2:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=Connections,name2=127.0.0.1,name3=0x1230c2f0a220004]
[junit] 2016-08-15 17:15:17,482 [myid:] - WARN [NIOWorkerThread-11:NIOServerCnxn@365] - Unable to read additional data from client sessionid 0x1230c2f0a22001c, likely client has closed socket
[junit] 2016-08-15 17:15:17,486 [myid:] - INFO [NIOWorkerThread-11:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=Connections,name2=127.0.0.1,name3=0x1230c2f0a22001c]
[junit] 2016-08-15 17:15:17,486 [myid:] - INFO [NIOWorkerThread-11:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:45877 which had sessionid 0x1230c2f0a22001c
[junit] 2016-08-15 17:15:17,486 [myid:] - INFO [NIOWorkerThread-2:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:45902 which had sessionid 0x1230c2f0a220004
[junit] 2016-08-15 17:15:17,482 [myid:] - WARN [NIOWorkerThread-16:NIOServerCnxn@365] - Unable to read additional data from client sessionid 0x1230c2f0a22001d, likely client has closed socket
[junit] 2016-08-15 17:15:17,482 [myid:] - WARN [NIOWorkerThread-14:NIOServerCnxn@365] - Unable to read additional data from client sessionid 0x1230c2f0a22001b, likely client has closed socket
[junit] 2016-08-15 17:15:17,481 [myid:] - INFO [NIOWorkerThread-12:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:45886 which had sessionid 0x1230c2f0a220011
[junit] 2016-08-15 17:15:17,481 [myid:] - INFO [NIOWorkerThread-13:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:45895 which had sessionid 0x1230c2f0a220001
[junit] 2016-08-15 17:15:17,487 [myid:] - INFO [NIOWorkerThread-14:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=Connections,name2=127.0.0.1,name3=0x1230c2f0a22001b]
[junit] 2016-08-15 17:15:17,487 [myid:] - INFO [NIOWorkerThread-16:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=Connections,name2=127.0.0.1,name3=0x1230c2f0a22001d]
[junit] 2016-08-15 17:15:17,485 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-08-15 17:15:17,485 [myid:] - INFO [NIOWorkerThread-7:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:45881 which had sessionid 0x1230c2f0a22000e
[junit] 2016-08-15 17:15:17,489 [myid:] - INFO [NIOWorkerThread-16:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:45882 which had sessionid 0x1230c2f0a22001d
[junit] 2016-08-15 17:15:17,489 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-08-15 17:15:17,488 [myid:] - INFO [NIOWorkerThread-14:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:45884 which had sessionid 0x1230c2f0a22001b
[junit] 2016-08-15 17:15:17,565 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-15 17:15:17,568 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-15 17:15:17,568 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-15 17:15:17,569 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-15 17:15:17,570 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-15 17:15:17,570 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-15 17:15:17,570 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-15 17:15:17,571 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-15 17:15:17,571 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-15 17:15:17,571 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-15 17:15:17,571 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-15 17:15:17,571 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-15 17:15:17,572 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-08-15 17:15:17,572 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-08-15 17:15:17,573 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-15 17:15:17,603 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-08-15 17:15:18,042 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 142 at start it was 39
[junit] 2016-08-15 17:15:18,043 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-08-15 17:15:18,259 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testMaxCnxns
[junit] 2016-08-15 17:15:18,259 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testMaxCnxns
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 11.306 sec
[junit] Running org.apache.zookeeper.test.MultiAsyncTransactionTest
[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/branch-3.5/build.xml:1219: Process fork failed.
Total time: 61 minutes 26 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
FAILED: org.apache.zookeeper.test.MultiAsyncTransactionTest.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 # 210 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/210/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 405747 lines...]
[junit] 2016-08-14 17:21:55,922 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-08-14 17:21:55,922 [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-08-14 17:21:55,923 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-08-14 17:21:55,924 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-08-14 17:21:55,924 [myid:] - INFO [main:ZooKeeperServer@889] - minSessionTimeout set to 6000
[junit] 2016-08-14 17:21:55,924 [myid:] - INFO [main:ZooKeeperServer@898] - maxSessionTimeout set to 60000
[junit] 2016-08-14 17:21:55,924 [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/branch-3.5/build/test/tmp/test826532141122148107.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test826532141122148107.junit.dir/version-2
[junit] 2016-08-14 17:21:55,925 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test826532141122148107.junit.dir/version-2/snapshot.b
[junit] 2016-08-14 17:21:55,927 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test826532141122148107.junit.dir/version-2/snapshot.b
[junit] 2016-08-14 17:21:55,928 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-14 17:21:55,928 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-14 17:21:55,929 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:46647
[junit] 2016-08-14 17:21:55,929 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:46647
[junit] 2016-08-14 17:21:55,930 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-08-14 17:21:55,930 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:46647 (no session established for client)
[junit] 2016-08-14 17:21:55,930 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-08-14 17:21:55,931 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-08-14 17:21:55,932 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-08-14 17:21:55,932 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-08-14 17:21:55,932 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-08-14 17:21:55,932 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17934
[junit] 2016-08-14 17:21:55,932 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-08-14 17:21:55,933 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-08-14 17:21:55,933 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-08-14 17:21:56,012 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x123070ed2f40000 closed
[junit] 2016-08-14 17:21:56,012 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x123070ed2f40000
[junit] 2016-08-14 17:21:56,012 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-08-14 17:21:56,012 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-08-14 17:21:56,012 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-08-14 17:21:56,012 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-14 17:21:56,013 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-08-14 17:21:56,013 [myid:] - INFO [main:ZooKeeperServer@529] - shutting down
[junit] 2016-08-14 17:21:56,014 [myid:] - ERROR [main:ZooKeeperServer@501] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2016-08-14 17:21:56,014 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-08-14 17:21:56,014 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-08-14 17:21:56,014 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-08-14 17:21:56,014 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-08-14 17:21:56,014 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-08-14 17:21:56,014 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-08-14 17:21:56,015 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-08-14 17:21:56,015 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-08-14 17:21:56,015 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-08-14 17:21:56,016 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-08-14 17:21:56,019 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-08-14 17:21:56,019 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-08-14 17:21:56,021 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-08-14 17:21:56,021 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.915 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build.xml:1233: Tests failed!
Total time: 70 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.test.QuorumZxidSyncTest.testBehindLeader
Error Message:
KeeperErrorCode = ConnectionLoss for /0
Stack Trace:
org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /0
at org.apache.zookeeper.KeeperException.create(KeeperException.java:99)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:1412)
at org.apache.zookeeper.test.QuorumZxidSyncTest.testBehindLeader(QuorumZxidSyncTest.java:53)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortLeader(ReconfigTest.java:662)
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:173)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPort(ReconfigTest.java:732)
at org.apache.zookeeper.test.ReconfigTest.testPortChangeToBlockedPortFollower(ReconfigTest.java:658)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)