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/06/30 10:22:15 UTC
ZooKeeper_branch35_solaris - Build # 155 - Failure
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/155/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 416601 lines...]
[junit] 2016-06-30 10:23:29,006 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-06-30 10:23:29,007 [myid:] - INFO [main:ClientBase@466] - STARTING server
[junit] 2016-06-30 10:23:29,007 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-06-30 10:23:29,008 [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-06-30 10:23:29,009 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-06-30 10:23:29,009 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-06-30 10:23:29,010 [myid:] - INFO [main:ZooKeeperServer@858] - minSessionTimeout set to 6000
[junit] 2016-06-30 10:23:29,010 [myid:] - INFO [main:ZooKeeperServer@867] - maxSessionTimeout set to 60000
[junit] 2016-06-30 10:23:29,010 [myid:] - INFO [main:ZooKeeperServer@156] - 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/test1367016559119357952.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test1367016559119357952.junit.dir/version-2
[junit] 2016-06-30 10:23:29,012 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test1367016559119357952.junit.dir/version-2/snapshot.b
[junit] 2016-06-30 10:23:29,014 [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/test1367016559119357952.junit.dir/version-2/snapshot.b
[junit] 2016-06-30 10:23:29,016 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-06-30 10:23:29,017 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:35188
[junit] 2016-06-30 10:23:29,017 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:35188
[junit] 2016-06-30 10:23:29,018 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-06-30 10:23:29,018 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:35188 (no session established for client)
[junit] 2016-06-30 10:23:29,018 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-06-30 10:23:29,020 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-06-30 10:23:29,020 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-06-30 10:23:29,020 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-06-30 10:23:29,020 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-06-30 10:23:29,021 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17803
[junit] 2016-06-30 10:23:29,021 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-06-30 10:23:29,021 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-06-30 10:23:29,021 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-06-30 10:23:29,093 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x1221dd240a70000 closed
[junit] 2016-06-30 10:23:29,093 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x1221dd240a70000
[junit] 2016-06-30 10:23:29,093 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-06-30 10:23:29,094 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-06-30 10:23:29,094 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-06-30 10:23:29,094 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-06-30 10:23:29,094 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-06-30 10:23:29,095 [myid:] - INFO [main:ZooKeeperServer@498] - shutting down
[junit] 2016-06-30 10:23:29,095 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-06-30 10:23:29,095 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-06-30 10:23:29,095 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-06-30 10:23:29,095 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-06-30 10:23:29,095 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-06-30 10:23:29,096 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-06-30 10:23:29,096 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-06-30 10:23:29,096 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-06-30 10:23:29,096 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-06-30 10:23:29,097 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-06-30 10:23:29,116 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-06-30 10:23:29,117 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-06-30 10:23:29,118 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-06-30 10:23:29,118 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.163 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build.xml:1233: Tests failed!
Total time: 76 minutes 4 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 # 163 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/163/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 117677 lines...]
[junit] 2016-07-07 16:58:29,878 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testOverwriteFile
[junit] 2016-07-07 16:58:30,027 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testOverwriteFile
[junit] 2016-07-07 16:58:30,027 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testOverwriteFile
[junit] 2016-07-07 16:58:30,062 [myid:] - INFO [main:ZKTestCase$1@55] - STARTING testAbortNewFileAfterFlush
[junit] 2016-07-07 16:58:30,155 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@77] - RUNNING TEST METHOD testAbortNewFileAfterFlush
[junit] 2016-07-07 16:58:30,156 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 12239
[junit] 2016-07-07 16:58:30,156 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 4
[junit] 2016-07-07 16:58:30,156 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testAbortNewFileAfterFlush
[junit] 2016-07-07 16:58:30,204 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testAbortNewFileAfterFlush
[junit] 2016-07-07 16:58:30,204 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testAbortNewFileAfterFlush
[junit] 2016-07-07 16:58:30,207 [myid:] - INFO [main:ZKTestCase$1@55] - STARTING testAbortNewFile
[junit] 2016-07-07 16:58:30,207 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@77] - RUNNING TEST METHOD testAbortNewFile
[junit] 2016-07-07 16:58:30,207 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 12239
[junit] 2016-07-07 16:58:30,208 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 4
[junit] 2016-07-07 16:58:30,208 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testAbortNewFile
[junit] 2016-07-07 16:58:30,246 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testAbortNewFile
[junit] 2016-07-07 16:58:30,246 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testAbortNewFile
[junit] 2016-07-07 16:58:30,246 [myid:] - INFO [main:ZKTestCase$1@55] - STARTING testAbortExistingFileAfterFlush
[junit] 2016-07-07 16:58:30,247 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@77] - RUNNING TEST METHOD testAbortExistingFileAfterFlush
[junit] 2016-07-07 16:58:30,247 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 12577
[junit] 2016-07-07 16:58:30,247 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 4
[junit] 2016-07-07 16:58:30,248 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testAbortExistingFileAfterFlush
[junit] 2016-07-07 16:58:30,268 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testAbortExistingFileAfterFlush
[junit] 2016-07-07 16:58:30,268 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testAbortExistingFileAfterFlush
[junit] 2016-07-07 16:58:30,269 [myid:] - INFO [main:ZKTestCase$1@55] - STARTING testAbortExistingFile
[junit] 2016-07-07 16:58:30,269 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@77] - RUNNING TEST METHOD testAbortExistingFile
[junit] 2016-07-07 16:58:30,269 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 12577
[junit] 2016-07-07 16:58:30,270 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 4
[junit] 2016-07-07 16:58:30,270 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testAbortExistingFile
[junit] 2016-07-07 16:58:30,284 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testAbortExistingFile
[junit] 2016-07-07 16:58:30,284 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testAbortExistingFile
[junit] 2016-07-07 16:58:30,285 [myid:] - INFO [main:ZKTestCase$1@55] - STARTING testWriteNewFile
[junit] 2016-07-07 16:58:30,285 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@77] - RUNNING TEST METHOD testWriteNewFile
[junit] 2016-07-07 16:58:30,287 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 12577
[junit] 2016-07-07 16:58:30,287 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 4
[junit] 2016-07-07 16:58:30,287 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testWriteNewFile
[junit] 2016-07-07 16:58:30,288 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testWriteNewFile
[junit] 2016-07-07 16:58:30,288 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testWriteNewFile
[junit] 2016-07-07 16:58:30,288 [myid:] - INFO [main:ZKTestCase$1@55] - STARTING testFailToFlush
[junit] 2016-07-07 16:58:30,289 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@77] - RUNNING TEST METHOD testFailToFlush
[junit] 2016-07-07 16:58:30,289 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 12577
[junit] 2016-07-07 16:58:30,289 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 4
[junit] 2016-07-07 16:58:30,290 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testFailToFlush
[junit] 2016-07-07 16:58:30,290 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testFailToFlush
[junit] 2016-07-07 16:58:30,290 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testFailToFlush
[junit] Tests run: 7, Failures: 0, Errors: 0, Time elapsed: 4.931 sec
[junit] Running org.apache.zookeeper.test.AuthTest
[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: 30 minutes 53 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
FAILED: org.apache.zookeeper.test.AuthTest.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 # 162 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/162/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 418835 lines...]
[junit] 2016-07-06 17:30:29,912 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-07-06 17:30:29,913 [myid:] - INFO [main:ClientBase@466] - STARTING server
[junit] 2016-07-06 17:30:29,913 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-07-06 17:30:29,913 [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-07-06 17:30:29,914 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-07-06 17:30:29,915 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-07-06 17:30:29,915 [myid:] - INFO [main:ZooKeeperServer@858] - minSessionTimeout set to 6000
[junit] 2016-07-06 17:30:29,915 [myid:] - INFO [main:ZooKeeperServer@867] - maxSessionTimeout set to 60000
[junit] 2016-07-06 17:30:29,916 [myid:] - INFO [main:ZooKeeperServer@156] - 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/test1293325000481034435.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test1293325000481034435.junit.dir/version-2
[junit] 2016-07-06 17:30:29,916 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test1293325000481034435.junit.dir/version-2/snapshot.b
[junit] 2016-07-06 17:30:29,918 [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/test1293325000481034435.junit.dir/version-2/snapshot.b
[junit] 2016-07-06 17:30:29,920 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-07-06 17:30:29,921 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:53435
[junit] 2016-07-06 17:30:29,921 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:53435
[junit] 2016-07-06 17:30:29,921 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-07-06 17:30:29,922 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:53435 (no session established for client)
[junit] 2016-07-06 17:30:29,922 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-07-06 17:30:29,923 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-07-06 17:30:29,923 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-07-06 17:30:29,923 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-07-06 17:30:29,924 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-07-06 17:30:29,924 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17734
[junit] 2016-07-06 17:30:29,924 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-07-06 17:30:29,924 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-07-06 17:30:29,924 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-07-06 17:30:30,002 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x1223e3f43090000 closed
[junit] 2016-07-06 17:30:30,002 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x1223e3f43090000
[junit] 2016-07-06 17:30:30,002 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-07-06 17:30:30,003 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-07-06 17:30:30,003 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-07-06 17:30:30,003 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-07-06 17:30:30,003 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-07-06 17:30:30,004 [myid:] - INFO [main:ZooKeeperServer@498] - shutting down
[junit] 2016-07-06 17:30:30,004 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-07-06 17:30:30,004 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-07-06 17:30:30,004 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-07-06 17:30:30,004 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-07-06 17:30:30,005 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-07-06 17:30:30,005 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-07-06 17:30:30,005 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-07-06 17:30:30,006 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-07-06 17:30:30,006 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-07-06 17:30:30,006 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-07-06 17:30:30,011 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-07-06 17:30:30,011 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-07-06 17:30:30,013 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-07-06 17:30:30,013 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.902 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build.xml:1233: Tests failed!
Total time: 69 minutes 38 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 # 161 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/161/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
Started by timer
[EnvInject] - Loading node environment variables.
Building remotely on solaris1 (Solaris) in workspace /export/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris
Updating http://svn.apache.org/repos/asf/zookeeper/branches/branch-3.5 at revision '2016-07-05T16:06:21.948 +0000'
FATAL: java.io.IOException: Unexpected termination of the channel
hudson.remoting.RequestAbortedException: java.io.IOException: Unexpected termination of the channel
at hudson.remoting.Request.abort(Request.java:297)
at hudson.remoting.Channel.terminate(Channel.java:847)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:69)
at ......remote call to solaris1(Native Method)
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1416)
at hudson.remoting.Request.call(Request.java:172)
at hudson.remoting.Channel.call(Channel.java:780)
at hudson.FilePath.act(FilePath.java:979)
at hudson.FilePath.act(FilePath.java:968)
at hudson.scm.SubversionSCM.checkout(SubversionSCM.java:894)
at hudson.scm.SubversionSCM.checkout(SubversionSCM.java:830)
at hudson.scm.SCM.checkout(SCM.java:485)
at hudson.model.AbstractProject.checkout(AbstractProject.java:1276)
at hudson.model.AbstractBuild$AbstractBuildExecution.defaultCheckout(AbstractBuild.java:607)
at jenkins.scm.SCMCheckoutStrategy.checkout(SCMCheckoutStrategy.java:86)
at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:529)
at hudson.model.Run.execute(Run.java:1738)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:98)
at hudson.model.Executor.run(Executor.java:410)
Caused by: java.io.IOException: Unexpected termination of the channel
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:50)
Caused by: java.io.EOFException
at java.io.ObjectInputStream$PeekInputStream.readFully(ObjectInputStream.java:2325)
at java.io.ObjectInputStream$BlockDataInputStream.readShort(ObjectInputStream.java:2794)
at java.io.ObjectInputStream.readStreamHeader(ObjectInputStream.java:801)
at java.io.ObjectInputStream.<init>(ObjectInputStream.java:299)
at hudson.remoting.ObjectInputStreamEx.<init>(ObjectInputStreamEx.java:48)
at hudson.remoting.AbstractSynchronousByteArrayCommandTransport.read(AbstractSynchronousByteArrayCommandTransport.java:34)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:48)
ERROR: Step ?Publish JUnit test result report? failed: no workspace for ZooKeeper_branch35_solaris #161
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
No tests ran.
ZooKeeper_branch35_solaris - Build # 160 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/160/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 422017 lines...]
[junit] 2016-07-04 17:27:15,054 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:42050
[junit] 2016-07-04 17:27:15,055 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-07-04 17:27:15,055 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:42050 (no session established for client)
[junit] 2016-07-04 17:27:15,055 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-07-04 17:27:15,056 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-07-04 17:27:15,056 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-07-04 17:27:15,057 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-07-04 17:27:15,057 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-07-04 17:27:15,057 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17737
[junit] 2016-07-04 17:27:15,057 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-07-04 17:27:15,057 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-07-04 17:27:15,057 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-07-04 17:27:15,261 [myid:] - INFO [SessionTracker:SessionTrackerImpl@158] - SessionTrackerImpl exited loop!
[junit] 2016-07-04 17:27:15,261 [myid:] - INFO [SessionTracker:SessionTrackerImpl@158] - SessionTrackerImpl exited loop!
[junit] 2016-07-04 17:27:16,841 [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-07-04 17:27:16,841 [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-07-04 17:27:16,842 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:42051
[junit] 2016-07-04 17:27:16,843 [myid:] - INFO [NIOWorkerThread-2:ZooKeeperServer@969] - Client attempting to renew session 0x12233ef8a7d0000 at /127.0.0.1:42051
[junit] 2016-07-04 17:27:16,844 [myid:] - INFO [NIOWorkerThread-2:ZooKeeperServer@678] - Established session 0x12233ef8a7d0000 with negotiated timeout 30000 for client /127.0.0.1:42051
[junit] 2016-07-04 17:27:16,845 [myid:127.0.0.1:11222] - INFO [main-SendThread(127.0.0.1:11222):ClientCnxn$SendThread@1381] - Session establishment complete on server null, sessionid = 0x12233ef8a7d0000, negotiated timeout = 30000
[junit] 2016-07-04 17:27:16,846 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@647] - Processed session termination for sessionid: 0x12233ef8a7d0000
[junit] 2016-07-04 17:27:16,846 [myid:] - INFO [SyncThread:0:FileTxnLog@204] - Creating new log file: log.c
[junit] 2016-07-04 17:27:16,875 [myid:] - INFO [NIOWorkerThread-5:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=Connections,name2=127.0.0.1,name3=0x12233ef8a7d0000]
[junit] 2016-07-04 17:27:16,875 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x12233ef8a7d0000
[junit] 2016-07-04 17:27:16,875 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x12233ef8a7d0000 closed
[junit] 2016-07-04 17:27:16,876 [myid:] - INFO [NIOWorkerThread-5:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:42051 which had sessionid 0x12233ef8a7d0000
[junit] 2016-07-04 17:27:16,876 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-07-04 17:27:16,877 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-07-04 17:27:16,877 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-07-04 17:27:16,877 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-07-04 17:27:16,877 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-07-04 17:27:16,879 [myid:] - INFO [main:ZooKeeperServer@498] - shutting down
[junit] 2016-07-04 17:27:16,879 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-07-04 17:27:16,879 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-07-04 17:27:16,879 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-07-04 17:27:16,879 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-07-04 17:27:16,879 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-07-04 17:27:16,880 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-07-04 17:27:16,880 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-07-04 17:27:16,880 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-07-04 17:27:16,881 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-07-04 17:27:16,881 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-07-04 17:27:17,558 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 52 at start it was 39
[junit] 2016-07-04 17:27:17,560 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-07-04 17:27:17,646 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-07-04 17:27:17,646 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 21.313 sec
[junit] 2016-07-04 17:27:18,261 [myid:] - INFO [SessionTracker:SessionTrackerImpl@158] - SessionTrackerImpl exited loop!
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build.xml:1233: Tests failed!
Total time: 75 minutes 14 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
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 # 159 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/159/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 418110 lines...]
[junit] 2016-07-03 17:20:54,200 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-07-03 17:20:54,201 [myid:] - INFO [main:ClientBase@466] - STARTING server
[junit] 2016-07-03 17:20:54,201 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-07-03 17:20:54,202 [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-07-03 17:20:54,202 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-07-03 17:20:54,203 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-07-03 17:20:54,203 [myid:] - INFO [main:ZooKeeperServer@858] - minSessionTimeout set to 6000
[junit] 2016-07-03 17:20:54,204 [myid:] - INFO [main:ZooKeeperServer@867] - maxSessionTimeout set to 60000
[junit] 2016-07-03 17:20:54,204 [myid:] - INFO [main:ZooKeeperServer@156] - 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/test1630865093280186957.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test1630865093280186957.junit.dir/version-2
[junit] 2016-07-03 17:20:54,204 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test1630865093280186957.junit.dir/version-2/snapshot.b
[junit] 2016-07-03 17:20:54,206 [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/test1630865093280186957.junit.dir/version-2/snapshot.b
[junit] 2016-07-03 17:20:54,208 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-07-03 17:20:54,208 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:34316
[junit] 2016-07-03 17:20:54,209 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:34316
[junit] 2016-07-03 17:20:54,209 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-07-03 17:20:54,210 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:34316 (no session established for client)
[junit] 2016-07-03 17:20:54,210 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-07-03 17:20:54,211 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-07-03 17:20:54,212 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-07-03 17:20:54,212 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-07-03 17:20:54,212 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-07-03 17:20:54,212 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17641
[junit] 2016-07-03 17:20:54,212 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-07-03 17:20:54,212 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-07-03 17:20:54,213 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-07-03 17:20:54,292 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x1222ec375ae0000 closed
[junit] 2016-07-03 17:20:54,292 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x1222ec375ae0000
[junit] 2016-07-03 17:20:54,292 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-07-03 17:20:54,293 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-07-03 17:20:54,293 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-07-03 17:20:54,293 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-07-03 17:20:54,293 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-07-03 17:20:54,294 [myid:] - INFO [main:ZooKeeperServer@498] - shutting down
[junit] 2016-07-03 17:20:54,294 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-07-03 17:20:54,294 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-07-03 17:20:54,294 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-07-03 17:20:54,294 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-07-03 17:20:54,295 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-07-03 17:20:54,295 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-07-03 17:20:54,295 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-07-03 17:20:54,296 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-07-03 17:20:54,296 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-07-03 17:20:54,296 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-07-03 17:20:54,301 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-07-03 17:20:54,301 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-07-03 17:20:54,303 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-07-03 17:20:54,303 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.99 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 47 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
3 tests failed.
FAILED: org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testCurrentServersAreObserversInNextConfig
Error Message:
waiting for server 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.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 # 158 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/158/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 38716 lines...]
[junit] 2016-07-02 16:42:25,635 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11285
[junit] 2016-07-02 16:42:25,636 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17116
[junit] 2016-07-02 16:42:25,636 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 94
[junit] 2016-07-02 16:42:25,636 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testBadPeerAddressInQuorum
[junit] 2016-07-02 16:42:25,636 [myid:] - INFO [main:QuorumPeerMainTest@63] - No servers to shutdown!
[junit] 2016-07-02 16:42:25,636 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testBadPeerAddressInQuorum
[junit] 2016-07-02 16:42:25,636 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testBadPeerAddressInQuorum
[junit] 2016-07-02 16:42:25,731 [myid:127.0.0.1:11246] - INFO [main-SendThread(127.0.0.1:11246):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:11246. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-07-02 16:42:25,731 [myid:127.0.0.1:11246] - ERROR [main-SendThread(127.0.0.1:11246):ClientCnxnSocketNIO@287] - Unable to open socket to 127.0.0.1/127.0.0.1:11246
[junit] 2016-07-02 16:42:25,731 [myid:127.0.0.1:11246] - WARN [main-SendThread(127.0.0.1:11246):ClientCnxn$SendThread@1235] - Session 0x122297897ba0000 for server 127.0.0.1/127.0.0.1:11246, unexpected error, closing socket connection and attempting reconnect
[junit] java.net.ConnectException: Connection refused
[junit] at sun.nio.ch.Net.connect0(Native Method)
[junit] at sun.nio.ch.Net.connect(Net.java:465)
[junit] at sun.nio.ch.Net.connect(Net.java:457)
[junit] at sun.nio.ch.SocketChannelImpl.connect(SocketChannelImpl.java:670)
[junit] at org.apache.zookeeper.ClientCnxnSocketNIO.registerAndConnect(ClientCnxnSocketNIO.java:275)
[junit] at org.apache.zookeeper.ClientCnxnSocketNIO.connect(ClientCnxnSocketNIO.java:285)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1098)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1133)
[junit] 2016-07-02 16:42:25,831 [myid:1] - INFO [WorkerReceiver[myid=1]:FastLeaderElection$Messenger$WorkerReceiver@440] - WorkerReceiver is down
[junit] 2016-07-02 16:42:25,831 [myid:1] - INFO [WorkerSender[myid=1]:FastLeaderElection$Messenger$WorkerSender@470] - WorkerSender is down
[junit] Tests run: 10, Failures: 0, Errors: 0, Time elapsed: 138.628 sec
[junit] 2016-07-02 16:42:26,051 [myid:127.0.0.1:11258] - INFO [main-SendThread(127.0.0.1:11258):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:11258. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-07-02 16:42:26,051 [myid:127.0.0.1:11258] - ERROR [main-SendThread(127.0.0.1:11258):ClientCnxnSocketNIO@287] - Unable to open socket to 127.0.0.1/127.0.0.1:11258
[junit] 2016-07-02 16:42:26,051 [myid:127.0.0.1:11258] - WARN [main-SendThread(127.0.0.1:11258):ClientCnxn$SendThread@1235] - Session 0x22297913540000 for server null, unexpected error, closing socket connection and attempting reconnect
[junit] java.net.ConnectException: Connection refused
[junit] at sun.nio.ch.Net.connect0(Native Method)
[junit] at sun.nio.ch.Net.connect(Net.java:465)
[junit] at sun.nio.ch.Net.connect(Net.java:457)
[junit] at sun.nio.ch.SocketChannelImpl.connect(SocketChannelImpl.java:670)
[junit] at org.apache.zookeeper.ClientCnxnSocketNIO.registerAndConnect(ClientCnxnSocketNIO.java:275)
[junit] at org.apache.zookeeper.ClientCnxnSocketNIO.connect(ClientCnxnSocketNIO.java:285)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1098)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1133)
[junit] 2016-07-02 16:42:26,161 [myid:127.0.0.1:11264] - INFO [main-SendThread(127.0.0.1:11264):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:11264. Will not attempt to authenticate using SASL (unknown error)
[junit] 2016-07-02 16:42:26,161 [myid:127.0.0.1:11264] - ERROR [main-SendThread(127.0.0.1:11264):ClientCnxnSocketNIO@287] - Unable to open socket to 127.0.0.1/127.0.0.1:11264
[junit] 2016-07-02 16:42:26,161 [myid:127.0.0.1:11264] - WARN [main-SendThread(127.0.0.1:11264):ClientCnxn$SendThread@1235] - Session 0x2222979137b0000 for server null, unexpected error, closing socket connection and attempting reconnect
[junit] java.net.ConnectException: Connection refused
[junit] at sun.nio.ch.Net.connect0(Native Method)
[junit] at sun.nio.ch.Net.connect(Net.java:465)
[junit] at sun.nio.ch.Net.connect(Net.java:457)
[junit] at sun.nio.ch.SocketChannelImpl.connect(SocketChannelImpl.java:670)
[junit] at org.apache.zookeeper.ClientCnxnSocketNIO.registerAndConnect(ClientCnxnSocketNIO.java:275)
[junit] at org.apache.zookeeper.ClientCnxnSocketNIO.connect(ClientCnxnSocketNIO.java:285)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1098)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1133)
[junit] Running org.apache.zookeeper.server.quorum.QuorumPeerTest
[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: 30 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) ##############################
2 tests failed.
FAILED: org.apache.zookeeper.server.quorum.FLEBackwardElectionRoundTest.testBackwardElectionRound
Error Message:
Should not have joined
Stack Trace:
junit.framework.AssertionFailedError: Should not have joined
at org.apache.zookeeper.server.quorum.FLEBackwardElectionRoundTest.testBackwardElectionRound(FLEBackwardElectionRoundTest.java:146)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
FAILED: org.apache.zookeeper.server.quorum.QuorumPeerTest.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 # 157 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/157/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 413213 lines...]
[junit] 2016-07-01 17:26:21,057 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-07-01 17:26:21,058 [myid:] - INFO [main:ClientBase@466] - STARTING server
[junit] 2016-07-01 17:26:21,058 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-07-01 17:26:21,058 [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-07-01 17:26:21,059 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-07-01 17:26:21,060 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-07-01 17:26:21,060 [myid:] - INFO [main:ZooKeeperServer@858] - minSessionTimeout set to 6000
[junit] 2016-07-01 17:26:21,060 [myid:] - INFO [main:ZooKeeperServer@867] - maxSessionTimeout set to 60000
[junit] 2016-07-01 17:26:21,060 [myid:] - INFO [main:ZooKeeperServer@156] - 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/test2682262409381188581.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test2682262409381188581.junit.dir/version-2
[junit] 2016-07-01 17:26:21,061 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test2682262409381188581.junit.dir/version-2/snapshot.b
[junit] 2016-07-01 17:26:21,063 [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/test2682262409381188581.junit.dir/version-2/snapshot.b
[junit] 2016-07-01 17:26:21,065 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-07-01 17:26:21,065 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:36442
[junit] 2016-07-01 17:26:21,066 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:36442
[junit] 2016-07-01 17:26:21,066 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-07-01 17:26:21,067 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:36442 (no session established for client)
[junit] 2016-07-01 17:26:21,067 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-07-01 17:26:21,068 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-07-01 17:26:21,068 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-07-01 17:26:21,068 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-07-01 17:26:21,068 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-07-01 17:26:21,069 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17738
[junit] 2016-07-01 17:26:21,069 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-07-01 17:26:21,069 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-07-01 17:26:21,069 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-07-01 17:26:21,142 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x122247bc2680000 closed
[junit] 2016-07-01 17:26:21,142 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x122247bc2680000
[junit] 2016-07-01 17:26:21,143 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-07-01 17:26:21,143 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-07-01 17:26:21,143 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-07-01 17:26:21,143 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-07-01 17:26:21,143 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-07-01 17:26:21,144 [myid:] - INFO [main:ZooKeeperServer@498] - shutting down
[junit] 2016-07-01 17:26:21,144 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-07-01 17:26:21,145 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-07-01 17:26:21,145 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-07-01 17:26:21,145 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-07-01 17:26:21,145 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-07-01 17:26:21,145 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-07-01 17:26:21,146 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-07-01 17:26:21,146 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-07-01 17:26:21,146 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-07-01 17:26:21,146 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-07-01 17:26:21,151 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-07-01 17:26:21,151 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-07-01 17:26:21,153 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-07-01 17:26:21,153 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.883 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 40 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 # 156 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_solaris/156/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 419699 lines...]
[junit] 2016-06-30 17:22:38,893 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-06-30 17:22:38,893 [myid:] - INFO [main:ClientBase@466] - STARTING server
[junit] 2016-06-30 17:22:38,894 [myid:] - INFO [main:ClientBase@386] - CREATING server instance 127.0.0.1:11222
[junit] 2016-06-30 17:22:38,894 [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-06-30 17:22:38,895 [myid:] - INFO [main:NIOServerCnxnFactory@686] - binding to port 0.0.0.0/0.0.0.0:11222
[junit] 2016-06-30 17:22:38,896 [myid:] - INFO [main:ClientBase@361] - STARTING server instance 127.0.0.1:11222
[junit] 2016-06-30 17:22:38,896 [myid:] - INFO [main:ZooKeeperServer@858] - minSessionTimeout set to 6000
[junit] 2016-06-30 17:22:38,896 [myid:] - INFO [main:ZooKeeperServer@867] - maxSessionTimeout set to 60000
[junit] 2016-06-30 17:22:38,896 [myid:] - INFO [main:ZooKeeperServer@156] - 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/test3017668215272821382.junit.dir/version-2 snapdir /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test3017668215272821382.junit.dir/version-2
[junit] 2016-06-30 17:22:38,897 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper_branch35_solaris/branch-3.5/build/test/tmp/test3017668215272821382.junit.dir/version-2/snapshot.b
[junit] 2016-06-30 17:22:38,899 [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/test3017668215272821382.junit.dir/version-2/snapshot.b
[junit] 2016-06-30 17:22:38,901 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-06-30 17:22:38,901 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:59055
[junit] 2016-06-30 17:22:38,902 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@485] - Processing stat command from /127.0.0.1:59055
[junit] 2016-06-30 17:22:38,902 [myid:] - INFO [NIOWorkerThread-1:StatCommand@49] - Stat command output
[junit] 2016-06-30 17:22:38,902 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@607] - Closed socket connection for client /127.0.0.1:59055 (no session established for client)
[junit] 2016-06-30 17:22:38,902 [myid:] - INFO [main:JMXEnv@228] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2016-06-30 17:22:38,904 [myid:] - INFO [main:JMXEnv@245] - expect:InMemoryDataTree
[junit] 2016-06-30 17:22:38,904 [myid:] - INFO [main:JMXEnv@249] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree
[junit] 2016-06-30 17:22:38,904 [myid:] - INFO [main:JMXEnv@245] - expect:StandaloneServer_port
[junit] 2016-06-30 17:22:38,904 [myid:] - INFO [main:JMXEnv@249] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port11222
[junit] 2016-06-30 17:22:38,904 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 17734
[junit] 2016-06-30 17:22:38,905 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 24
[junit] 2016-06-30 17:22:38,905 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testQuota
[junit] 2016-06-30 17:22:38,905 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2016-06-30 17:22:38,982 [myid:] - INFO [main:ZooKeeper@1313] - Session: 0x1221f52028e0000 closed
[junit] 2016-06-30 17:22:38,982 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x1221f52028e0000
[junit] 2016-06-30 17:22:38,983 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2016-06-30 17:22:38,983 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2016-06-30 17:22:38,983 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-06-30 17:22:38,983 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11222:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2016-06-30 17:22:38,983 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2016-06-30 17:22:38,984 [myid:] - INFO [main:ZooKeeperServer@498] - shutting down
[junit] 2016-06-30 17:22:38,985 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2016-06-30 17:22:38,985 [myid:] - INFO [main:PrepRequestProcessor@965] - Shutting down
[junit] 2016-06-30 17:22:38,985 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2016-06-30 17:22:38,985 [myid:] - INFO [ProcessThread(sid:0 cport:11222)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2016-06-30 17:22:38,985 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2016-06-30 17:22:38,985 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2016-06-30 17:22:38,986 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222,name1=InMemoryDataTree]
[junit] 2016-06-30 17:22:38,986 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port11222]
[junit] 2016-06-30 17:22:38,986 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 11222
[junit] 2016-06-30 17:22:38,987 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2016-06-30 17:22:38,992 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 56 at start it was 39
[junit] 2016-06-30 17:22:38,992 [myid:] - INFO [main:ClientBase@570] - sleeping for 20 secs
[junit] 2016-06-30 17:22:38,994 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testQuota
[junit] 2016-06-30 17:22:38,994 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.894 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 45 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
4 tests failed.
FAILED: org.apache.zookeeper.server.admin.JettyAdminServerTest.testQuorum
Error Message:
Connection refused
Stack Trace:
java.net.ConnectException: Connection refused
at java.net.PlainSocketImpl.socketConnect(Native Method)
at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:339)
at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:200)
at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:182)
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
at java.net.Socket.connect(Socket.java:579)
at java.net.Socket.connect(Socket.java:528)
at sun.net.NetworkClient.doConnect(NetworkClient.java:180)
at sun.net.www.http.HttpClient.openServer(HttpClient.java:432)
at sun.net.www.http.HttpClient.openServer(HttpClient.java:527)
at sun.net.www.http.HttpClient.<init>(HttpClient.java:211)
at sun.net.www.http.HttpClient.New(HttpClient.java:308)
at sun.net.www.http.HttpClient.New(HttpClient.java:326)
at sun.net.www.protocol.http.HttpURLConnection.getNewHttpClient(HttpURLConnection.java:997)
at sun.net.www.protocol.http.HttpURLConnection.plainConnect(HttpURLConnection.java:933)
at sun.net.www.protocol.http.HttpURLConnection.connect(HttpURLConnection.java:851)
at sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1301)
at java.net.URL.openStream(URL.java:1037)
at org.apache.zookeeper.server.admin.JettyAdminServerTest.queryAdminServer(JettyAdminServerTest.java:158)
at org.apache.zookeeper.server.admin.JettyAdminServerTest.queryAdminServer(JettyAdminServerTest.java:150)
at org.apache.zookeeper.server.admin.JettyAdminServerTest.testQuorum(JettyAdminServerTest.java:131)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
FAILED: org.apache.zookeeper.test.FourLetterWordsTest.testFourLetterWords
Error Message:
Exception while executing four letter word: dump
Stack Trace:
java.io.IOException: Exception while executing four letter word: dump
at org.apache.zookeeper.client.FourLetterWordMain.send4LetterWord(FourLetterWordMain.java:124)
at org.apache.zookeeper.client.FourLetterWordMain.send4LetterWord(FourLetterWordMain.java:54)
at org.apache.zookeeper.test.FourLetterWordsTest.sendRequest(FourLetterWordsTest.java:120)
at org.apache.zookeeper.test.FourLetterWordsTest.verify(FourLetterWordsTest.java:128)
at org.apache.zookeeper.test.FourLetterWordsTest.testFourLetterWords(FourLetterWordsTest.java:58)
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)
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:152)
at java.net.SocketInputStream.read(SocketInputStream.java:122)
at sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:283)
at sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:325)
at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:177)
at java.io.InputStreamReader.read(InputStreamReader.java:184)
at java.io.BufferedReader.fill(BufferedReader.java:154)
at java.io.BufferedReader.readLine(BufferedReader.java:317)
at java.io.BufferedReader.readLine(BufferedReader.java:382)
at org.apache.zookeeper.client.FourLetterWordMain.send4LetterWord(FourLetterWordMain.java:119)
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)