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
