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 2012/07/02 12:20:13 UTC

ZooKeeper-trunk-jdk7 - Build # 310 - Still Failing

See https://builds.apache.org/job/ZooKeeper-trunk-jdk7/310/

###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 184177 lines...]
    [junit] 2012-07-02 10:19:59,040 [myid:] - INFO  [main:ZooKeeperServer@147] - Created server with tickTime 3000 minSessionTimeout 6000 maxSessionTimeout 60000 datadir /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build/test/tmp/test2598553261958142782.junit.dir/version-2 snapdir /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build/test/tmp/test2598553261958142782.junit.dir/version-2
    [junit] 2012-07-02 10:19:59,040 [myid:] - INFO  [main:NIOServerCnxnFactory@108] - binding to port 0.0.0.0/0.0.0.0:11221
    [junit] 2012-07-02 10:19:59,046 [myid:] - INFO  [main:FileSnap@83] - Reading snapshot /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build/test/tmp/test2598553261958142782.junit.dir/version-2/snapshot.b
    [junit] 2012-07-02 10:19:59,048 [myid:] - INFO  [main:FileTxnSnapLog@268] - Snapshotting: 0xb to /home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build/test/tmp/test2598553261958142782.junit.dir/version-2/snapshot.b
    [junit] 2012-07-02 10:19:59,093 [myid:] - INFO  [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
    [junit] 2012-07-02 10:19:59,093 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory@211] - Accepted socket connection from /127.0.0.1:58615
    [junit] 2012-07-02 10:19:59,094 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxn@821] - Processing stat command from /127.0.0.1:58615
    [junit] 2012-07-02 10:19:59,107 [myid:] - INFO  [Thread-4:NIOServerCnxn$StatCommand@655] - Stat command output
    [junit] 2012-07-02 10:19:59,109 [myid:] - INFO  [Thread-4:NIOServerCnxn@1001] - Closed socket connection for client /127.0.0.1:58615 (no session established for client)
    [junit] 2012-07-02 10:19:59,110 [myid:] - INFO  [main:JMXEnv@133] - ensureOnly:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2012-07-02 10:19:59,111 [myid:] - INFO  [main:JMXEnv@105] - expect:InMemoryDataTree
    [junit] 2012-07-02 10:19:59,111 [myid:] - INFO  [main:JMXEnv@108] - found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
    [junit] 2012-07-02 10:19:59,112 [myid:] - INFO  [main:JMXEnv@105] - expect:StandaloneServer_port
    [junit] 2012-07-02 10:19:59,112 [myid:] - INFO  [main:JMXEnv@108] - found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
    [junit] 2012-07-02 10:19:59,112 [myid:] - INFO  [main:JUnit4ZKTestRunner$LoggedInvokeMethod@57] - FINISHED TEST METHOD testQuota
    [junit] 2012-07-02 10:19:59,112 [myid:] - INFO  [main:ClientBase@448] - tearDown starting
    [junit] 2012-07-02 10:20:00,000 [myid:] - INFO  [SessionTracker:SessionTrackerImpl@162] - SessionTrackerImpl exited loop!
    [junit] 2012-07-02 10:20:00,000 [myid:] - INFO  [SessionTracker:SessionTrackerImpl@162] - SessionTrackerImpl exited loop!
    [junit] 2012-07-02 10:20:00,680 [myid:] - INFO  [main-SendThread(localhost:11221):ClientCnxn$SendThread@944] - Opening socket connection to server localhost/127.0.0.1:11221
    [junit] 2012-07-02 10:20:00,681 [myid:] - INFO  [main-SendThread(localhost:11221):ZooKeeperSaslClient@125] - Client will not SASL-authenticate because the default JAAS configuration section 'Client' could not be found. If you are not using SASL, you may ignore this. On the other hand, if you expected SASL to work, please fix your JAAS configuration.
    [junit] 2012-07-02 10:20:00,681 [myid:] - INFO  [main-SendThread(localhost:11221):ClientCnxn$SendThread@850] - Socket connection established to localhost/127.0.0.1:11221, initiating session
    [junit] 2012-07-02 10:20:00,681 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory@211] - Accepted socket connection from /127.0.0.1:58616
    [junit] 2012-07-02 10:20:00,682 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:ZooKeeperServer@816] - Client attempting to renew session 0x13847342f200000 at /127.0.0.1:58616
    [junit] 2012-07-02 10:20:00,683 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:ZooKeeperServer@567] - Established session 0x13847342f200000 with negotiated timeout 30000 for client /127.0.0.1:58616
    [junit] 2012-07-02 10:20:00,683 [myid:] - INFO  [main-SendThread(localhost:11221):ClientCnxn$SendThread@1179] - Session establishment complete on server localhost/127.0.0.1:11221, sessionid = 0x13847342f200000, negotiated timeout = 30000
    [junit] 2012-07-02 10:20:00,683 [myid:] - INFO  [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@466] - Processed session termination for sessionid: 0x13847342f200000
    [junit] 2012-07-02 10:20:00,683 [myid:] - INFO  [SyncThread:0:FileTxnLog@199] - Creating new log file: log.c
    [junit] 2012-07-02 10:20:00,697 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxn@1001] - Closed socket connection for client /127.0.0.1:58616 which had sessionid 0x13847342f200000
    [junit] 2012-07-02 10:20:00,698 [myid:] - INFO  [main:ZooKeeper@679] - Session: 0x13847342f200000 closed
    [junit] 2012-07-02 10:20:00,698 [myid:] - INFO  [main-EventThread:ClientCnxn$EventThread@511] - EventThread shut down
    [junit] 2012-07-02 10:20:00,698 [myid:] - INFO  [main:ClientBase@418] - STOPPING server
    [junit] 2012-07-02 10:20:00,698 [myid:] - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory@238] - NIOServerCnxn factory exited run method
    [junit] 2012-07-02 10:20:00,699 [myid:] - INFO  [main:ZooKeeperServer@399] - shutting down
    [junit] 2012-07-02 10:20:00,699 [myid:] - INFO  [main:SessionTrackerImpl@220] - Shutting down
    [junit] 2012-07-02 10:20:00,699 [myid:] - INFO  [main:PrepRequestProcessor@733] - Shutting down
    [junit] 2012-07-02 10:20:00,699 [myid:] - INFO  [main:SyncRequestProcessor@175] - Shutting down
    [junit] 2012-07-02 10:20:00,699 [myid:] - INFO  [SyncThread:0:SyncRequestProcessor@155] - SyncRequestProcessor exited!
    [junit] 2012-07-02 10:20:00,699 [myid:] - INFO  [ProcessThread(sid:0 cport:-1)::PrepRequestProcessor@142] - PrepRequestProcessor exited loop!
    [junit] 2012-07-02 10:20:00,700 [myid:] - INFO  [main:FinalRequestProcessor@411] - shutdown of request processor complete
    [junit] 2012-07-02 10:20:00,700 [myid:] - INFO  [main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
    [junit] 2012-07-02 10:20:00,701 [myid:] - INFO  [main:JMXEnv@133] - ensureOnly:[]
    [junit] 2012-07-02 10:20:00,704 [myid:] - INFO  [main:ClientBase@476] - fdcount after test is: 41 at start it was 29
    [junit] 2012-07-02 10:20:00,704 [myid:] - INFO  [main:ClientBase@478] - sleeping for 20 secs
    [junit] 2012-07-02 10:20:00,705 [myid:] - INFO  [main:ZKTestCase$1@61] - SUCCEEDED testQuota
    [junit] 2012-07-02 10:20:00,706 [myid:] - INFO  [main:ZKTestCase$1@56] - FINISHED testQuota
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 2.725 sec

BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build.xml:1302: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/ZooKeeper-trunk-jdk7/trunk/build.xml:1213: Tests failed!

Total time: 26 minutes 32 seconds
Build step 'Execute shell' marked build as failure
[WARNINGS] Skipping publisher since build result is FAILURE
Archiving artifacts
Recording test results
Publishing Javadoc
Email was triggered for: Failure
Sending email for trigger: Failure



###################################################################################
############################## FAILED TESTS (if any) ##############################
2 tests failed.
REGRESSION:  org.apache.zookeeper.server.quorum.Zab1_0Test.testLeaderInElectingFollowers

Error Message:
Address already in use

Stack Trace:
java.net.BindException: Address already in use
	at java.net.PlainSocketImpl.socketBind(Native Method)
	at java.net.AbstractPlainSocketImpl.bind(AbstractPlainSocketImpl.java:374)
	at java.net.ServerSocket.bind(ServerSocket.java:376)
	at java.net.ServerSocket.bind(ServerSocket.java:330)
	at org.apache.zookeeper.server.quorum.Leader.<init>(Leader.java:184)
	at org.apache.zookeeper.server.quorum.Zab1_0Test.createLeader(Zab1_0Test.java:815)
	at org.apache.zookeeper.server.quorum.Zab1_0Test.testLeaderInElectingFollowers(Zab1_0Test.java:226)


REGRESSION:  org.apache.zookeeper.server.quorum.Zab1_0Test.testLeaderInConnectingFollowers

Error Message:
Address already in use

Stack Trace:
java.net.BindException: Address already in use
	at java.net.PlainSocketImpl.socketBind(Native Method)
	at java.net.AbstractPlainSocketImpl.bind(AbstractPlainSocketImpl.java:374)
	at java.net.ServerSocket.bind(ServerSocket.java:376)
	at java.net.ServerSocket.bind(ServerSocket.java:330)
	at org.apache.zookeeper.server.quorum.Leader.<init>(Leader.java:184)
	at org.apache.zookeeper.server.quorum.Zab1_0Test.createLeader(Zab1_0Test.java:815)
	at org.apache.zookeeper.server.quorum.Zab1_0Test.testLeaderInConnectingFollowers(Zab1_0Test.java:137)