See https://builds.apache.org/job/ZooKeeper-trunk-WinVS2008_java/622/
################################################################################### ########################## LAST 60 LINES OF THE CONSOLE ########################### [...truncated 271774 lines...] [junit] 2013-12-13 00:00:43,718 [myid:] - INFO [main:ZooKeeperServer@149] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir f:\hudson\hudson-slave\workspace\ZooKeeper-trunk-WinVS2008_java\trunk\build\test\tmp\test5100204417961579608.junit.dir\version-2 snapdir f:\hudson\hudson-slave\workspace\ZooKeeper-trunk-WinVS2008_java\trunk\build\test\tmp\test5100204417961579608.junit.dir\version-2 [junit] 2013-12-13 00:00:43,729 [myid:] - INFO [main:NIOServerCnxnFactory@670] - Configuring NIO connection handler with 10s sessionless connection timeout, 1 selector thread(s), 4 worker threads, and 64 kB direct buffers. [junit] 2013-12-13 00:00:43,730 [myid:] - INFO [main:NIOServerCnxnFactory@683] - binding to port 0.0.0.0/0.0.0.0:11221 [junit] 2013-12-13 00:00:43,733 [myid:] - INFO [main:FileSnap@83] - Reading snapshot f:\hudson\hudson-slave\workspace\ZooKeeper-trunk-WinVS2008_java\trunk\build\test\tmp\test5100204417961579608.junit.dir\version-2\snapshot.b [junit] 2013-12-13 00:00:43,815 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:62339 [junit] 2013-12-13 00:00:43,815 [myid:] - INFO [main-SendThread(127.0.0.1:11221):ClientCnxn$SendThread@882] - Socket connection established to 127.0.0.1/127.0.0.1:11221, initiating session [junit] 2013-12-13 00:00:43,831 [myid:] - WARN [NIOWorkerThread-1:NIOServerCnxn@372] - Exception causing close of session 0x0: ZooKeeperServer not running [junit] 2013-12-13 00:00:43,831 [myid:] - INFO [main:FileTxnSnapLog@297] - Snapshotting: 0xb to f:\hudson\hudson-slave\workspace\ZooKeeper-trunk-WinVS2008_java\trunk\build\test\tmp\test5100204417961579608.junit.dir\version-2\snapshot.b [junit] 2013-12-13 00:00:43,930 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:62339 (no session established for client) [junit] 2013-12-13 00:00:43,931 [myid:] - INFO [main-SendThread(127.0.0.1:11221):ClientCnxn$SendThread@1124] - Unable to read additional data from server sessionid 0x142e9414c4d0000, likely server has closed socket, closing socket connection and attempting reconnect [junit] 2013-12-13 00:00:43,932 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221 [junit] 2013-12-13 00:00:43,933 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:62344 [junit] 2013-12-13 00:00:43,934 [myid:] - INFO [NIOWorkerThread-2:NIOServerCnxn@835] - Processing stat command from /127.0.0.1:62344 [junit] 2013-12-13 00:00:43,934 [myid:] - INFO [NIOWorkerThread-2:NIOServerCnxn$StatCommand@684] - Stat command output [junit] 2013-12-13 00:00:44,032 [myid:] - INFO [NIOWorkerThread-2:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:62344 (no session established for client) [junit] 2013-12-13 00:00:44,032 [myid:] - INFO [main:JMXEnv@133] - ensureOnly:[InMemoryDataTree, StandaloneServer_port] [junit] 2013-12-13 00:00:44,034 [myid:] - INFO [main:JMXEnv@105] - expect:InMemoryDataTree [junit] 2013-12-13 00:00:44,034 [myid:] - INFO [main:JMXEnv@108] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree [junit] 2013-12-13 00:00:44,132 [myid:] - INFO [main:JMXEnv@105] - expect:StandaloneServer_port [junit] 2013-12-13 00:00:44,132 [myid:] - INFO [main:JMXEnv@108] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1 [junit] 2013-12-13 00:00:44,132 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@57] - FINISHED TEST METHOD testQuota [junit] 2013-12-13 00:00:44,132 [myid:] - INFO [main:ClientBase@451] - tearDown starting [junit] 2013-12-13 00:00:45,000 [myid:] - INFO [SessionTracker:SessionTrackerImpl@134] - SessionTrackerImpl exited loop! [junit] 2013-12-13 00:00:45,638 [myid:] - INFO [main-SendThread(127.0.0.1:11221):ClientCnxn$SendThread@1008] - Opening socket connection to server 127.0.0.1/127.0.0.1:11221. Will not attempt to authenticate using SASL (java.lang.SecurityException: Unable to locate a login configuration) [junit] 2013-12-13 00:00:45,639 [myid:] - INFO [main-SendThread(127.0.0.1:11221):ClientCnxn$SendThread@882] - Socket connection established to 127.0.0.1/127.0.0.1:11221, initiating session [junit] 2013-12-13 00:00:45,639 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:62345 [junit] 2013-12-13 00:00:45,642 [myid:] - INFO [NIOWorkerThread-3:ZooKeeperServer@858] - Client attempting to renew session 0x142e9414c4d0000 at /127.0.0.1:62345 [junit] 2013-12-13 00:00:45,643 [myid:] - INFO [NIOWorkerThread-3:ZooKeeperServer@604] - Established session 0x142e9414c4d0000 with negotiated timeout 30000 for client /127.0.0.1:62345 [junit] 2013-12-13 00:00:45,647 [myid:] - INFO [main-SendThread(127.0.0.1:11221):ClientCnxn$SendThread@1261] - Session establishment complete on server 127.0.0.1/127.0.0.1:11221, sessionid = 0x142e9414c4d0000, negotiated timeout = 30000 [junit] 2013-12-13 00:00:45,742 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@678] - Processed session termination for sessionid: 0x142e9414c4d0000 [junit] 2013-12-13 00:00:45,742 [myid:] - INFO [SyncThread:0:FileTxnLog@200] - Creating new log file: log.c [junit] 2013-12-13 00:00:45,748 [myid:] - INFO [main:ZooKeeper@777] - Session: 0x142e9414c4d0000 closed [junit] 2013-12-13 00:00:45,749 [myid:] - INFO [main:ClientBase@421] - STOPPING server [junit] 2013-12-13 00:00:45,749 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down [junit] 2013-12-13 00:00:45,751 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method [junit] 2013-12-13 00:00:45,750 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method [junit] 2013-12-13 00:00:45,750 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted [junit] 2013-12-13 00:00:45,749 [myid:] - INFO [NIOWorkerThread-2:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:62345 which had sessionid 0x142e9414c4d0000 [junit] 2013-12-13 00:00:45,943 [myid:] - INFO [main:ZooKeeperServer@428] - shutting down [junit] 2013-12-13 00:00:45,943 [myid:] - INFO [main:SessionTrackerImpl@183] - Shutting down [junit] 2013-12-13 00:00:45,944 [myid:] - INFO [main:PrepRequestProcessor@972] - Shutting down [junit] 2013-12-13 00:00:45,944 [myid:] - INFO [main:SyncRequestProcessor@190] - Shutting down [junit] 2013-12-13 00:00:45,944 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@156] - PrepRequestProcessor exited loop! [junit] 2013-12-13 00:00:45,944 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@168] - SyncRequestProcessor exited! [junit] 2013-12-13 00:00:46,043 [myid:] - INFO [main:FinalRequestProcessor@442] - shutdown of request processor complete [junit] 2013-12-13 00:00:46,044 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221 [junit] 2013-12-13 00:00:47,036 [myid:] - INFO [main:JMXEnv@133] - ensureOnly:[] [junit] 2013-12-13 00:00:47,041 [myid:] - INFO [main:ZKTestCase$1@61] - SUCCEEDED testQuota [junit] 2013-12-13 00:00:47,041 [myid:] - INFO [main:ZKTestCase$1@56] - FINISHED testQuota [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 7.919 sec BUILD FAILED f:\hudson\hudson-slave\workspace\ZooKeeper-trunk-WinVS2008_java\trunk\build.xml:1264: Tests failed! Total time: 117 minutes 4 seconds Build step 'Invoke Ant' marked build as failure Recording test results Email was triggered for: Failure Sending email for trigger: Failure ################################################################################### ############################## FAILED TESTS (if any) ############################## 17 tests failed. REGRESSION: org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testNextConfigUnreachable Error Message: QP failed to shutdown in 30 seconds: QuorumPeer[myid=0]/127.0.0.1:11251 Stack Trace: junit.framework.AssertionFailedError: QP failed to shutdown in 30 seconds: QuorumPeer[myid=0]/127.0.0.1:11251 at org.apache.zookeeper.test.QuorumBase.shutdown(QuorumBase.java:393) at org.apache.zookeeper.server.quorum.QuorumPeerTestBase$TestQPMain.shutdown(QuorumPeerTestBase.java:52) at org.apache.zookeeper.server.quorum.QuorumPeerTestBase$MainThread.shutdown(QuorumPeerTestBase.java:152) at org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testNextConfigUnreachable(ReconfigRecoveryTest.java:268) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) REGRESSION: org.apache.zookeeper.test.DisconnectedWatcherTest.testChildWatcherAutoResetWithChroot Error Message: expected:<0> but was:<1> Stack Trace: junit.framework.AssertionFailedError: expected:<0> but was:<1> at org.apache.zookeeper.test.JMXEnv.ensureOnly(JMXEnv.java:138) at org.apache.zookeeper.test.ClientBase.startServer(ClientBase.java:417) at org.apache.zookeeper.test.DisconnectedWatcherTest.testChildWatcherAutoResetWithChroot(DisconnectedWatcherTest.java:84) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) REGRESSION: org.apache.zookeeper.test.DuplicateLocalSessionUpgradeTest.testLocalSessionUpgradeOnLeader Error Message: waiting for server up Stack Trace: junit.framework.AssertionFailedError: waiting for server up at org.apache.zookeeper.test.QuorumBase.startServers(QuorumBase.java:221) at org.apache.zookeeper.test.QuorumBase.setUp(QuorumBase.java:118) at org.apache.zookeeper.test.QuorumBase.setUp(QuorumBase.java:76) at org.apache.zookeeper.test.DuplicateLocalSessionUpgradeTest.setUp(DuplicateLocalSessionUpgradeTest.java:53) REGRESSION: org.apache.zookeeper.test.FLENewEpochTest.testLENewEpoch Error Message: First leader election failed Stack Trace: junit.framework.AssertionFailedError: First leader election failed at org.apache.zookeeper.test.FLENewEpochTest.testLENewEpoch(FLENewEpochTest.java:177) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) REGRESSION: org.apache.zookeeper.test.FLEZeroWeightTest.testZeroWeightQuorum Error Message: Threads didn't join Stack Trace: junit.framework.AssertionFailedError: Threads didn't join at org.apache.zookeeper.test.FLEZeroWeightTest.testZeroWeightQuorum(FLEZeroWeightTest.java:169) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) REGRESSION: 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:408) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) REGRESSION: org.apache.zookeeper.test.QuorumZxidSyncTest.testLateLogs Error Message: waiting for server up Stack Trace: junit.framework.AssertionFailedError: waiting for server up at org.apache.zookeeper.test.QuorumBase.startServers(QuorumBase.java:221) at org.apache.zookeeper.test.QuorumBase.startServers(QuorumBase.java:130) at org.apache.zookeeper.test.QuorumZxidSyncTest.testLateLogs(QuorumZxidSyncTest.java:143) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) FAILED: org.apache.zookeeper.test.StaticHostProviderTest.testUpdateClientMigrateOrNot Error Message: Timeout occurred. Please note the time in the report does not reflect the time until the timeout. Stack Trace: junit.framework.AssertionFailedError: Timeout occurred. Please note the time in the report does not reflect the time until the timeout. FAILED: org.apache.zookeeper.test.TruncateTest.testTruncate Error Message: delete f:\hudson\hudson-slave\workspace\ZooKeeper-trunk-WinVS2008_java\trunk\build\test\tmp\test9138329483298835632.junit.dir\version-2\log.100000001 Stack Trace: junit.framework.AssertionFailedError: delete f:\hudson\hudson-slave\workspace\ZooKeeper-trunk-WinVS2008_java\trunk\build\test\tmp\test9138329483298835632.junit.dir\version-2\log.100000001 at org.apache.zookeeper.test.ClientBase.recursiveDelete(ClientBase.java:493) at org.apache.zookeeper.test.ClientBase.recursiveDelete(ClientBase.java:493) at org.apache.zookeeper.test.TruncateTest.tearDown(TruncateTest.java:68) FAILED: org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetDisabledWithLocal Error Message: expected:<0> but was:<1> Stack Trace: junit.framework.AssertionFailedError: expected:<0> but was:<1> at org.apache.zookeeper.test.JMXEnv.ensureOnly(JMXEnv.java:138) at org.apache.zookeeper.test.ClientBase.startServer(ClientBase.java:417) at org.apache.zookeeper.test.WatcherTest.testWatcherAutoReset(WatcherTest.java:280) at org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetWithLocal(WatcherTest.java:241) at org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetDisabledWithLocal(WatcherTest.java:254) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) FAILED: org.apache.zookeeper.test.QuorumZxidSyncTest.testBehindLeader Error Message: Servers didn't come up Stack Trace: junit.framework.AssertionFailedError: Servers didn't come up at org.apache.zookeeper.test.QuorumZxidSyncTest.testBehindLeader(QuorumZxidSyncTest.java:87) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) FAILED: org.apache.zookeeper.test.ServerCnxnTest.testServerCnxnExpiry Error Message: Software caused connection abort: recv failed Stack Trace: java.net.SocketException: Software caused connection abort: recv failed at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.read(SocketInputStream.java:129) at sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:264) at sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:306) at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:158) at java.io.InputStreamReader.read(InputStreamReader.java:167) at java.io.BufferedReader.fill(BufferedReader.java:136) at java.io.BufferedReader.readLine(BufferedReader.java:299) at java.io.BufferedReader.readLine(BufferedReader.java:362) at org.apache.zookeeper.test.ServerCnxnTest.send4LetterWord(ServerCnxnTest.java:105) at org.apache.zookeeper.test.ServerCnxnTest.sendRequest(ServerCnxnTest.java:77) at org.apache.zookeeper.test.ServerCnxnTest.testServerCnxnExpiry(ServerCnxnTest.java:64) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) FAILED: org.apache.zookeeper.test.ReconfigTest.testBulkReconfig Error Message: waiting for server up Stack Trace: junit.framework.AssertionFailedError: waiting for server up at org.apache.zookeeper.test.QuorumUtil.startAll(QuorumUtil.java:151) at org.apache.zookeeper.test.ReconfigTest.testBulkReconfig(ReconfigTest.java:361) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) FAILED: org.apache.zookeeper.test.ReconfigTest.testQuorumSystemChange Error Message: waiting for server up Stack Trace: junit.framework.AssertionFailedError: waiting for server up at org.apache.zookeeper.test.QuorumUtil.startAll(QuorumUtil.java:151) at org.apache.zookeeper.test.ReconfigTest.testQuorumSystemChange(ReconfigTest.java:628) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) FAILED: org.apache.zookeeper.test.LETest.testLE Error Message: Threads didn't join Stack Trace: junit.framework.AssertionFailedError: Threads didn't join at org.apache.zookeeper.test.LETest.testLE(LETest.java:123) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) FAILED: org.apache.zookeeper.test.ClientPortBindTest.testBindByAddress Error Message: Address family not supported by protocol family: bind Stack Trace: java.net.SocketException: Address family not supported by protocol family: bind at sun.nio.ch.Net.bind(Native Method) at sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:126) at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:59) at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:52) at org.apache.zookeeper.server.NIOServerCnxnFactory.configure(NIOServerCnxnFactory.java:684) at org.apache.zookeeper.server.ServerCnxnFactory.createFactory(ServerCnxnFactory.java:127) at org.apache.zookeeper.test.ClientPortBindTest.testBindByAddress(ClientPortBindTest.java:84) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) FAILED: org.apache.zookeeper.server.util.DynamicConfigBCTest.dynamicConfigBackwardCompatibilityTest Error Message: null Stack Trace: junit.framework.AssertionFailedError at org.apache.zookeeper.server.util.DynamicConfigBCTest.dynamicConfigBackwardCompatibilityTest(DynamicConfigBCTest.java:141)