See https://builds.apache.org/job/ZooKeeper-trunk-WinVS2008_java/705/
################################################################################### ########################## LAST 60 LINES OF THE CONSOLE ########################### [...truncated 246340 lines...] [junit] 2014-03-12 09:52:53,599 [myid:] - INFO [main:ClientBase@364] - CREATING server instance 127.0.0.1:11221 [junit] 2014-03-12 09:52:53,600 [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] 2014-03-12 09:52:53,601 [myid:] - INFO [main:NIOServerCnxnFactory@683] - binding to port 0.0.0.0/0.0.0.0:11221 [junit] 2014-03-12 09:52:53,602 [myid:] - INFO [main:ClientBase@339] - STARTING server instance 127.0.0.1:11221 [junit] 2014-03-12 09:52:53,602 [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\test6742098565508420874.junit.dir\version-2 snapdir f:\hudson\hudson-slave\workspace\ZooKeeper-trunk-WinVS2008_java\trunk\build\test\tmp\test6742098565508420874.junit.dir\version-2 [junit] 2014-03-12 09:52:53,603 [myid:] - INFO [main:FileSnap@83] - Reading snapshot f:\hudson\hudson-slave\workspace\ZooKeeper-trunk-WinVS2008_java\trunk\build\test\tmp\test6742098565508420874.junit.dir\version-2\snapshot.b [junit] 2014-03-12 09:52:53,605 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to f:\hudson\hudson-slave\workspace\ZooKeeper-trunk-WinVS2008_java\trunk\build\test\tmp\test6742098565508420874.junit.dir\version-2\snapshot.b [junit] 2014-03-12 09:52:53,611 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221 [junit] 2014-03-12 09:52:53,612 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:63918 [junit] 2014-03-12 09:52:53,613 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@835] - Processing stat command from /127.0.0.1:63918 [junit] 2014-03-12 09:52:53,613 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn$StatCommand@684] - Stat command output [junit] 2014-03-12 09:52:53,614 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:63918 (no session established for client) [junit] 2014-03-12 09:52:53,614 [myid:] - INFO [main:JMXEnv@224] - ensureParent:[InMemoryDataTree, StandaloneServer_port] [junit] 2014-03-12 09:52:53,615 [myid:] - INFO [main:JMXEnv@241] - expect:InMemoryDataTree [junit] 2014-03-12 09:52:53,615 [myid:] - INFO [main:JMXEnv@245] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree [junit] 2014-03-12 09:52:53,615 [myid:] - INFO [main:JMXEnv@241] - expect:StandaloneServer_port [junit] 2014-03-12 09:52:53,615 [myid:] - INFO [main:JMXEnv@245] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1 [junit] 2014-03-12 09:52:53,615 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@55] - Memory used 3853 [junit] 2014-03-12 09:52:53,615 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@60] - Number of threads 24 [junit] 2014-03-12 09:52:53,615 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@65] - FINISHED TEST METHOD testQuota [junit] 2014-03-12 09:52:53,616 [myid:] - INFO [main:ClientBase@520] - tearDown starting [junit] 2014-03-12 09:52:53,952 [myid:] - INFO [main-SendThread(127.0.0.1:11221):ClientCnxn$SendThread@971] - Socket connection established to 127.0.0.1/127.0.0.1:11221, initiating session [junit] 2014-03-12 09:52:53,952 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:63913 [junit] 2014-03-12 09:52:53,953 [myid:] - INFO [NIOWorkerThread-2:ZooKeeperServer@858] - Client attempting to renew session 0x144b5b5727b0000 at /127.0.0.1:63913 [junit] 2014-03-12 09:52:53,955 [myid:] - INFO [NIOWorkerThread-2:ZooKeeperServer@604] - Established session 0x144b5b5727b0000 with negotiated timeout 30000 for client /127.0.0.1:63913 [junit] 2014-03-12 09:52:53,956 [myid:] - INFO [main-SendThread(127.0.0.1:11221):ClientCnxn$SendThread@1354] - Session establishment complete on server 127.0.0.1/127.0.0.1:11221, sessionid = 0x144b5b5727b0000, negotiated timeout = 30000 [junit] 2014-03-12 09:52:53,956 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@680] - Processed session termination for sessionid: 0x144b5b5727b0000 [junit] 2014-03-12 09:52:53,957 [myid:] - INFO [SyncThread:0:FileTxnLog@200] - Creating new log file: log.c [junit] 2014-03-12 09:52:53,971 [myid:] - INFO [main:ZooKeeper@954] - Session: 0x144b5b5727b0000 closed [junit] 2014-03-12 09:52:53,971 [myid:] - INFO [main:ClientBase@490] - STOPPING server [junit] 2014-03-12 09:52:53,971 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method [junit] 2014-03-12 09:52:53,971 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@536] - EventThread shut down [junit] 2014-03-12 09:52:53,971 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:63913 which had sessionid 0x144b5b5727b0000 [junit] 2014-03-12 09:52:53,971 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted [junit] 2014-03-12 09:52:53,971 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method [junit] 2014-03-12 09:52:53,972 [myid:] - INFO [main:ZooKeeperServer@428] - shutting down [junit] 2014-03-12 09:52:53,972 [myid:] - INFO [main:SessionTrackerImpl@183] - Shutting down [junit] 2014-03-12 09:52:53,972 [myid:] - INFO [main:PrepRequestProcessor@975] - Shutting down [junit] 2014-03-12 09:52:53,973 [myid:] - INFO [main:SyncRequestProcessor@190] - Shutting down [junit] 2014-03-12 09:52:53,973 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@156] - PrepRequestProcessor exited loop! [junit] 2014-03-12 09:52:53,973 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@168] - SyncRequestProcessor exited! [junit] 2014-03-12 09:52:53,973 [myid:] - INFO [main:FinalRequestProcessor@454] - shutdown of request processor complete [junit] 2014-03-12 09:52:53,974 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221 [junit] 2014-03-12 09:52:54,000 [myid:] - INFO [SessionTracker:SessionTrackerImpl@134] - SessionTrackerImpl exited loop! [junit] 2014-03-12 09:52:54,000 [myid:] - INFO [SessionTracker:SessionTrackerImpl@134] - SessionTrackerImpl exited loop! [junit] 2014-03-12 09:52:54,000 [myid:] - INFO [SessionTracker:SessionTrackerImpl@134] - SessionTrackerImpl exited loop! [junit] 2014-03-12 09:52:54,973 [myid:] - INFO [main:JMXEnv@142] - ensureOnly:[] [junit] 2014-03-12 09:52:54,978 [myid:] - INFO [main:ZKTestCase$1@61] - SUCCEEDED testQuota [junit] 2014-03-12 09:52:54,978 [myid:] - INFO [main:ZKTestCase$1@56] - FINISHED testQuota [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 4.111 sec BUILD FAILED f:\hudson\hudson-slave\workspace\ZooKeeper-trunk-WinVS2008_java\trunk\build.xml:1315: Tests failed! Total time: 80 minutes 52 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) ############################## 16 tests failed. REGRESSION: org.apache.zookeeper.RemoveWatchesTest.testRemoveAllWatchers[1] Error Message: expected [0x144b56e9ace0000] expected:<1> but was:<0> Stack Trace: junit.framework.AssertionFailedError: expected [0x144b56e9ace0000] expected:<1> but was:<0> at org.apache.zookeeper.test.JMXEnv.ensureAll(JMXEnv.java:124) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:196) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:176) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:161) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:154) at org.apache.zookeeper.RemoveWatchesTest.setUp(RemoveWatchesTest.java:55) REGRESSION: org.apache.zookeeper.ZooKeeperTest.testParseWithExtraSpaces Error Message: expected [0x44b57052240001] expected:<1> but was:<0> Stack Trace: junit.framework.AssertionFailedError: expected [0x44b57052240001] expected:<1> but was:<0> at org.apache.zookeeper.test.JMXEnv.ensureAll(JMXEnv.java:124) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:196) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:176) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:161) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:154) at org.apache.zookeeper.ZooKeeperTest.testParseWithExtraSpaces(ZooKeeperTest.java:157) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) REGRESSION: org.apache.zookeeper.ZooKeeperTest.testCreatePersistentNode Error Message: waiting for server up Stack Trace: junit.framework.AssertionFailedError: waiting for server up at org.apache.zookeeper.test.ClientBase.startServerInstance(ClientBase.java:342) at org.apache.zookeeper.test.ClientBase.startServer(ClientBase.java:446) at org.apache.zookeeper.test.ClientBase.setUp(ClientBase.java:437) REGRESSION: org.apache.zookeeper.ZooKeeperTest.testStatCommand Error Message: expected [0x144b57030b50001] expected:<1> but was:<0> Stack Trace: junit.framework.AssertionFailedError: expected [0x144b57030b50001] expected:<1> but was:<0> at org.apache.zookeeper.test.JMXEnv.ensureAll(JMXEnv.java:124) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:196) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:176) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:161) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:154) at org.apache.zookeeper.ZooKeeperTest.testStatCommand(ZooKeeperTest.java:273) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) REGRESSION: org.apache.zookeeper.server.InvalidSnapshotTest.testInvalidSnapshot Error Message: KeeperErrorCode = NoAuth for /invalidsnap-975 Stack Trace: org.apache.zookeeper.KeeperException$NoAuthException: KeeperErrorCode = NoAuth for /invalidsnap-975 at org.apache.zookeeper.KeeperException.create(KeeperException.java:117) at org.apache.zookeeper.KeeperException.create(KeeperException.java:51) at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:1053) at org.apache.zookeeper.server.InvalidSnapshotTest.testInvalidSnapshot(InvalidSnapshotTest.java:56) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) REGRESSION: org.apache.zookeeper.server.NettyServerCnxnTest.testSendCloseSession Error Message: test timed out after 40000 milliseconds Stack Trace: java.lang.Exception: test timed out after 40000 milliseconds at java.lang.Thread.sleep(Native Method) at org.apache.zookeeper.test.JMXEnv.ensureAll(JMXEnv.java:102) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:196) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:176) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:161) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:154) at org.apache.zookeeper.server.NettyServerCnxnTest.testSendCloseSession(NettyServerCnxnTest.java:81) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) REGRESSION: org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest Error Message: Error- Server started in Standalone Mode! Stack Trace: junit.framework.AssertionFailedError: Error- Server started in Standalone Mode! at org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startServer(StandaloneDisabledTest.java:161) at org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startFollowers(StandaloneDisabledTest.java:187) at org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest(StandaloneDisabledTest.java:68) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) REGRESSION: org.apache.zookeeper.test.ChrootClientTest.testACLs Error Message: expected [0x144b5818e2d0019] expected:<1> but was:<0> Stack Trace: junit.framework.AssertionFailedError: expected [0x144b5818e2d0019] expected:<1> but was:<0> at org.apache.zookeeper.test.JMXEnv.ensureAll(JMXEnv.java:124) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:196) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:176) at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:161) at org.apache.zookeeper.test.ChrootClientTest.setUp(ChrootClientTest.java:41) REGRESSION: org.apache.zookeeper.test.FollowerResyncConcurrencyTest.testFollowerSendsLastZxid Error Message: Waiting for server down Stack Trace: junit.framework.AssertionFailedError: Waiting for server down at org.apache.zookeeper.test.QuorumUtil.shutdownAll(QuorumUtil.java:241) at org.apache.zookeeper.test.QuorumUtil.startAll(QuorumUtil.java:143) at org.apache.zookeeper.test.FollowerResyncConcurrencyTest.testFollowerSendsLastZxid(FollowerResyncConcurrencyTest.java:671) at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52) REGRESSION: org.apache.zookeeper.test.LocalSessionRequestTest.testLocalSessionsOnLeader Error Message: waiting for server down Stack Trace: junit.framework.AssertionFailedError: waiting for server down at org.apache.zookeeper.test.QuorumBase.tearDown(QuorumBase.java:360) at org.apache.zookeeper.test.LocalSessionRequestTest.tearDown(LocalSessionRequestTest.java:60) REGRESSION: org.apache.zookeeper.test.ObserverLETest.testLEWithObserver 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.ObserverLETest.establishThreeParticipantOneObserverEnsemble(ObserverLETest.java:37) FAILED: 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) 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) 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:408) 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:150) at java.net.SocketInputStream.read(SocketInputStream.java:121) 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.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.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.