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 2014/04/16 17:27:35 UTC
ZooKeeper-trunk-jdk8 - Build # 9 - Failure
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/9/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 262285 lines...]
[junit] 2014-04-16 15:26:01,324 [myid:] - INFO [main:Environment@99] - Client environment:java.class.path=/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/classes:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/lib/antlr-2.7.6.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/lib/checkstyle-5.0.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/lib/commons-beanutils-core-1.7.0.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/lib/commons-cli-1.0.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/lib/commons-collections-2.0.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/lib/commons-lang-1.0.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/lib/commons-logging-1.0.3.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/lib/google-collections-0.9.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/lib/hamcrest-core-1.1.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/lib/junit-4.9.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/lib/mockito-all-1.8.2.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/classes:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/src/java/lib/ivy-2.2.0.jar:/usr/share/ant/lib/ant.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/lib/commons-cli-1.2.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/lib/javacc.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/lib/jline-2.11.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/lib/log4j-1.2.16.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/lib/netty-3.7.0.Final.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/lib/slf4j-api-1.7.5.jar:/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/lib/slf4j-log4j12-1.7.5.jar:/usr/share/java/ant-launcher-1.8.2.jar:/usr/share/ant/lib/ant-junit.jar:/usr/share/ant/lib/ant-junit4.jar
[junit] 2014-04-16 15:26:01,324 [myid:] - INFO [main:Environment@99] - Client environment:java.library.path=/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
[junit] 2014-04-16 15:26:01,324 [myid:] - INFO [main:Environment@99] - Client environment:java.io.tmpdir=/tmp
[junit] 2014-04-16 15:26:01,325 [myid:] - INFO [main:Environment@99] - Client environment:java.compiler=<NA>
[junit] 2014-04-16 15:26:01,325 [myid:] - INFO [main:Environment@99] - Client environment:os.name=Linux
[junit] 2014-04-16 15:26:01,325 [myid:] - INFO [main:Environment@99] - Client environment:os.arch=amd64
[junit] 2014-04-16 15:26:01,325 [myid:] - INFO [main:Environment@99] - Client environment:os.version=3.2.0-57-generic
[junit] 2014-04-16 15:26:01,325 [myid:] - INFO [main:Environment@99] - Client environment:user.name=jenkins
[junit] 2014-04-16 15:26:01,325 [myid:] - INFO [main:Environment@99] - Client environment:user.home=/home/jenkins
[junit] 2014-04-16 15:26:01,326 [myid:] - INFO [main:Environment@99] - Client environment:user.dir=/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test
[junit] 2014-04-16 15:26:01,327 [myid:] - INFO [main:ZooKeeper@707] - Initiating client connection, connectString=127.0.0.1:11221 sessionTimeout=30000 watcher=org.apache.zookeeper.test.ClientBase$CountdownWatcher@4411d970
[junit] 2014-04-16 15:26:01,355 [myid:] - INFO [main-SendThread(127.0.0.1:11221):Login@287] - successfully logged in.
[junit] 2014-04-16 15:26:01,355 [myid:] - INFO [main-SendThread(127.0.0.1:11221):ZooKeeperSaslClient@235] - Client will use DIGEST-MD5 as SASL mechanism.
[junit] 2014-04-16 15:26:01,356 [myid:] - INFO [main-SendThread(127.0.0.1:11221):ClientCnxn$SendThread@1093] - Opening socket connection to server 127.0.0.1/127.0.0.1:11221. Will attempt to SASL-authenticate using Login Context section 'Client'
[junit] 2014-04-16 15:26:01,357 [myid:] - INFO [main-SendThread(127.0.0.1:11221):ClientCnxn$SendThread@963] - Socket connection established to 127.0.0.1/127.0.0.1:11221, initiating session
[junit] 2014-04-16 15:26:01,357 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:52288
[junit] 2014-04-16 15:26:01,360 [myid:] - INFO [NIOWorkerThread-2:ZooKeeperServer@853] - Client attempting to establish new session at /127.0.0.1:52288
[junit] 2014-04-16 15:26:01,363 [myid:] - INFO [SyncThread:0:FileTxnLog@200] - Creating new log file: log.1
Build timed out (after 60 minutes). Marking the build as failed.
[junit] 2014-04-16 15:26:01,493 [myid:] - INFO [SyncThread:0:ZooKeeperServer@604] - Established session 0x1456b250bea0000 with negotiated timeout 30000 for client /127.0.0.1:52288
[junit] 2014-04-16 15:26:01,495 [myid:] - INFO [main-SendThread(127.0.0.1:11221):ClientCnxn$SendThread@1346] - Session establishment complete on server 127.0.0.1/127.0.0.1:11221, sessionid = 0x1456b250bea0000, negotiated timeout = 30000
[junit] 2014-04-16 15:26:01,499 [myid:] - INFO [main:JMXEnv@113] - expect:0x1456b250bea0000
[junit] 2014-04-16 15:26:01,500 [myid:] - INFO [main:JMXEnv@116] - found:0x1456b250bea0000 org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x1456b250bea0000
[junit] 2014-04-16 15:26:01,508 [myid:] - WARN [NIOWorkerThread-6:ZooKeeperServer@964] - Client failed to SASL authenticate: javax.security.sasl.SaslException: DIGEST-MD5: digest response format violation. Mismatched response.
[junit] 2014-04-16 15:26:01,508 [myid:] - WARN [NIOWorkerThread-6:ZooKeeperServer@968] - Maintaining client connection despite SASL authentication failure.
[junit] 2014-04-16 15:26:01,509 [myid:] - ERROR [main-SendThread(127.0.0.1:11221):ZooKeeperSaslClient@323] - SASL authentication failed using login context 'Client'.
[junit] 2014-04-16 15:26:01,510 [myid:] - WARN [NIOWorkerThread-9:NIOServerCnxn@368] - Unable to read additional data from client sessionid 0x1456b250bea0000, likely client has closed socket
[junit] 2014-04-16 15:26:01,511 [myid:] - INFO [NIOWorkerThread-9:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:52288 which had sessionid 0x1456b250bea0000
[junit] 2014-04-16 15:26:01,522 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@851] - Got user-level KeeperException when processing sessionid:0x1456b250bea0000 type:create cxid:0x3 zxid:0x2 txntype:-1 reqpath:n/a Error Path:/path1 Error:KeeperErrorCode = InvalidACL for /path1
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[junit] 2014-04-16 15:26:01,611 [myid:] - INFO [main:SaslAuthFailTest@71] - Got exception as expected: org.apache.zookeeper.KeeperException$AuthFailedException: KeeperErrorCode = AuthFailed for /path1
[junit] 2014-04-16 15:26:01,611 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@55] - Memory used 3732
[junit] 2014-04-16 15:26:01,612 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@60] - Number of threads 29
[junit] 2014-04-16 15:26:01,612 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@65] - FINISHED TEST METHOD testAuthFail
[junit] 2014-04-16 15:26:01,612 [myid:] - INFO [main:ClientBase@520] - tearDown starting
[junit] 2014-04-16 15:26:01,612 [myid:] - INFO [main:ClientBase@490] - STOPPING server
[junit] 2014-04-16 15:26:01,613 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2014-04-16 15:26:01,614 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2014-04-16 15:26:01,615 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-16 15:26:01,615 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-16 15:26:01,616 [myid:] - INFO [main:ZooKeeperServer@428] - shutting down
[junit] 2014-04-16 15:26:01,616 [myid:] - INFO [main:SessionTrackerImpl@184] - Shutting down
[junit] 2014-04-16 15:26:01,616 [myid:] - INFO [main:PrepRequestProcessor@980] - Shutting down
[junit] 2014-04-16 15:26:01,617 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2014-04-16 15:26:01,617 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@155] - PrepRequestProcessor exited loop!
[junit] 2014-04-16 15:26:01,617 [myid:] - INFO [main:FinalRequestProcessor@454] - shutdown of request processor complete
[junit] 2014-04-16 15:26:01,617 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2014-04-16 15:26:01,618 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-16 15:26:01,621 [myid:] - INFO [main:JMXEnv@142] - ensureOnly:[]
[junit] 2014-04-16 15:26:01,625 [myid:] - INFO [main:ClientBase@545] - fdcount after test is: 45 at start it was 37
[junit] 2014-04-16 15:26:01,625 [myid:] - INFO [main:ClientBase@547] - sleeping for 20 secs
[junit] 2014-04-16 15:26:01,626 [myid:] - INFO [main:ZKTestCase$1@61] - SUCCEEDED testAuthFail
[junit] 2014-04-16 15:26:01,626 [myid:] - INFO [main:ZKTestCase$1@56] - FINISHED testAuthFail
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.702 sec
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any) ##############################
7 tests failed.
REGRESSION: org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testCurrentServersAreObserversInNextConfig
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.
REGRESSION: org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest
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:153)
at org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest(StandaloneDisabledTest.java:75)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
REGRESSION: org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetWithGlobal
Error Message:
KeeperErrorCode = ConnectionLoss for /watchtest/child
Stack Trace:
org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /watchtest/child
at org.apache.zookeeper.KeeperException.create(KeeperException.java:99)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.delete(ZooKeeper.java:1264)
at org.apache.zookeeper.test.WatcherTest.testWatcherAutoReset(WatcherTest.java:375)
at org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetWithGlobal(WatcherTest.java:231)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
REGRESSION: org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetWithLocal
Error Message:
Unable to connect to server
Stack Trace:
junit.framework.AssertionFailedError: Unable to connect to server
at org.apache.zookeeper.test.ClientBase.createClient(ClientBase.java:187)
at org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetWithLocal(WatcherTest.java:239)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
REGRESSION: org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetDisabledWithGlobal
Error Message:
Unexpected bean exists! expected:<0> but was:<1>
Stack Trace:
junit.framework.AssertionFailedError: Unexpected bean exists! expected:<0> but was:<1>
at org.apache.zookeeper.test.ClientBase.verifyUnexpectedBeans(ClientBase.java:475)
at org.apache.zookeeper.test.ClientBase.startServer(ClientBase.java:454)
at org.apache.zookeeper.test.ClientBase.setUp(ClientBase.java:437)
at org.apache.zookeeper.test.WatcherTest.setUp(WatcherTest.java:73)
REGRESSION: org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetDisabledWithLocal
Error Message:
Unexpected bean exists! expected:<0> but was:<1>
Stack Trace:
junit.framework.AssertionFailedError: Unexpected bean exists! expected:<0> but was:<1>
at org.apache.zookeeper.test.ClientBase.verifyUnexpectedBeans(ClientBase.java:475)
at org.apache.zookeeper.test.ClientBase.startServer(ClientBase.java:454)
at org.apache.zookeeper.test.ClientBase.setUp(ClientBase.java:437)
at org.apache.zookeeper.test.WatcherTest.setUp(WatcherTest.java:73)
FAILED: TEST-org.apache.zookeeper.test.SaslAuthFailTest.xml.<init>
Error Message:
Stack Trace:
Failed to read test report file /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/logs/TEST-org.apache.zookeeper.test.SaslAuthFailTest.xml
org.dom4j.DocumentException: Error on line 77 of document file:///home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/logs/TEST-org.apache.zookeeper.test.SaslAuthFailTest.xml : XML document structures must start and end within the same entity. Nested exception: XML document structures must start and end within the same entity.
at org.dom4j.io.SAXReader.read(SAXReader.java:482)
at org.dom4j.io.SAXReader.read(SAXReader.java:264)
at hudson.tasks.junit.SuiteResult.parse(SuiteResult.java:123)
at hudson.tasks.junit.TestResult.parse(TestResult.java:273)
at hudson.tasks.junit.TestResult.parsePossiblyEmpty(TestResult.java:229)
at hudson.tasks.junit.TestResult.parse(TestResult.java:164)
at hudson.tasks.junit.TestResult.parse(TestResult.java:147)
at hudson.tasks.junit.TestResult.<init>(TestResult.java:123)
at hudson.tasks.junit.JUnitParser$ParseResultCallable.invoke(JUnitParser.java:117)
at hudson.tasks.junit.JUnitParser$ParseResultCallable.invoke(JUnitParser.java:90)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2462)
at hudson.remoting.UserRequest.perform(UserRequest.java:118)
at hudson.remoting.UserRequest.perform(UserRequest.java:48)
at hudson.remoting.Request$2.run(Request.java:328)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
at java.util.concurrent.FutureTask.run(FutureTask.java:166)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:724)
Caused by: org.xml.sax.SAXParseException; systemId: file:///home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/logs/TEST-org.apache.zookeeper.test.SaslAuthFailTest.xml; lineNumber: 77; columnNumber: 1; XML document structures must start and end within the same entity.
at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:198)
at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.fatalError(ErrorHandlerWrapper.java:177)
at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:441)
at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:368)
at com.sun.org.apache.xerces.internal.impl.XMLScanner.reportFatalError(XMLScanner.java:1388)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.endEntity(XMLDocumentFragmentScannerImpl.java:865)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl.endEntity(XMLDocumentScannerImpl.java:564)
at com.sun.org.apache.xerces.internal.impl.XMLEntityManager.endEntity(XMLEntityManager.java:1356)
at com.sun.org.apache.xerces.internal.impl.XMLEntityScanner.load(XMLEntityScanner.java:1774)
at com.sun.org.apache.xerces.internal.impl.XMLEntityScanner.skipChar(XMLEntityScanner.java:1426)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl$FragmentContentDriver.next(XMLDocumentFragmentScannerImpl.java:2754)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl.next(XMLDocumentScannerImpl.java:607)
at com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.next(XMLNSDocumentScannerImpl.java:116)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanDocument(XMLDocumentFragmentScannerImpl.java:489)
at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:835)
at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:764)
at com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(XMLParser.java:123)
at com.sun.org.apache.xerces.internal.parsers.AbstractSAXParser.parse(AbstractSAXParser.java:1210)
at com.sun.org.apache.xerces.internal.jaxp.SAXParserImpl$JAXPSAXParser.parse(SAXParserImpl.java:568)
at org.dom4j.io.SAXReader.read(SAXReader.java:465)
... 19 more
Nested exception:
org.xml.sax.SAXParseException; systemId: file:///home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/logs/TEST-org.apache.zookeeper.test.SaslAuthFailTest.xml; lineNumber: 77; columnNumber: 1; XML document structures must start and end within the same entity.
at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:198)
at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.fatalError(ErrorHandlerWrapper.java:177)
at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:441)
at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:368)
at com.sun.org.apache.xerces.internal.impl.XMLScanner.reportFatalError(XMLScanner.java:1388)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.endEntity(XMLDocumentFragmentScannerImpl.java:865)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl.endEntity(XMLDocumentScannerImpl.java:564)
at com.sun.org.apache.xerces.internal.impl.XMLEntityManager.endEntity(XMLEntityManager.java:1356)
at com.sun.org.apache.xerces.internal.impl.XMLEntityScanner.load(XMLEntityScanner.java:1774)
at com.sun.org.apache.xerces.internal.impl.XMLEntityScanner.skipChar(XMLEntityScanner.java:1426)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl$FragmentContentDriver.next(XMLDocumentFragmentScannerImpl.java:2754)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl.next(XMLDocumentScannerImpl.java:607)
at com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.next(XMLNSDocumentScannerImpl.java:116)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanDocument(XMLDocumentFragmentScannerImpl.java:489)
at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:835)
at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:764)
at com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(XMLParser.java:123)
at com.sun.org.apache.xerces.internal.parsers.AbstractSAXParser.parse(AbstractSAXParser.java:1210)
at com.sun.org.apache.xerces.internal.jaxp.SAXParserImpl$JAXPSAXParser.parse(SAXParserImpl.java:568)
at org.dom4j.io.SAXReader.read(SAXReader.java:465)
at org.dom4j.io.SAXReader.read(SAXReader.java:264)
at hudson.tasks.junit.SuiteResult.parse(SuiteResult.java:123)
at hudson.tasks.junit.TestResult.parse(TestResult.java:273)
at hudson.tasks.junit.TestResult.parsePossiblyEmpty(TestResult.java:229)
at hudson.tasks.junit.TestResult.parse(TestResult.java:164)
at hudson.tasks.junit.TestResult.parse(TestResult.java:147)
at hudson.tasks.junit.TestResult.<init>(TestResult.java:123)
at hudson.tasks.junit.JUnitParser$ParseResultCallable.invoke(JUnitParser.java:117)
at hudson.tasks.junit.JUnitParser$ParseResultCallable.invoke(JUnitParser.java:90)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2462)
at hudson.remoting.UserRequest.perform(UserRequest.java:118)
at hudson.remoting.UserRequest.perform(UserRequest.java:48)
at hudson.remoting.Request$2.run(Request.java:328)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
at java.util.concurrent.FutureTask.run(FutureTask.java:166)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:724)
ZooKeeper-trunk-jdk8 - Build # 19 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/19/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 274375 lines...]
[junit] 2014-04-27 11:24:12,315 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-27 11:24:12,315 [myid:] - INFO [main:JMXEnv@142] - ensureOnly:[]
[junit] 2014-04-27 11:24:12,316 [myid:] - INFO [main:ClientBase@443] - STARTING server
[junit] 2014-04-27 11:24:12,317 [myid:] - INFO [main:ClientBase@364] - CREATING server instance 127.0.0.1:11221
[junit] 2014-04-27 11:24:12,317 [myid:] - INFO [main:NIOServerCnxnFactory@670] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2014-04-27 11:24:12,317 [myid:] - INFO [main:NIOServerCnxnFactory@683] - binding to port 0.0.0.0/0.0.0.0:11221
[junit] 2014-04-27 11:24:12,318 [myid:] - INFO [main:ClientBase@339] - STARTING server instance 127.0.0.1:11221
[junit] 2014-04-27 11:24:12,318 [myid:] - INFO [main:ZooKeeperServer@766] - minSessionTimeout set to 6000
[junit] 2014-04-27 11:24:12,318 [myid:] - INFO [main:ZooKeeperServer@775] - maxSessionTimeout set to 60000
[junit] 2014-04-27 11:24:12,318 [myid:] - INFO [main:ZooKeeperServer@149] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test3345792095088560853.junit.dir/version-2 snapdir /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test3345792095088560853.junit.dir/version-2
[junit] 2014-04-27 11:24:12,319 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test3345792095088560853.junit.dir/version-2/snapshot.b
[junit] 2014-04-27 11:24:12,321 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test3345792095088560853.junit.dir/version-2/snapshot.b
[junit] 2014-04-27 11:24:12,323 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-27 11:24:12,323 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:36280
[junit] 2014-04-27 11:24:12,324 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@835] - Processing stat command from /127.0.0.1:36280
[junit] 2014-04-27 11:24:12,324 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn$StatCommand@684] - Stat command output
[junit] 2014-04-27 11:24:12,325 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:36280 (no session established for client)
[junit] 2014-04-27 11:24:12,325 [myid:] - INFO [main:JMXEnv@224] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2014-04-27 11:24:12,326 [myid:] - INFO [main:JMXEnv@241] - expect:InMemoryDataTree
[junit] 2014-04-27 11:24:12,326 [myid:] - INFO [main:JMXEnv@245] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] 2014-04-27 11:24:12,327 [myid:] - INFO [main:JMXEnv@241] - expect:StandaloneServer_port
[junit] 2014-04-27 11:24:12,327 [myid:] - INFO [main:JMXEnv@245] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2014-04-27 11:24:12,327 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@55] - Memory used 3508
[junit] 2014-04-27 11:24:12,327 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@60] - Number of threads 24
[junit] 2014-04-27 11:24:12,327 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@65] - FINISHED TEST METHOD testQuota
[junit] 2014-04-27 11:24:12,328 [myid:] - INFO [main:ClientBase@520] - tearDown starting
[junit] 2014-04-27 11:24:12,392 [myid:] - INFO [main:ZooKeeper@966] - Session: 0x145a2ed9b070000 closed
[junit] 2014-04-27 11:24:12,392 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@529] - EventThread shut down
[junit] 2014-04-27 11:24:12,393 [myid:] - INFO [main:ClientBase@490] - STOPPING server
[junit] 2014-04-27 11:24:12,393 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2014-04-27 11:24:12,393 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-27 11:24:12,393 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-27 11:24:12,393 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2014-04-27 11:24:12,394 [myid:] - INFO [main:ZooKeeperServer@428] - shutting down
[junit] 2014-04-27 11:24:12,394 [myid:] - INFO [main:SessionTrackerImpl@184] - Shutting down
[junit] 2014-04-27 11:24:12,394 [myid:] - INFO [main:PrepRequestProcessor@980] - Shutting down
[junit] 2014-04-27 11:24:12,394 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2014-04-27 11:24:12,394 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@155] - PrepRequestProcessor exited loop!
[junit] 2014-04-27 11:24:12,394 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2014-04-27 11:24:12,395 [myid:] - INFO [main:FinalRequestProcessor@462] - shutdown of request processor complete
[junit] 2014-04-27 11:24:12,395 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-27 11:24:12,396 [myid:] - INFO [main:JMXEnv@142] - ensureOnly:[]
[junit] 2014-04-27 11:24:12,399 [myid:] - INFO [main:ClientBase@545] - fdcount after test is: 46 at start it was 30
[junit] 2014-04-27 11:24:12,399 [myid:] - INFO [main:ClientBase@547] - sleeping for 20 secs
[junit] 2014-04-27 11:24:12,401 [myid:] - INFO [main:ZKTestCase$1@61] - SUCCEEDED testQuota
[junit] 2014-04-27 11:24:12,401 [myid:] - INFO [main:ZKTestCase$1@56] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.77 sec
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build.xml:1337: Tests failed!
Total time: 47 minutes 56 seconds
Build step 'Execute shell' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
REGRESSION: org.apache.zookeeper.server.quorum.CommitProcessorTest.testManyCommitWorkers
Error Message:
Forked Java VM exited abnormally. Please note the time in the report does not reflect the time until the VM exit.
Stack Trace:
junit.framework.AssertionFailedError: Forked Java VM exited abnormally. Please note the time in the report does not reflect the time until the VM exit.
$PROJECT_NAME - Build # $BUILD_NUMBER - $BUILD_STATUS
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See ${BUILD_URL}
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
${BUILD_LOG, maxLines=60}
###################################################################################
############################## FAILED TESTS (if any) ##############################
${FAILED_TESTS}
ZooKeeper-trunk-jdk8 - Build # 17 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/17/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 274128 lines...]
[junit] 2014-04-25 12:35:08,747 [myid:] - INFO [main:ZkDatabaseCorruptionTest@130] - 127.0.0.1:11232 is accepting client connections
[junit] 2014-04-25 12:35:08,747 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11233
[junit] 2014-04-25 12:35:08,747 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11233:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:45271
[junit] 2014-04-25 12:35:08,748 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@835] - Processing stat command from /127.0.0.1:45271
[junit] 2014-04-25 12:35:08,749 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn$StatCommand@684] - Stat command output
[junit] 2014-04-25 12:35:08,749 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:45271 (no session established for client)
[junit] 2014-04-25 12:35:08,749 [myid:] - INFO [main:ZkDatabaseCorruptionTest@130] - 127.0.0.1:11233 is accepting client connections
[junit] 2014-04-25 12:35:08,750 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11234
[junit] 2014-04-25 12:35:08,750 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11234:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:38622
[junit] 2014-04-25 12:35:08,751 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@835] - Processing stat command from /127.0.0.1:38622
[junit] 2014-04-25 12:35:08,751 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn$StatCommand@684] - Stat command output
[junit] 2014-04-25 12:35:08,752 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:38622 (no session established for client)
[junit] 2014-04-25 12:35:08,752 [myid:] - INFO [main:ZkDatabaseCorruptionTest@130] - 127.0.0.1:11234 is accepting client connections
[junit] 2014-04-25 12:35:08,752 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11235
[junit] 2014-04-25 12:35:08,752 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11235:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:45986
[junit] 2014-04-25 12:35:08,753 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@835] - Processing stat command from /127.0.0.1:45986
[junit] 2014-04-25 12:35:08,754 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn$StatCommand@684] - Stat command output
[junit] 2014-04-25 12:35:08,754 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:45986 (no session established for client)
[junit] 2014-04-25 12:35:08,754 [myid:] - INFO [main:ZkDatabaseCorruptionTest@130] - 127.0.0.1:11235 is accepting client connections
[junit] 2014-04-25 12:35:08,755 [myid:] - INFO [main:ZkDatabaseCorruptionTest@132] - Skipping the leader
[junit] 2014-04-25 12:35:08,756 [myid:] - INFO [main:ZooKeeper@707] - Initiating client connection, connectString=127.0.0.1:11232,127.0.0.1:11233,127.0.0.1:11234,127.0.0.1:11235,127.0.0.1:11236 sessionTimeout=30000 watcher=org.apache.zookeeper.test.ClientBase$CountdownWatcher@735f7ae5
[junit] 2014-04-25 12:35:08,757 [myid:] - INFO [main-SendThread(127.0.0.1:11232):ClientCnxn$SendThread@1093] - Opening socket connection to server 127.0.0.1/127.0.0.1:11232. Will not attempt to authenticate using SASL (unknown error)
[junit] 2014-04-25 12:35:08,758 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11232:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:35993
[junit] 2014-04-25 12:35:08,758 [myid:] - INFO [main-SendThread(127.0.0.1:11232):ClientCnxn$SendThread@963] - Socket connection established to 127.0.0.1/127.0.0.1:11232, initiating session
[junit] 2014-04-25 12:35:08,759 [myid:] - INFO [NIOWorkerThread-8:ZooKeeperServer@853] - Client attempting to establish new session at /127.0.0.1:35993
[junit] 2014-04-25 12:35:08,762 [myid:] - INFO [SyncThread:4:FileTxnLog@200] - Creating new log file: log.200000001
[junit] 2014-04-25 12:35:08,763 [myid:] - WARN [QuorumPeer[myid=3]/0:0:0:0:0:0:0:0:11234:Follower@121] - Got zxid 0x200000001 expected 0x1
[junit] 2014-04-25 12:35:08,763 [myid:] - WARN [QuorumPeer[myid=2]/0:0:0:0:0:0:0:0:11233:Follower@121] - Got zxid 0x200000001 expected 0x1
[junit] 2014-04-25 12:35:08,763 [myid:] - WARN [QuorumPeer[myid=1]/0:0:0:0:0:0:0:0:11232:Follower@121] - Got zxid 0x200000001 expected 0x1
[junit] 2014-04-25 12:35:08,763 [myid:] - INFO [SyncThread:2:FileTxnLog@200] - Creating new log file: log.200000001
[junit] 2014-04-25 12:35:08,763 [myid:] - INFO [SyncThread:3:FileTxnLog@200] - Creating new log file: log.200000001
[junit] 2014-04-25 12:35:08,763 [myid:] - INFO [SyncThread:1:FileTxnLog@200] - Creating new log file: log.200000001
[junit] 2014-04-25 12:35:08,912 [myid:] - INFO [CommitProcWorkThread-9:ZooKeeperServer@604] - Established session 0x14598e1d69d0000 with negotiated timeout 30000 for client /127.0.0.1:35993
[junit] 2014-04-25 12:35:08,913 [myid:] - INFO [main-SendThread(127.0.0.1:11232):ClientCnxn$SendThread@1346] - Session establishment complete on server 127.0.0.1/127.0.0.1:11232, sessionid = 0x14598e1d69d0000, negotiated timeout = 30000
[junit] 2014-04-25 12:35:08,919 [myid:] - INFO [main:JMXEnv@113] - expect:0x14598e1d69d0000
[junit] 2014-04-25 12:35:08,919 [myid:] - INFO [main:JMXEnv@116] - found:0x14598e1d69d0000 org.apache.ZooKeeperService:name0=ReplicatedServer_id1,name1=replica.1,name2=Follower,name3=Connections,name4=127.0.0.1,name5=0x14598e1d69d0000
[junit] 2014-04-25 12:35:10,951 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000048 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8164843032837091271.junit.dir/version-2/snapshot.200000048
[junit] 2014-04-25 12:35:10,974 [myid:] - INFO [SyncThread:1:FileTxnLog@200] - Creating new log file: log.20000004a
[junit] 2014-04-25 12:35:11,182 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x20000004f to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test4516132787339648363.junit.dir/version-2/snapshot.20000004f
[junit] 2014-04-25 12:35:11,182 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x20000004f to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8896974237850678125.junit.dir/version-2/snapshot.20000004f
[junit] 2014-04-25 12:35:11,206 [myid:] - INFO [SyncThread:4:FileTxnLog@200] - Creating new log file: log.200000051
[junit] 2014-04-25 12:35:11,206 [myid:] - INFO [SyncThread:2:FileTxnLog@200] - Creating new log file: log.200000051
[junit] 2014-04-25 12:35:11,367 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000051 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test5985989361498137423.junit.dir/version-2/snapshot.200000051
[junit] 2014-04-25 12:35:11,387 [myid:] - INFO [SyncThread:3:FileTxnLog@200] - Creating new log file: log.200000053
[junit] 2014-04-25 12:35:13,943 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000087 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8896974237850678125.junit.dir/version-2/snapshot.200000087
[junit] 2014-04-25 12:35:13,985 [myid:] - INFO [SyncThread:2:FileTxnLog@200] - Creating new log file: log.200000089
[junit] 2014-04-25 12:35:14,186 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x20000008c to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test5985989361498137423.junit.dir/version-2/snapshot.20000008c
[junit] 2014-04-25 12:35:14,232 [myid:] - INFO [SyncThread:3:FileTxnLog@200] - Creating new log file: log.20000008e
[junit] 2014-04-25 12:35:15,122 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x2000000a5 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8164843032837091271.junit.dir/version-2/snapshot.2000000a5
[junit] 2014-04-25 12:35:15,163 [myid:] - INFO [SyncThread:1:FileTxnLog@200] - Creating new log file: log.2000000a7
[junit] 2014-04-25 12:35:15,425 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x2000000ad to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test4516132787339648363.junit.dir/version-2/snapshot.2000000ad
Build timed out (after 60 minutes). Marking the build as failed.
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[junit] 2014-04-25 12:35:15,449 [myid:] - INFO [SyncThread:4:FileTxnLog@200] - Creating new log file: log.2000000af
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any) ##############################
2 tests failed.
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: TEST-org.apache.zookeeper.test.ZkDatabaseCorruptionTest.xml.<init>
Error Message:
Stack Trace:
Test report file /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/logs/TEST-org.apache.zookeeper.test.ZkDatabaseCorruptionTest.xml was length 0
ZooKeeper-trunk-jdk8 - Build # 16 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/16/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 238710 lines...]
[junit] 2014-04-23 16:54:22,317 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2014-04-23 16:54:22,318 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2014-04-23 16:54:22,317 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@155] - PrepRequestProcessor exited loop!
[junit] 2014-04-23 16:54:22,318 [myid:] - INFO [main:FinalRequestProcessor@462] - shutdown of request processor complete
[junit] 2014-04-23 16:54:22,318 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-23 16:54:22,319 [myid:] - INFO [main:JMXEnv@142] - ensureOnly:[]
[junit] 2014-04-23 16:54:22,320 [myid:] - INFO [main:ClientBase@443] - STARTING server
[junit] 2014-04-23 16:54:22,320 [myid:] - INFO [main:ClientBase@364] - CREATING server instance 127.0.0.1:11221
[junit] 2014-04-23 16:54:22,320 [myid:] - INFO [main:NIOServerCnxnFactory@670] - Configuring NIO connection handler with 10s sessionless connection timeout, 3 selector thread(s), 48 worker threads, and 64 kB direct buffers.
[junit] 2014-04-23 16:54:22,327 [myid:] - INFO [main:NIOServerCnxnFactory@683] - binding to port 0.0.0.0/0.0.0.0:11221
[junit] 2014-04-23 16:54:22,328 [myid:] - INFO [main:ClientBase@339] - STARTING server instance 127.0.0.1:11221
[junit] 2014-04-23 16:54:22,328 [myid:] - INFO [main:ZooKeeperServer@766] - minSessionTimeout set to 6000
[junit] 2014-04-23 16:54:22,328 [myid:] - INFO [main:ZooKeeperServer@775] - maxSessionTimeout set to 60000
[junit] 2014-04-23 16:54:22,328 [myid:] - INFO [main:ZooKeeperServer@149] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8578587173622632695.junit.dir/version-2 snapdir /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8578587173622632695.junit.dir/version-2
[junit] 2014-04-23 16:54:22,329 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8578587173622632695.junit.dir/version-2/snapshot.b
[junit] 2014-04-23 16:54:22,333 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8578587173622632695.junit.dir/version-2/snapshot.b
[junit] 2014-04-23 16:54:22,335 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-23 16:54:22,335 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:57046
[junit] 2014-04-23 16:54:22,336 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@835] - Processing stat command from /127.0.0.1:57046
[junit] 2014-04-23 16:54:22,336 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn$StatCommand@684] - Stat command output
[junit] 2014-04-23 16:54:22,337 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:57046 (no session established for client)
[junit] 2014-04-23 16:54:22,337 [myid:] - INFO [main:JMXEnv@224] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2014-04-23 16:54:22,338 [myid:] - INFO [main:JMXEnv@241] - expect:InMemoryDataTree
[junit] 2014-04-23 16:54:22,339 [myid:] - INFO [main:JMXEnv@245] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] 2014-04-23 16:54:22,339 [myid:] - INFO [main:JMXEnv@241] - expect:StandaloneServer_port
[junit] 2014-04-23 16:54:22,339 [myid:] - INFO [main:JMXEnv@245] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2014-04-23 16:54:22,339 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@55] - Memory used 3651
[junit] 2014-04-23 16:54:22,339 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@60] - Number of threads 25
[junit] 2014-04-23 16:54:22,340 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@65] - FINISHED TEST METHOD testQuota
[junit] 2014-04-23 16:54:22,340 [myid:] - INFO [main:ClientBase@520] - tearDown starting
[junit] 2014-04-23 16:54:22,385 [myid:] - INFO [main:ZooKeeper@966] - Session: 0x1458f82712c0000 closed
[junit] 2014-04-23 16:54:22,385 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@529] - EventThread shut down
[junit] 2014-04-23 16:54:22,385 [myid:] - INFO [main:ClientBase@490] - STOPPING server
[junit] 2014-04-23 16:54:22,388 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2014-04-23 16:54:22,389 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-23 16:54:22,389 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-23 16:54:22,392 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2014-04-23 16:54:22,392 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-2:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-23 16:54:22,396 [myid:] - INFO [main:ZooKeeperServer@428] - shutting down
[junit] 2014-04-23 16:54:22,396 [myid:] - INFO [main:SessionTrackerImpl@184] - Shutting down
[junit] 2014-04-23 16:54:22,396 [myid:] - INFO [main:PrepRequestProcessor@980] - Shutting down
[junit] 2014-04-23 16:54:22,396 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2014-04-23 16:54:22,396 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@155] - PrepRequestProcessor exited loop!
[junit] 2014-04-23 16:54:22,396 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2014-04-23 16:54:22,400 [myid:] - INFO [main:FinalRequestProcessor@462] - shutdown of request processor complete
[junit] 2014-04-23 16:54:22,400 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-23 16:54:22,401 [myid:] - INFO [main:JMXEnv@142] - ensureOnly:[]
[junit] 2014-04-23 16:54:22,404 [myid:] - INFO [main:ClientBase@545] - fdcount after test is: 47 at start it was 31
[junit] 2014-04-23 16:54:22,404 [myid:] - INFO [main:ClientBase@547] - sleeping for 20 secs
[junit] 2014-04-23 16:54:22,405 [myid:] - INFO [main:ZKTestCase$1@61] - SUCCEEDED testQuota
[junit] 2014-04-23 16:54:22,405 [myid:] - INFO [main:ZKTestCase$1@56] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.964 sec
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build.xml:1337: Tests failed!
Total time: 60 minutes 0 seconds
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any) ##############################
4 tests failed.
REGRESSION: org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest
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:153)
at org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest(StandaloneDisabledTest.java:75)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
REGRESSION: org.apache.zookeeper.test.LETest.testLE
Error Message:
Address already in use
Stack Trace:
java.net.BindException: Address already in use
at sun.nio.ch.Net.bind0(Native Method)
at sun.nio.ch.Net.bind(Net.java:414)
at sun.nio.ch.Net.bind(Net.java:406)
at sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:214)
at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:74)
at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:67)
at org.apache.zookeeper.server.NIOServerCnxnFactory.configure(NIOServerCnxnFactory.java:684)
at org.apache.zookeeper.server.ServerCnxnFactory.createFactory(ServerCnxnFactory.java:127)
at org.apache.zookeeper.server.quorum.QuorumPeer.<init>(QuorumPeer.java:741)
at org.apache.zookeeper.test.LETest.testLE(LETest.java:112)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
REGRESSION: org.apache.zookeeper.test.StaticHostProviderTest.testUpdateLoadBalancing
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.
REGRESSION: org.apache.zookeeper.test.ZkDatabaseCorruptionTest.testCorruption
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-trunk-jdk8 - Build # 15 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/15/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 265969 lines...]
[junit] 2014-04-22 18:34:36,444 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-22 18:34:36,445 [myid:] - INFO [main:JMXEnv@142] - ensureOnly:[]
[junit] 2014-04-22 18:34:36,446 [myid:] - INFO [main:ClientBase@443] - STARTING server
[junit] 2014-04-22 18:34:36,446 [myid:] - INFO [main:ClientBase@364] - CREATING server instance 127.0.0.1:11221
[junit] 2014-04-22 18:34:36,446 [myid:] - INFO [main:NIOServerCnxnFactory@670] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2014-04-22 18:34:36,447 [myid:] - INFO [main:NIOServerCnxnFactory@683] - binding to port 0.0.0.0/0.0.0.0:11221
[junit] 2014-04-22 18:34:36,447 [myid:] - INFO [main:ClientBase@339] - STARTING server instance 127.0.0.1:11221
[junit] 2014-04-22 18:34:36,447 [myid:] - INFO [main:ZooKeeperServer@766] - minSessionTimeout set to 6000
[junit] 2014-04-22 18:34:36,448 [myid:] - INFO [main:ZooKeeperServer@775] - maxSessionTimeout set to 60000
[junit] 2014-04-22 18:34:36,448 [myid:] - INFO [main:ZooKeeperServer@149] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test405058806239266840.junit.dir/version-2 snapdir /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test405058806239266840.junit.dir/version-2
[junit] 2014-04-22 18:34:36,448 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test405058806239266840.junit.dir/version-2/snapshot.b
[junit] 2014-04-22 18:34:36,451 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test405058806239266840.junit.dir/version-2/snapshot.b
[junit] 2014-04-22 18:34:36,452 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-22 18:34:36,453 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:58551
[junit] 2014-04-22 18:34:36,453 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@835] - Processing stat command from /127.0.0.1:58551
[junit] 2014-04-22 18:34:36,453 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn$StatCommand@684] - Stat command output
[junit] 2014-04-22 18:34:36,454 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:58551 (no session established for client)
[junit] 2014-04-22 18:34:36,454 [myid:] - INFO [main:JMXEnv@224] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2014-04-22 18:34:36,455 [myid:] - INFO [main:JMXEnv@241] - expect:InMemoryDataTree
[junit] 2014-04-22 18:34:36,455 [myid:] - INFO [main:JMXEnv@245] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] 2014-04-22 18:34:36,456 [myid:] - INFO [main:JMXEnv@241] - expect:StandaloneServer_port
[junit] 2014-04-22 18:34:36,456 [myid:] - INFO [main:JMXEnv@245] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2014-04-22 18:34:36,456 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@55] - Memory used 3407
[junit] 2014-04-22 18:34:36,456 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@60] - Number of threads 24
[junit] 2014-04-22 18:34:36,456 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@65] - FINISHED TEST METHOD testQuota
[junit] 2014-04-22 18:34:36,457 [myid:] - INFO [main:ClientBase@520] - tearDown starting
[junit] 2014-04-22 18:34:36,522 [myid:] - INFO [main:ZooKeeper@966] - Session: 0x1458ab7d98b0000 closed
[junit] 2014-04-22 18:34:36,522 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@529] - EventThread shut down
[junit] 2014-04-22 18:34:36,523 [myid:] - INFO [main:ClientBase@490] - STOPPING server
[junit] 2014-04-22 18:34:36,523 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2014-04-22 18:34:36,523 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-22 18:34:36,523 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2014-04-22 18:34:36,523 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-22 18:34:36,524 [myid:] - INFO [main:ZooKeeperServer@428] - shutting down
[junit] 2014-04-22 18:34:36,524 [myid:] - INFO [main:SessionTrackerImpl@184] - Shutting down
[junit] 2014-04-22 18:34:36,524 [myid:] - INFO [main:PrepRequestProcessor@980] - Shutting down
[junit] 2014-04-22 18:34:36,524 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2014-04-22 18:34:36,524 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@155] - PrepRequestProcessor exited loop!
[junit] 2014-04-22 18:34:36,524 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2014-04-22 18:34:36,525 [myid:] - INFO [main:FinalRequestProcessor@462] - shutdown of request processor complete
[junit] 2014-04-22 18:34:36,525 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-22 18:34:36,526 [myid:] - INFO [main:JMXEnv@142] - ensureOnly:[]
[junit] 2014-04-22 18:34:36,529 [myid:] - INFO [main:ClientBase@545] - fdcount after test is: 46 at start it was 30
[junit] 2014-04-22 18:34:36,529 [myid:] - INFO [main:ClientBase@547] - sleeping for 20 secs
[junit] 2014-04-22 18:34:36,530 [myid:] - INFO [main:ZKTestCase$1@61] - SUCCEEDED testQuota
[junit] 2014-04-22 18:34:36,531 [myid:] - INFO [main:ZKTestCase$1@56] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.009 sec
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build.xml:1337: Tests failed!
Total time: 53 minutes 20 seconds
Build step 'Execute shell' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
REGRESSION: org.apache.zookeeper.test.RestoreCommittedLogTest.testRestoreCommittedLog
Error Message:
KeeperErrorCode = ConnectionLoss for /invalidsnap-978
Stack Trace:
org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /invalidsnap-978
at org.apache.zookeeper.KeeperException.create(KeeperException.java:99)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:1065)
at org.apache.zookeeper.test.RestoreCommittedLogTest.testRestoreCommittedLog(RestoreCommittedLogTest.java:64)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
ZooKeeper-trunk-jdk8 - Build # 14 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/14/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 273354 lines...]
[junit] 2014-04-21 12:16:54,368 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x2000005a9 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test7178459447508344951.junit.dir/version-2/snapshot.2000005a9
[junit] 2014-04-21 12:16:54,420 [myid:] - INFO [SyncThread:2:FileTxnLog@200] - Creating new log file: log.2000005ab
[junit] 2014-04-21 12:16:57,352 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x2000005dc to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test7178459447508344951.junit.dir/version-2/snapshot.2000005dc
[junit] 2014-04-21 12:16:57,382 [myid:] - INFO [SyncThread:2:FileTxnLog@200] - Creating new log file: log.2000005de
[junit] 2014-04-21 12:16:57,763 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x2000005e7 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8843168338773766001.junit.dir/version-2/snapshot.2000005e7
[junit] 2014-04-21 12:16:57,803 [myid:] - INFO [SyncThread:3:FileTxnLog@200] - Creating new log file: log.2000005e9
[junit] 2014-04-21 12:16:58,343 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x2000005f3 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test6166558243069636639.junit.dir/version-2/snapshot.2000005f3
[junit] 2014-04-21 12:16:58,372 [myid:] - INFO [SyncThread:1:FileTxnLog@200] - Creating new log file: log.2000005f5
[junit] 2014-04-21 12:16:59,000 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000603 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test5190379201787673046.junit.dir/version-2/snapshot.200000603
[junit] 2014-04-21 12:16:59,033 [myid:] - INFO [SyncThread:4:FileTxnLog@200] - Creating new log file: log.200000605
[junit] 2014-04-21 12:17:00,477 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000622 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test7178459447508344951.junit.dir/version-2/snapshot.200000622
[junit] 2014-04-21 12:17:00,523 [myid:] - INFO [SyncThread:2:FileTxnLog@200] - Creating new log file: log.200000624
[junit] 2014-04-21 12:17:03,222 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000646 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8843168338773766001.junit.dir/version-2/snapshot.200000646
[junit] 2014-04-21 12:17:03,260 [myid:] - INFO [SyncThread:3:FileTxnLog@200] - Creating new log file: log.200000648
[junit] 2014-04-21 12:17:03,867 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000652 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test6166558243069636639.junit.dir/version-2/snapshot.200000652
[junit] 2014-04-21 12:17:03,915 [myid:] - INFO [SyncThread:1:FileTxnLog@200] - Creating new log file: log.200000654
[junit] 2014-04-21 12:17:04,741 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000661 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test5190379201787673046.junit.dir/version-2/snapshot.200000661
[junit] 2014-04-21 12:17:04,776 [myid:] - INFO [SyncThread:4:FileTxnLog@200] - Creating new log file: log.200000663
[junit] 2014-04-21 12:17:06,667 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000678 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test7178459447508344951.junit.dir/version-2/snapshot.200000678
[junit] 2014-04-21 12:17:06,714 [myid:] - INFO [SyncThread:2:FileTxnLog@200] - Creating new log file: log.20000067a
[junit] 2014-04-21 12:17:08,140 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000692 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8843168338773766001.junit.dir/version-2/snapshot.200000692
[junit] 2014-04-21 12:17:08,180 [myid:] - INFO [SyncThread:3:FileTxnLog@200] - Creating new log file: log.200000694
[junit] 2014-04-21 12:17:08,340 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000696 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test6166558243069636639.junit.dir/version-2/snapshot.200000696
[junit] 2014-04-21 12:17:08,384 [myid:] - INFO [SyncThread:1:FileTxnLog@200] - Creating new log file: log.200000698
[junit] 2014-04-21 12:17:10,838 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x2000006be to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test5190379201787673046.junit.dir/version-2/snapshot.2000006be
[junit] 2014-04-21 12:17:10,880 [myid:] - INFO [SyncThread:4:FileTxnLog@200] - Creating new log file: log.2000006c0
[junit] 2014-04-21 12:17:11,647 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x2000006c7 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test7178459447508344951.junit.dir/version-2/snapshot.2000006c7
[junit] 2014-04-21 12:17:11,742 [myid:] - INFO [SyncThread:2:FileTxnLog@200] - Creating new log file: log.2000006c9
[junit] 2014-04-21 12:17:12,500 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x2000006d3 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8843168338773766001.junit.dir/version-2/snapshot.2000006d3
[junit] 2014-04-21 12:17:12,545 [myid:] - INFO [SyncThread:3:FileTxnLog@200] - Creating new log file: log.2000006d5
[junit] 2014-04-21 12:17:12,545 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x2000006d4 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test6166558243069636639.junit.dir/version-2/snapshot.2000006d4
[junit] 2014-04-21 12:17:12,612 [myid:] - INFO [SyncThread:1:FileTxnLog@200] - Creating new log file: log.2000006d6
[junit] 2014-04-21 12:17:13,849 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x2000006f2 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test5190379201787673046.junit.dir/version-2/snapshot.2000006f2
[junit] 2014-04-21 12:17:13,874 [myid:] - INFO [SyncThread:4:FileTxnLog@200] - Creating new log file: log.2000006f4
[junit] 2014-04-21 12:17:14,468 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000701 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test7178459447508344951.junit.dir/version-2/snapshot.200000701
[junit] 2014-04-21 12:17:14,531 [myid:] - INFO [SyncThread:2:FileTxnLog@200] - Creating new log file: log.200000703
[junit] 2014-04-21 12:17:14,977 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000710 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8843168338773766001.junit.dir/version-2/snapshot.200000710
[junit] 2014-04-21 12:17:15,010 [myid:] - INFO [SyncThread:3:FileTxnLog@200] - Creating new log file: log.200000712
[junit] 2014-04-21 12:17:15,158 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000715 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test6166558243069636639.junit.dir/version-2/snapshot.200000715
[junit] 2014-04-21 12:17:15,295 [myid:] - INFO [SyncThread:1:FileTxnLog@200] - Creating new log file: log.200000717
[junit] 2014-04-21 12:17:16,679 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000735 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test5190379201787673046.junit.dir/version-2/snapshot.200000735
[junit] 2014-04-21 12:17:16,696 [myid:] - INFO [SyncThread:4:FileTxnLog@200] - Creating new log file: log.200000737
[junit] 2014-04-21 12:17:17,881 [myid:] - WARN [SyncThread:4:FileTxnLog@335] - fsync-ing the write ahead log in SyncThread:4 took 1184ms which will adversely effect operation latency. See the ZooKeeper troubleshooting guide
[junit] 2014-04-21 12:17:17,882 [myid:] - WARN [SyncThread:2:FileTxnLog@335] - fsync-ing the write ahead log in SyncThread:2 took 1562ms which will adversely effect operation latency. See the ZooKeeper troubleshooting guide
[junit] 2014-04-21 12:17:18,770 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000741 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test7178459447508344951.junit.dir/version-2/snapshot.200000741
[junit] 2014-04-21 12:17:18,794 [myid:] - INFO [SyncThread:2:FileTxnLog@200] - Creating new log file: log.200000743
[junit] 2014-04-21 12:17:19,678 [myid:] - WARN [SyncThread:3:FileTxnLog@335] - fsync-ing the write ahead log in SyncThread:3 took 1481ms which will adversely effect operation latency. See the ZooKeeper troubleshooting guide
[junit] 2014-04-21 12:17:20,280 [myid:] - WARN [SyncThread:1:FileTxnLog@335] - fsync-ing the write ahead log in SyncThread:1 took 1485ms which will adversely effect operation latency. See the ZooKeeper troubleshooting guide
[junit] 2014-04-21 12:17:20,602 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000748 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test6166558243069636639.junit.dir/version-2/snapshot.200000748
[junit] 2014-04-21 12:17:20,637 [myid:] - INFO [SyncThread:1:FileTxnLog@200] - Creating new log file: log.20000074a
[junit] 2014-04-21 12:17:22,048 [myid:] - INFO [Snapshot Thread:FileTxnSnapLog@298] - Snapshotting: 0x200000769 to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test8843168338773766001.junit.dir/version-2/snapshot.200000769
[junit] 2014-04-21 12:17:22,126 [myid:] - INFO [SyncThread:3:FileTxnLog@200] - Creating new log file: log.20000076b
Build timed out (after 60 minutes). Marking the build as failed.
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any) ##############################
3 tests failed.
REGRESSION: 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: TEST-org.apache.zookeeper.test.ZkDatabaseCorruptionTest.xml.<init>
Error Message:
Stack Trace:
Test report file /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/logs/TEST-org.apache.zookeeper.test.ZkDatabaseCorruptionTest.xml was length 0
FAILED: org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest
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:153)
at org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest(StandaloneDisabledTest.java:75)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
ZooKeeper-trunk-jdk8 - Build # 13 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/13/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 271047 lines...]
[junit] 2014-04-20 13:14:50,475 [myid:] - INFO [main:ClientBase@443] - STARTING server
[junit] 2014-04-20 13:14:50,476 [myid:] - INFO [main:ClientBase@364] - CREATING server instance 127.0.0.1:11221
[junit] 2014-04-20 13:14:50,476 [myid:] - INFO [main:NIOServerCnxnFactory@670] - Configuring NIO connection handler with 10s sessionless connection timeout, 2 selector thread(s), 16 worker threads, and 64 kB direct buffers.
[junit] 2014-04-20 13:14:50,476 [myid:] - INFO [main:NIOServerCnxnFactory@683] - binding to port 0.0.0.0/0.0.0.0:11221
[junit] 2014-04-20 13:14:50,477 [myid:] - INFO [main:ClientBase@339] - STARTING server instance 127.0.0.1:11221
[junit] 2014-04-20 13:14:50,477 [myid:] - INFO [main:ZooKeeperServer@766] - minSessionTimeout set to 6000
[junit] 2014-04-20 13:14:50,477 [myid:] - INFO [main:ZooKeeperServer@775] - maxSessionTimeout set to 60000
[junit] 2014-04-20 13:14:50,477 [myid:] - INFO [main:ZooKeeperServer@149] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test236877204662067516.junit.dir/version-2 snapdir /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test236877204662067516.junit.dir/version-2
[junit] 2014-04-20 13:14:50,480 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test236877204662067516.junit.dir/version-2/snapshot.b
[junit] 2014-04-20 13:14:50,483 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test236877204662067516.junit.dir/version-2/snapshot.b
[junit] 2014-04-20 13:14:50,486 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-20 13:14:50,487 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:54404
[junit] 2014-04-20 13:14:50,488 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@835] - Processing stat command from /127.0.0.1:54404
[junit] 2014-04-20 13:14:50,489 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn$StatCommand@684] - Stat command output
[junit] 2014-04-20 13:14:50,489 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:54404 (no session established for client)
[junit] 2014-04-20 13:14:50,489 [myid:] - INFO [main:JMXEnv@224] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2014-04-20 13:14:50,491 [myid:] - INFO [main:JMXEnv@241] - expect:InMemoryDataTree
[junit] 2014-04-20 13:14:50,491 [myid:] - INFO [main:JMXEnv@245] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] 2014-04-20 13:14:50,491 [myid:] - INFO [main:JMXEnv@241] - expect:StandaloneServer_port
[junit] 2014-04-20 13:14:50,498 [myid:] - INFO [main:JMXEnv@245] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2014-04-20 13:14:50,501 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@55] - Memory used 3081
[junit] 2014-04-20 13:14:50,501 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@60] - Number of threads 24
[junit] 2014-04-20 13:14:50,501 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@65] - FINISHED TEST METHOD testQuota
[junit] 2014-04-20 13:14:50,501 [myid:] - INFO [main:ClientBase@520] - tearDown starting
[junit] 2014-04-20 13:14:51,000 [myid:] - INFO [SessionTracker:SessionTrackerImpl@135] - SessionTrackerImpl exited loop!
[junit] 2014-04-20 13:14:51,001 [myid:] - INFO [SessionTracker:SessionTrackerImpl@135] - SessionTrackerImpl exited loop!
[junit] 2014-04-20 13:14:51,024 [myid:] - INFO [main:ZooKeeper@966] - Session: 0x1457f465fd00000 closed
[junit] 2014-04-20 13:14:51,024 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@529] - EventThread shut down
[junit] 2014-04-20 13:14:51,024 [myid:] - INFO [main:ClientBase@490] - STOPPING server
[junit] 2014-04-20 13:14:51,025 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2014-04-20 13:14:51,026 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2014-04-20 13:14:51,026 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-20 13:14:51,026 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-20 13:14:51,030 [myid:] - INFO [main:ZooKeeperServer@428] - shutting down
[junit] 2014-04-20 13:14:51,031 [myid:] - INFO [main:SessionTrackerImpl@184] - Shutting down
[junit] 2014-04-20 13:14:51,031 [myid:] - INFO [main:PrepRequestProcessor@980] - Shutting down
[junit] 2014-04-20 13:14:51,031 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2014-04-20 13:14:51,031 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2014-04-20 13:14:51,032 [myid:] - INFO [main:FinalRequestProcessor@462] - shutdown of request processor complete
[junit] 2014-04-20 13:14:51,032 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-20 13:14:51,033 [myid:] - INFO [main:JMXEnv@142] - ensureOnly:[]
[junit] 2014-04-20 13:14:51,031 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@155] - PrepRequestProcessor exited loop!
[junit] 2014-04-20 13:14:51,044 [myid:] - INFO [main:ClientBase@545] - fdcount after test is: 47 at start it was 31
[junit] 2014-04-20 13:14:51,044 [myid:] - INFO [main:ClientBase@547] - sleeping for 20 secs
[junit] 2014-04-20 13:14:51,045 [myid:] - INFO [main:ZKTestCase$1@61] - SUCCEEDED testQuota
[junit] 2014-04-20 13:14:51,046 [myid:] - INFO [main:ZKTestCase$1@56] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.998 sec
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build.xml:1337: Tests failed!
Total time: 55 minutes 26 seconds
Build step 'Execute shell' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any) ##############################
4 tests failed.
REGRESSION: org.apache.zookeeper.RemoveWatchesTest.testMultipleDataWatchers[1]
Error Message:
KeeperErrorCode = Session expired for /node1
Stack Trace:
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /node1
at org.apache.zookeeper.KeeperException.create(KeeperException.java:131)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:1065)
at org.apache.zookeeper.RemoveWatchesTest.testMultipleDataWatchers(RemoveWatchesTest.java:147)
REGRESSION: org.apache.zookeeper.test.ACLTest.testAcls
Error Message:
KeeperErrorCode = ConnectionLoss for /0
Stack Trace:
org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /0
at org.apache.zookeeper.KeeperException.create(KeeperException.java:99)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:1065)
at org.apache.zookeeper.test.ACLTest.testAcls(ACLTest.java:105)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
REGRESSION: org.apache.zookeeper.test.SessionTest.testSession
Error Message:
KeeperErrorCode = Session expired for /e
Stack Trace:
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /e
at org.apache.zookeeper.KeeperException.create(KeeperException.java:131)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:1065)
at org.apache.zookeeper.test.SessionTest.testSession(SessionTest.java:189)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
FAILED: org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest
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:153)
at org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest(StandaloneDisabledTest.java:75)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
ZooKeeper-trunk-jdk8 - Build # 12 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/12/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 241499 lines...]
[junit] at org.apache.zookeeper.server.quorum.LearnerHandler.run(LearnerHandler.java:587)
[junit] 2014-04-19 11:43:45,347 [myid:] - WARN [LearnerHandler-/127.0.0.1:60512:LearnerHandler@584] - ******* GOODBYE /127.0.0.1:60512 ********
[junit] 2014-04-19 11:43:45,347 [myid:] - WARN [LearnerHandler-/127.0.0.1:60512:LearnerHandler@868] - Ignoring unexpected exception
[junit] java.lang.InterruptedException
[junit] at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1220)
[junit] at java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:335)
[junit] at java.util.concurrent.LinkedBlockingQueue.put(LinkedBlockingQueue.java:339)
[junit] at org.apache.zookeeper.server.quorum.LearnerHandler.shutdown(LearnerHandler.java:866)
[junit] at org.apache.zookeeper.server.quorum.LearnerHandler.run(LearnerHandler.java:587)
[junit] 2014-04-19 11:43:45,347 [myid:] - WARN [LearnerHandler-/127.0.0.1:60522:LearnerHandler@584] - ******* GOODBYE /127.0.0.1:60522 ********
[junit] 2014-04-19 11:43:45,348 [myid:] - WARN [LearnerHandler-/127.0.0.1:60522:LearnerHandler@868] - Ignoring unexpected exception
[junit] java.lang.InterruptedException
[junit] at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1220)
[junit] at java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:335)
[junit] at java.util.concurrent.LinkedBlockingQueue.put(LinkedBlockingQueue.java:339)
[junit] at org.apache.zookeeper.server.quorum.LearnerHandler.shutdown(LearnerHandler.java:866)
[junit] at org.apache.zookeeper.server.quorum.LearnerHandler.run(LearnerHandler.java:587)
[junit] 2014-04-19 11:43:45,348 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2014-04-19 11:43:45,349 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-19 11:43:45,348 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11235:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2014-04-19 11:43:45,354 [myid:] - INFO [/127.0.0.1:12229:QuorumCnxManager$Listener@573] - Leaving listener
[junit] 2014-04-19 11:43:45,348 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-19 11:43:45,356 [myid:] - INFO [main:QuorumBase@385] - Shutting down leader election QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11235
[junit] 2014-04-19 11:43:45,356 [myid:] - INFO [main:QuorumBase@390] - Waiting for QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11235 to exit thread
[junit] 2014-04-19 11:43:45,357 [myid:] - WARN [QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11235:QuorumPeer@987] - Unexpected exception
[junit] java.lang.InterruptedException: sleep interrupted
[junit] at java.lang.Thread.sleep(Native Method)
[junit] at org.apache.zookeeper.server.quorum.Leader.lead(Leader.java:588)
[junit] at org.apache.zookeeper.server.quorum.QuorumPeer.run(QuorumPeer.java:984)
[junit] 2014-04-19 11:43:45,357 [myid:] - INFO [QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11235:Leader@628] - Shutting down
[junit] 2014-04-19 11:43:45,357 [myid:] - WARN [QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11235:QuorumPeer@1014] - PeerState set to LOOKING
[junit] 2014-04-19 11:43:45,357 [myid:] - WARN [QuorumPeer[myid=4]/0:0:0:0:0:0:0:0:11235:QuorumPeer@1000] - QuorumPeer main thread exited
[junit] 2014-04-19 11:43:45,359 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@55] - Memory used 67840
[junit] 2014-04-19 11:43:45,359 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@60] - Number of threads 16
[junit] 2014-04-19 11:43:45,359 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@65] - FINISHED TEST METHOD testCorruption
[junit] 2014-04-19 11:43:45,359 [myid:] - INFO [main:ZkDatabaseCorruptionTest@57] - STOPPING quorum org.apache.zookeeper.test.ZkDatabaseCorruptionTest
[junit] 2014-04-19 11:43:45,432 [myid:] - INFO [main:ZKTestCase$1@61] - SUCCEEDED testCorruption
[junit] 2014-04-19 11:43:45,432 [myid:] - INFO [main:ZKTestCase$1@56] - FINISHED testCorruption
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 48.625 sec
[junit] 2014-04-19 11:43:46,001 [myid:] - INFO [SessionTracker:SessionTrackerImpl@135] - SessionTrackerImpl exited loop!
[junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest
Build timed out (after 60 minutes). Marking the build as failed.
[junit] 2014-04-19 11:43:57,413 [myid:] - INFO [main:PortAssignment@32] - assigning port 11221
[junit] 2014-04-19 11:43:57,422 [myid:] - INFO [main:ZKTestCase$1@51] - STARTING testQuota
[junit] 2014-04-19 11:43:57,648 [myid:] - INFO [main:ClientBase@425] - Initial fdcount is: 31
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
[junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest
[junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec
[junit] Test org.apache.zookeeper.test.ZooKeeperQuotaTest FAILED (crashed)
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build.xml:1337: Tests failed!
Total time: 60 minutes 0 seconds
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any) ##############################
11 tests failed.
REGRESSION: org.apache.zookeeper.server.quorum.CommitProcessorTest.testManyCommitWorkers
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.
REGRESSION: org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest
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:153)
at org.apache.zookeeper.server.quorum.StandaloneDisabledTest.startSingleServerTest(StandaloneDisabledTest.java:75)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
REGRESSION: org.apache.zookeeper.test.GetProposalFromTxnTest.testGetProposalFromTxn
Error Message:
KeeperErrorCode = ConnectionLoss for /invalidsnap-656
Stack Trace:
org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /invalidsnap-656
at org.apache.zookeeper.KeeperException.create(KeeperException.java:99)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:1065)
at org.apache.zookeeper.test.GetProposalFromTxnTest.testGetProposalFromTxn(GetProposalFromTxnTest.java:85)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
REGRESSION: org.apache.zookeeper.test.HierarchicalQuorumTest.testHierarchicalQuorum
Error Message:
KeeperErrorCode = ConnectionLoss for /test-3
Stack Trace:
org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /test-3
at org.apache.zookeeper.KeeperException.create(KeeperException.java:99)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:1065)
at org.apache.zookeeper.test.ClientHammerTest.runHammer(ClientHammerTest.java:131)
at org.apache.zookeeper.test.HierarchicalQuorumTest.testHierarchicalQuorum(HierarchicalQuorumTest.java:306)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
REGRESSION: org.apache.zookeeper.test.ObserverQuorumHammerTest.testHammerBasic
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.ObserverQuorumHammerTest.setUp(ObserverQuorumHammerTest.java:30)
REGRESSION: org.apache.zookeeper.test.QuorumHammerTest.testHammerBasic
Error Message:
expected:<1000> but was:<333>
Stack Trace:
junit.framework.AssertionFailedError: expected:<1000> but was:<333>
at org.apache.zookeeper.test.ClientHammerTest.verifyHammer(ClientHammerTest.java:230)
at org.apache.zookeeper.test.ClientHammerTest.runHammer(ClientHammerTest.java:141)
at org.apache.zookeeper.test.ClientHammerTest.testHammerBasic(ClientHammerTest.java:119)
at org.apache.zookeeper.test.QuorumHammerTest.testHammerBasic(QuorumHammerTest.java:49)
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.testBehindLeader
Error Message:
KeeperErrorCode = ConnectionLoss for /0
Stack Trace:
org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /0
at org.apache.zookeeper.KeeperException.create(KeeperException.java:99)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:1065)
at org.apache.zookeeper.test.QuorumZxidSyncTest.testBehindLeader(QuorumZxidSyncTest.java:53)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
REGRESSION: org.apache.zookeeper.test.RestoreCommittedLogTest.testRestoreCommittedLog
Error Message:
KeeperErrorCode = ConnectionLoss for /invalidsnap-0
Stack Trace:
org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /invalidsnap-0
at org.apache.zookeeper.KeeperException.create(KeeperException.java:99)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:1065)
at org.apache.zookeeper.test.RestoreCommittedLogTest.testRestoreCommittedLog(RestoreCommittedLogTest.java:64)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
FAILED: org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetWithLocal
Error Message:
Did not connect
Stack Trace:
java.util.concurrent.TimeoutException: Did not connect
at org.apache.zookeeper.test.ClientBase$CountdownWatcher.waitForConnected(ClientBase.java:131)
at org.apache.zookeeper.test.WatcherTest.testWatcherAutoReset(WatcherTest.java:370)
at org.apache.zookeeper.test.WatcherTest.testWatcherAutoResetWithLocal(WatcherTest.java:240)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:52)
FAILED: org.apache.zookeeper.test.ZooKeeperQuotaTest.testQuota
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-trunk-jdk8 - Build # 11 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/11/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 270292 lines...]
[junit] 2014-04-18 12:40:11,551 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11224:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:48672
[junit] 2014-04-18 12:40:11,552 [myid:] - INFO [NIOWorkerThread-2:ZooKeeperServer@853] - Client attempting to establish new session at /127.0.0.1:48672
[junit] 2014-04-18 12:40:11,552 [myid:] - INFO [SyncThread:0:FileTxnLog@200] - Creating new log file: log.1
[junit] 2014-04-18 12:40:11,661 [myid:] - INFO [SyncThread:0:ZooKeeperServer@604] - Established session 0x14574d9f2130000 with negotiated timeout 30000 for client /127.0.0.1:48672
[junit] 2014-04-18 12:40:11,665 [myid:] - INFO [main-SendThread(127.0.0.1:11224):ClientCnxn$SendThread@1346] - Session establishment complete on server 127.0.0.1/127.0.0.1:11224, sessionid = 0x14574d9f2130000, negotiated timeout = 30000
[junit] 2014-04-18 12:40:11,676 [myid:] - INFO [main:JMXEnv@113] - expect:0x14574d9f2130000
[junit] 2014-04-18 12:40:11,676 [myid:] - INFO [main:JMXEnv@116] - found:0x14574d9f2130000 org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x14574d9f2130000
[junit] 2014-04-18 12:40:11,676 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@50] - RUNNING TEST METHOD testBasic
[junit] 2014-04-18 12:40:11,692 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@55] - Memory used 5527
[junit] 2014-04-18 12:40:11,692 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@60] - Number of threads 32
[junit] 2014-04-18 12:40:11,693 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@65] - FINISHED TEST METHOD testBasic
[junit] 2014-04-18 12:40:11,693 [myid:] - INFO [main:ClientBase@520] - tearDown starting
[junit] 2014-04-18 12:40:11,693 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@685] - Processed session termination for sessionid: 0x14574d9f2130000
[junit] 2014-04-18 12:40:11,705 [myid:] - INFO [main:ZooKeeper@966] - Session: 0x14574d9f2130000 closed
[junit] 2014-04-18 12:40:11,706 [myid:] - INFO [NIOWorkerThread-9:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:48672 which had sessionid 0x14574d9f2130000
[junit] 2014-04-18 12:40:11,705 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@529] - EventThread shut down
[junit] 2014-04-18 12:40:11,706 [myid:] - INFO [main:ClientBase@490] - STOPPING server
[junit] 2014-04-18 12:40:11,706 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2014-04-18 12:40:11,707 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-18 12:40:11,707 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-2:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-18 12:40:11,707 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-18 12:40:11,707 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11224:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2014-04-18 12:40:11,708 [myid:] - INFO [main:ZooKeeperServer@428] - shutting down
[junit] 2014-04-18 12:40:11,708 [myid:] - INFO [main:SessionTrackerImpl@184] - Shutting down
[junit] 2014-04-18 12:40:11,708 [myid:] - INFO [main:PrepRequestProcessor@980] - Shutting down
[junit] 2014-04-18 12:40:11,708 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2014-04-18 12:40:11,708 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@155] - PrepRequestProcessor exited loop!
[junit] 2014-04-18 12:40:11,708 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2014-04-18 12:40:11,709 [myid:] - INFO [main:FinalRequestProcessor@462] - shutdown of request processor complete
[junit] 2014-04-18 12:40:11,709 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11224
[junit] 2014-04-18 12:40:11,710 [myid:] - INFO [main:JMXEnv@142] - ensureOnly:[]
[junit] 2014-04-18 12:40:11,740 [myid:] - INFO [main:ClientBase@545] - fdcount after test is: 47 at start it was 47
[junit] 2014-04-18 12:40:11,740 [myid:] - INFO [main:ZKTestCase$1@61] - SUCCEEDED testBasic
[junit] 2014-04-18 12:40:11,740 [myid:] - INFO [main:ZKTestCase$1@56] - FINISHED testBasic
[junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 2.037 sec
[junit] Running org.apache.zookeeper.test.StaticHostProviderTest
[junit] 2014-04-18 12:40:13,359 [myid:] - INFO [main:ZKTestCase$1@51] - STARTING testNextGoesRound
[junit] 2014-04-18 12:40:13,369 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@50] - RUNNING TEST METHOD testNextGoesRound
[junit] 2014-04-18 12:40:23,394 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@55] - Memory used 3439
[junit] 2014-04-18 12:40:23,395 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@60] - Number of threads 4
[junit] 2014-04-18 12:40:23,395 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@65] - FINISHED TEST METHOD testNextGoesRound
[junit] 2014-04-18 12:40:23,395 [myid:] - INFO [main:ZKTestCase$1@61] - SUCCEEDED testNextGoesRound
[junit] 2014-04-18 12:40:23,395 [myid:] - INFO [main:ZKTestCase$1@56] - FINISHED testNextGoesRound
[junit] 2014-04-18 12:40:23,440 [myid:] - INFO [main:ZKTestCase$1@51] - STARTING testUpdateMigrationGoesRound
[junit] 2014-04-18 12:40:23,441 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@50] - RUNNING TEST METHOD testUpdateMigrationGoesRound
[junit] 2014-04-18 12:41:33,504 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@55] - Memory used 3669
[junit] 2014-04-18 12:41:33,504 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@60] - Number of threads 4
[junit] 2014-04-18 12:41:33,504 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@65] - FINISHED TEST METHOD testUpdateMigrationGoesRound
[junit] 2014-04-18 12:41:33,504 [myid:] - INFO [main:ZKTestCase$1@61] - SUCCEEDED testUpdateMigrationGoesRound
[junit] 2014-04-18 12:41:33,505 [myid:] - INFO [main:ZKTestCase$1@56] - FINISHED testUpdateMigrationGoesRound
[junit] 2014-04-18 12:41:33,505 [myid:] - INFO [main:ZKTestCase$1@51] - STARTING testUpdateLoadBalancing
[junit] 2014-04-18 12:41:33,505 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@50] - RUNNING TEST METHOD testUpdateLoadBalancing
Build timed out (after 60 minutes). Marking the build as failed.
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
FAILED: TEST-org.apache.zookeeper.test.StaticHostProviderTest.xml.<init>
Error Message:
Stack Trace:
Test report file /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/logs/TEST-org.apache.zookeeper.test.StaticHostProviderTest.xml was length 0
ZooKeeper-trunk-jdk8 - Build # 10 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper-trunk-jdk8/10/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 273687 lines...]
[junit] 2014-04-17 16:09:51,818 [myid:] - INFO [main:JMXEnv@142] - ensureOnly:[]
[junit] 2014-04-17 16:09:51,823 [myid:] - INFO [main:ClientBase@443] - STARTING server
[junit] 2014-04-17 16:09:51,824 [myid:] - INFO [main:ClientBase@364] - CREATING server instance 127.0.0.1:11221
[junit] 2014-04-17 16:09:51,824 [myid:] - INFO [main:NIOServerCnxnFactory@670] - Configuring NIO connection handler with 10s sessionless connection timeout, 3 selector thread(s), 48 worker threads, and 64 kB direct buffers.
[junit] 2014-04-17 16:09:51,824 [myid:] - INFO [main:NIOServerCnxnFactory@683] - binding to port 0.0.0.0/0.0.0.0:11221
[junit] 2014-04-17 16:09:51,825 [myid:] - INFO [main:ClientBase@339] - STARTING server instance 127.0.0.1:11221
[junit] 2014-04-17 16:09:51,825 [myid:] - INFO [main:ZooKeeperServer@766] - minSessionTimeout set to 6000
[junit] 2014-04-17 16:09:51,825 [myid:] - INFO [main:ZooKeeperServer@775] - maxSessionTimeout set to 60000
[junit] 2014-04-17 16:09:51,825 [myid:] - INFO [main:ZooKeeperServer@149] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test2239807040396724997.junit.dir/version-2 snapdir /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test2239807040396724997.junit.dir/version-2
[junit] 2014-04-17 16:09:51,826 [myid:] - INFO [main:FileSnap@83] - Reading snapshot /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test2239807040396724997.junit.dir/version-2/snapshot.b
[junit] 2014-04-17 16:09:51,828 [myid:] - INFO [main:FileTxnSnapLog@298] - Snapshotting: 0xb to /x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build/test/tmp/test2239807040396724997.junit.dir/version-2/snapshot.b
[junit] 2014-04-17 16:09:51,832 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-17 16:09:51,833 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from /127.0.0.1:48521
[junit] 2014-04-17 16:09:51,834 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@835] - Processing stat command from /127.0.0.1:48521
[junit] 2014-04-17 16:09:51,834 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn$StatCommand@684] - Stat command output
[junit] 2014-04-17 16:09:51,834 [myid:] - INFO [NIOWorkerThread-1:NIOServerCnxn@1006] - Closed socket connection for client /127.0.0.1:48521 (no session established for client)
[junit] 2014-04-17 16:09:51,834 [myid:] - INFO [main:JMXEnv@224] - ensureParent:[InMemoryDataTree, StandaloneServer_port]
[junit] 2014-04-17 16:09:51,836 [myid:] - INFO [main:JMXEnv@241] - expect:InMemoryDataTree
[junit] 2014-04-17 16:09:51,836 [myid:] - INFO [main:JMXEnv@245] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] 2014-04-17 16:09:51,836 [myid:] - INFO [main:JMXEnv@241] - expect:StandaloneServer_port
[junit] 2014-04-17 16:09:51,836 [myid:] - INFO [main:JMXEnv@245] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2014-04-17 16:09:51,836 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@55] - Memory used 3747
[junit] 2014-04-17 16:09:51,837 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@60] - Number of threads 25
[junit] 2014-04-17 16:09:51,837 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@65] - FINISHED TEST METHOD testQuota
[junit] 2014-04-17 16:09:51,837 [myid:] - INFO [main:ClientBase@520] - tearDown starting
[junit] 2014-04-17 16:09:51,895 [myid:] - INFO [main:ZooKeeper@966] - Session: 0x14570738a3d0000 closed
[junit] 2014-04-17 16:09:51,895 [myid:] - INFO [main:ClientBase@490] - STOPPING server
[junit] 2014-04-17 16:09:51,895 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@529] - EventThread shut down
[junit] 2014-04-17 16:09:51,896 [myid:] - INFO [ConnnectionExpirer:NIOServerCnxnFactory$ConnectionExpirerThread@583] - ConnnectionExpirerThread interrupted
[junit] 2014-04-17 16:09:51,896 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-17 16:09:51,896 [myid:] - INFO [NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@219] - accept thread exitted run method
[junit] 2014-04-17 16:09:51,896 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-2:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-17 16:09:51,896 [myid:] - INFO [NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420] - selector thread exitted run method
[junit] 2014-04-17 16:09:51,897 [myid:] - INFO [main:ZooKeeperServer@428] - shutting down
[junit] 2014-04-17 16:09:51,897 [myid:] - INFO [main:SessionTrackerImpl@184] - Shutting down
[junit] 2014-04-17 16:09:51,897 [myid:] - INFO [main:PrepRequestProcessor@980] - Shutting down
[junit] 2014-04-17 16:09:51,897 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2014-04-17 16:09:51,897 [myid:] - INFO [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@155] - PrepRequestProcessor exited loop!
[junit] 2014-04-17 16:09:51,898 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2014-04-17 16:09:51,898 [myid:] - INFO [main:FinalRequestProcessor@462] - shutdown of request processor complete
[junit] 2014-04-17 16:09:51,899 [myid:] - INFO [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2014-04-17 16:09:51,899 [myid:] - INFO [main:JMXEnv@142] - ensureOnly:[]
[junit] 2014-04-17 16:09:51,904 [myid:] - INFO [main:ClientBase@545] - fdcount after test is: 47 at start it was 31
[junit] 2014-04-17 16:09:51,904 [myid:] - INFO [main:ClientBase@547] - sleeping for 20 secs
[junit] 2014-04-17 16:09:51,905 [myid:] - INFO [main:ZKTestCase$1@61] - SUCCEEDED testQuota
[junit] 2014-04-17 16:09:51,906 [myid:] - INFO [main:ZKTestCase$1@56] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.763 sec
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk8/trunk/build.xml:1337: Tests failed!
Total time: 59 minutes 35 seconds
Build step 'Execute shell' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
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.