Mailing-List: contact dev-help@zookeeper.apache.org; run by ezmlm
Precedence: bulk
Reply-To: dev@zookeeper.apache.org
Date: Wed, 14 Jun 2017 10:21:06 +0000 (UTC)
From: Apache Jenkins Server <jenkins@builds.apache.org>
To: dev@zookeeper.apache.org
Message-ID: <682048100.7626.1497435668943.JavaMail.jenkins@crius>
Subject: ZooKeeper_branch35_openjdk7 - Build # 564 - Failure
MIME-Version: 1.0
Content-Type: multipart/mixed;
	boundary="----=_Part_7625_97186894.1497435666643"
archived-at: Wed, 14 Jun 2017 10:21:11 -0000

------=_Part_7625_97186894.1497435666643
Content-Type: text/plain; charset=UTF-8
Content-Transfer-Encoding: 7bit

See https://builds.apache.org/job/ZooKeeper_branch35_openjdk7/564/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 62.96 MB...]
    [junit] 2017-06-14 10:20:58,535 [myid:127.0.0.1:19547] - INFO  [main-SendThread(127.0.0.1:19547):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:19547. Will not attempt to authenticate using SASL (unknown error)
    [junit] 2017-06-14 10:20:58,536 [myid:127.0.0.1:19547] - INFO  [main-SendThread(127.0.0.1:19547):ClientCnxn$SendThread@946] - Socket connection established, initiating session, client: /127.0.0.1:36600, server: 127.0.0.1/127.0.0.1:19547
    [junit] 2017-06-14 10:20:58,536 [myid:] - INFO  [New I/O worker #6701:ZooKeeperServer@1025] - Client attempting to renew session 0x100fd8439ab0000 at /127.0.0.1:36600
    [junit] 2017-06-14 10:20:58,537 [myid:] - INFO  [New I/O worker #6701:ZooKeeperServer@727] - Established session 0x100fd8439ab0000 with negotiated timeout 6000 for client /127.0.0.1:36600
    [junit] 2017-06-14 10:20:58,537 [myid:127.0.0.1:19547] - INFO  [main-SendThread(127.0.0.1:19547):ClientCnxn$SendThread@1381] - Session establishment complete on server 127.0.0.1/127.0.0.1:19547, sessionid = 0x100fd8439ab0000, negotiated timeout = 6000
    [junit] 2017-06-14 10:20:58,539 [myid:] - INFO  [SyncThread:0:FileTxnLog@206] - Creating new log file: log.7
    [junit] 2017-06-14 10:20:58,870 [myid:127.0.0.1:19301] - INFO  [main-SendThread(127.0.0.1:19301):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:19301. Will not attempt to authenticate using SASL (unknown error)
    [junit] 2017-06-14 10:20:58,871 [myid:127.0.0.1:19301] - WARN  [main-SendThread(127.0.0.1:19301):ClientCnxn$SendThread@1235] - Session 0x100fd7c8fda0000 for server 127.0.0.1/127.0.0.1:19301, unexpected error, closing socket connection and attempting reconnect
    [junit] java.net.ConnectException: Connection refused
    [junit] 	at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
    [junit] 	at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:739)
    [junit] 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:357)
    [junit] 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1214)
    [junit] 2017-06-14 10:20:58,989 [myid:] - INFO  [SessionTracker:SessionTrackerImpl@158] - SessionTrackerImpl exited loop!
    [junit] 2017-06-14 10:20:59,123 [myid:127.0.0.1:19427] - INFO  [main-SendThread(127.0.0.1:19427):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:19427. Will not attempt to authenticate using SASL (unknown error)
    [junit] 2017-06-14 10:20:59,124 [myid:127.0.0.1:19427] - WARN  [main-SendThread(127.0.0.1:19427):ClientCnxn$SendThread@1235] - Session 0x200fd813e390000 for server 127.0.0.1/127.0.0.1:19427, unexpected error, closing socket connection and attempting reconnect
    [junit] java.net.ConnectException: Connection refused
    [junit] 	at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
    [junit] 	at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:739)
    [junit] 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:357)
    [junit] 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1214)
    [junit] 2017-06-14 10:20:59,619 [myid:] - INFO  [ProcessThread(sid:0 cport:19547)::PrepRequestProcessor@613] - Processed session termination for sessionid: 0x100fd8439ab0000
    [junit] 2017-06-14 10:20:59,756 [myid:] - INFO  [SyncThread:0:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port19547,name1=Connections,name2=127.0.0.1,name3=0x100fd8439ab0000]
    [junit] 2017-06-14 10:20:59,756 [myid:] - INFO  [main:ZooKeeper@1331] - Session: 0x100fd8439ab0000 closed
    [junit] 2017-06-14 10:20:59,756 [myid:] - INFO  [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x100fd8439ab0000
    [junit] 2017-06-14 10:20:59,757 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 150644
    [junit] 2017-06-14 10:20:59,757 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 1643
    [junit] 2017-06-14 10:20:59,757 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testWatcherAutoResetWithLocal
    [junit] 2017-06-14 10:20:59,757 [myid:] - INFO  [main:ClientBase@586] - tearDown starting
    [junit] 2017-06-14 10:20:59,757 [myid:] - INFO  [main:ClientBase@556] - STOPPING server
    [junit] 2017-06-14 10:20:59,757 [myid:] - INFO  [main:NettyServerCnxnFactory@464] - shutdown called 0.0.0.0/0.0.0.0:19547
    [junit] 2017-06-14 10:20:59,763 [myid:] - INFO  [main:ZooKeeperServer@541] - shutting down
    [junit] 2017-06-14 10:20:59,763 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
    [junit] 2017-06-14 10:20:59,764 [myid:] - INFO  [main:SessionTrackerImpl@232] - Shutting down
    [junit] 2017-06-14 10:20:59,764 [myid:] - INFO  [main:PrepRequestProcessor@1010] - Shutting down
    [junit] 2017-06-14 10:20:59,764 [myid:] - INFO  [main:SyncRequestProcessor@191] - Shutting down
    [junit] 2017-06-14 10:20:59,764 [myid:] - INFO  [ProcessThread(sid:0 cport:19547)::PrepRequestProcessor@156] - PrepRequestProcessor exited loop!
    [junit] 2017-06-14 10:20:59,764 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
    [junit] 2017-06-14 10:20:59,764 [myid:] - INFO  [main:FinalRequestProcessor@481] - shutdown of request processor complete
    [junit] 2017-06-14 10:20:59,764 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port19547,name1=InMemoryDataTree]
    [junit] 2017-06-14 10:20:59,765 [myid:] - INFO  [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port19547]
    [junit] 2017-06-14 10:20:59,765 [myid:] - INFO  [main:FourLetterWordMain@85] - connecting to 127.0.0.1 19547
    [junit] 2017-06-14 10:20:59,765 [myid:] - INFO  [main:JMXEnv@146] - ensureOnly:[]
    [junit] 2017-06-14 10:20:59,775 [myid:] - INFO  [main:ClientBase@611] - fdcount after test is: 4832 at start it was 4832
    [junit] 2017-06-14 10:20:59,775 [myid:] - INFO  [main:ZKTestCase$1@68] - SUCCEEDED testWatcherAutoResetWithLocal
    [junit] 2017-06-14 10:20:59,775 [myid:] - INFO  [main:ZKTestCase$1@63] - FINISHED testWatcherAutoResetWithLocal
    [junit] Tests run: 103, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 509.144 sec, Thread: 4, Class: org.apache.zookeeper.test.NioNettySuiteTest

fail.build.on.test.failure:

BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper_branch35_openjdk7/build.xml:1219: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/ZooKeeper_branch35_openjdk7/build.xml:1223: Tests failed!

Total time: 12 minutes 51 seconds
Build step 'Invoke Ant' marked build as failure
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
FAILED:  org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testCurrentServersAreObserversInNextConfig

Error Message:
waiting for server 4 being up

Stack Trace:
junit.framework.AssertionFailedError: waiting for server 4 being up
	at org.apache.zookeeper.server.quorum.ReconfigRecoveryTest.testCurrentServersAreObserversInNextConfig(ReconfigRecoveryTest.java:217)
	at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
------=_Part_7625_97186894.1497435666643--