See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/280/changes
Changes: [mahadev] ZOOKEEPER-361. integrate cppunit testing as part of hudson patch process. (giri via mahadev) ------------------------------------------ [...truncated 54082 lines...] [junit] 2009-04-15 05:32:39,078 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-04-15 05:32:39,078 - INFO [SyncThread:0:syncrequestproces...@119] - SyncRequestProcessor exited! [junit] 2009-04-15 05:32:39,080 - INFO [ProcessThread:-1:preprequestproces...@111] - PrepRequestProcessor exited loop! [junit] 2009-04-15 05:32:39,180 - INFO [main:clientb...@306] - STARTING server [junit] 2009-04-15 05:32:39,181 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-04-15 05:32:39,182 - INFO [main:files...@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8340474231230349885.junit.dir/version-2/snapshot.0 [junit] 2009-04-15 05:32:39,183 - INFO [main:filetxnsnap...@198] - Snapshotting: 3 [junit] 2009-04-15 05:32:39,185 - INFO [NIOServerCxn.Factory:33221:nioserverc...@635] - Processing stat command from /127.0.0.1:51772 [junit] 2009-04-15 05:32:39,185 - WARN [NIOServerCxn.Factory:33221:nioserverc...@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-04-15 05:32:39,185 - INFO [NIOServerCxn.Factory:33221:nioserverc...@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51772] [junit] 2009-04-15 05:32:40,889 - INFO [main-SendThread:clientcnxn$sendthr...@800] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-04-15 05:32:40,889 - INFO [main-SendThread:clientcnxn$sendthr...@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51773 remote=/127.0.0.1:33221] [junit] 2009-04-15 05:32:40,890 - INFO [main-SendThread:clientcnxn$sendthr...@868] - Server connection successful [junit] 2009-04-15 05:32:40,890 - INFO [NIOServerCxn.Factory:33221:nioserverc...@517] - Connected to /127.0.0.1:51773 lastZxid 3 [junit] 2009-04-15 05:32:40,890 - INFO [NIOServerCxn.Factory:33221:nioserverc...@895] - Finished init of 0x120a84339140000 valid:true [junit] 2009-04-15 05:32:40,891 - INFO [NIOServerCxn.Factory:33221:nioserverc...@545] - Renewing session 0x120a84339140000 [junit] 2009-04-15 05:32:42,000 - INFO [SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop! [junit] 2009-04-15 05:32:42,001 - INFO [SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop! [junit] 2009-04-15 05:33:14,902 - INFO [main:clientb...@300] - STOPPING server [junit] 2009-04-15 05:33:14,903 - INFO [main:nioserverc...@766] - closing session:0x120a84339140000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51773] [junit] 2009-04-15 05:33:14,904 - WARN [main-SendThread:clientcnxn$sendthr...@898] - Exception closing session 0x120a84339140000 to sun.nio.ch.selectionkeyi...@147358f [junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] [junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632) [junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876) [junit] 2009-04-15 05:33:14,904 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@177] - NIOServerCnxn factory exited run method [junit] 2009-04-15 05:33:14,905 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-04-15 05:33:14,905 - INFO [ProcessThread:-1:preprequestproces...@111] - PrepRequestProcessor exited loop! [junit] 2009-04-15 05:33:14,905 - INFO [SyncThread:0:syncrequestproces...@119] - SyncRequestProcessor exited! [junit] 2009-04-15 05:33:15,000 - INFO [SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop! [junit] 2009-04-15 05:33:15,004 - INFO [main:clientb...@306] - STARTING server [junit] 2009-04-15 05:33:15,005 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-04-15 05:33:15,006 - INFO [main:files...@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8340474231230349885.junit.dir/version-2/snapshot.3 [junit] 2009-04-15 05:33:15,008 - INFO [main:filetxnsnap...@198] - Snapshotting: 5 [junit] 2009-04-15 05:33:15,010 - INFO [NIOServerCxn.Factory:33221:nioserverc...@635] - Processing stat command from /127.0.0.1:51775 [junit] 2009-04-15 05:33:15,010 - WARN [NIOServerCxn.Factory:33221:nioserverc...@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-04-15 05:33:15,011 - INFO [NIOServerCxn.Factory:33221:nioserverc...@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51775] [junit] 2009-04-15 05:33:16,503 - INFO [main-SendThread:clientcnxn$sendthr...@800] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-04-15 05:33:16,504 - INFO [main-SendThread:clientcnxn$sendthr...@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51776 remote=/127.0.0.1:33221] [junit] 2009-04-15 05:33:16,504 - INFO [main-SendThread:clientcnxn$sendthr...@868] - Server connection successful [junit] 2009-04-15 05:33:16,504 - INFO [NIOServerCxn.Factory:33221:nioserverc...@517] - Connected to /127.0.0.1:51776 lastZxid 5 [junit] 2009-04-15 05:33:16,505 - INFO [NIOServerCxn.Factory:33221:nioserverc...@895] - Finished init of 0x120a84339140000 valid:true [junit] 2009-04-15 05:33:16,505 - INFO [NIOServerCxn.Factory:33221:nioserverc...@545] - Renewing session 0x120a84339140000 [junit] 2009-04-15 05:33:16,523 - INFO [main:clientb...@300] - STOPPING server [junit] 2009-04-15 05:33:16,524 - INFO [main:nioserverc...@766] - closing session:0x120a84339140000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51776] [junit] 2009-04-15 05:33:16,524 - WARN [main-SendThread:clientcnxn$sendthr...@898] - Exception closing session 0x120a84339140000 to sun.nio.ch.selectionkeyi...@dada24 [junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] [junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632) [junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876) [junit] 2009-04-15 05:33:16,524 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@177] - NIOServerCnxn factory exited run method [junit] 2009-04-15 05:33:16,525 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-04-15 05:33:16,525 - INFO [SyncThread:0:syncrequestproces...@119] - SyncRequestProcessor exited! [junit] 2009-04-15 05:33:16,525 - INFO [ProcessThread:-1:preprequestproces...@111] - PrepRequestProcessor exited loop! [junit] 2009-04-15 05:33:16,624 - INFO [main:clientb...@306] - STARTING server [junit] 2009-04-15 05:33:16,625 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-04-15 05:33:16,626 - INFO [main:files...@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8340474231230349885.junit.dir/version-2/snapshot.5 [junit] 2009-04-15 05:33:16,628 - INFO [main:filetxnsnap...@198] - Snapshotting: 6 [junit] 2009-04-15 05:33:16,630 - INFO [NIOServerCxn.Factory:33221:nioserverc...@635] - Processing stat command from /127.0.0.1:51778 [junit] 2009-04-15 05:33:16,631 - WARN [NIOServerCxn.Factory:33221:nioserverc...@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-04-15 05:33:16,631 - INFO [NIOServerCxn.Factory:33221:nioserverc...@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51778] [junit] 2009-04-15 05:33:18,000 - INFO [SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop! [junit] 2009-04-15 05:33:18,185 - INFO [main-SendThread:clientcnxn$sendthr...@800] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-04-15 05:33:18,186 - INFO [main-SendThread:clientcnxn$sendthr...@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51779 remote=/127.0.0.1:33221] [junit] 2009-04-15 05:33:18,186 - INFO [main-SendThread:clientcnxn$sendthr...@868] - Server connection successful [junit] 2009-04-15 05:33:18,186 - INFO [NIOServerCxn.Factory:33221:nioserverc...@517] - Connected to /127.0.0.1:51779 lastZxid 6 [junit] 2009-04-15 05:33:18,187 - INFO [NIOServerCxn.Factory:33221:nioserverc...@895] - Finished init of 0x120a84339140000 valid:true [junit] 2009-04-15 05:33:18,187 - INFO [NIOServerCxn.Factory:33221:nioserverc...@545] - Renewing session 0x120a84339140000 [junit] 2009-04-15 05:33:29,203 - INFO [main:zookee...@435] - Closing session: 0x120a84339140000 [junit] 2009-04-15 05:33:29,203 - INFO [main:clientc...@999] - Closing ClientCnxn for session: 0x120a84339140000 [junit] 2009-04-15 05:33:29,204 - INFO [ProcessThread:-1:preprequestproces...@365] - Processed session termination request for id: 0x120a84339140000 [junit] 2009-04-15 05:33:29,205 - INFO [SyncThread:0:nioserverc...@766] - closing session:0x120a84339140000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51779] [junit] 2009-04-15 05:33:29,205 - INFO [main-SendThread:clientcnxn$sendthr...@892] - Exception while closing send thread for session 0x120a84339140000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] [junit] 2009-04-15 05:33:29,305 - INFO [main:clientc...@985] - Disconnecting ClientCnxn for session: 0x120a84339140000 [junit] 2009-04-15 05:33:29,306 - INFO [main:zookee...@443] - Session: 0x120a84339140000 closed [junit] 2009-04-15 05:33:29,306 - INFO [main-EventThread:clientcnxn$eventthr...@452] - EventThread shut down [junit] 2009-04-15 05:33:29,306 - INFO [main:clientb...@312] - tearDown starting [junit] 2009-04-15 05:33:29,307 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@177] - NIOServerCnxn factory exited run method [junit] 2009-04-15 05:33:29,307 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-04-15 05:33:29,307 - INFO [SyncThread:0:syncrequestproces...@119] - SyncRequestProcessor exited! [junit] 2009-04-15 05:33:29,307 - INFO [ProcessThread:-1:preprequestproces...@111] - PrepRequestProcessor exited loop! [junit] 2009-04-15 05:33:29,309 - INFO [main:clientb...@322] - FINISHED testWatcherAutoResetDisabledWithGlobal [junit] 2009-04-15 05:33:29,309 - INFO [main:clientb...@288] - STARTING testWatcherAutoResetDisabledWithLocal [junit] 2009-04-15 05:33:29,310 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-04-15 05:33:29,311 - INFO [main:filetxnsnap...@198] - Snapshotting: 0 [junit] 2009-04-15 05:33:29,313 - INFO [NIOServerCxn.Factory:33221:nioserverc...@635] - Processing stat command from /127.0.0.1:51781 [junit] 2009-04-15 05:33:29,314 - INFO [main:clientb...@296] - Client test setup finished [junit] 2009-04-15 05:33:29,314 - INFO [main:zookee...@342] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=9000 watcher=org.apache.zookeeper.test.watchertest$mywatc...@df48c4 [junit] 2009-04-15 05:33:29,314 - INFO [main-SendThread:clientcnxn$sendthr...@800] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-04-15 05:33:29,315 - INFO [main-SendThread:clientcnxn$sendthr...@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51782 remote=/127.0.0.1:33221] [junit] 2009-04-15 05:33:29,315 - INFO [main-SendThread:clientcnxn$sendthr...@868] - Server connection successful [junit] 2009-04-15 05:33:29,314 - WARN [NIOServerCxn.Factory:33221:nioserverc...@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-04-15 05:33:29,317 - INFO [NIOServerCxn.Factory:33221:nioserverc...@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51781] [junit] 2009-04-15 05:33:29,318 - INFO [NIOServerCxn.Factory:33221:nioserverc...@517] - Connected to /127.0.0.1:51782 lastZxid 0 [junit] 2009-04-15 05:33:29,319 - INFO [NIOServerCxn.Factory:33221:nioserverc...@548] - Creating new session 0x120a843fd5f0000 [junit] 2009-04-15 05:33:29,321 - INFO [SyncThread:0:nioserverc...@895] - Finished init of 0x120a843fd5f0000 valid:true [junit] 2009-04-15 05:33:29,326 - INFO [main:clientb...@300] - STOPPING server [junit] 2009-04-15 05:33:29,327 - INFO [main:nioserverc...@766] - closing session:0x120a843fd5f0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51782] [junit] 2009-04-15 05:33:29,328 - WARN [main-SendThread:clientcnxn$sendthr...@898] - Exception closing session 0x120a843fd5f0000 to sun.nio.ch.selectionkeyi...@ee3aa7 [junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] [junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632) [junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876) [junit] 2009-04-15 05:33:29,328 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@177] - NIOServerCnxn factory exited run method [junit] 2009-04-15 05:33:29,329 - INFO [ProcessThread:-1:preprequestproces...@111] - PrepRequestProcessor exited loop! [junit] 2009-04-15 05:33:29,329 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-04-15 05:33:29,329 - INFO [SyncThread:0:syncrequestproces...@119] - SyncRequestProcessor exited! [junit] 2009-04-15 05:33:29,428 - INFO [main:clientb...@306] - STARTING server [junit] 2009-04-15 05:33:29,428 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-04-15 05:33:29,430 - INFO [main:files...@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test3606980780077583860.junit.dir/version-2/snapshot.0 [junit] 2009-04-15 05:33:29,431 - INFO [main:filetxnsnap...@198] - Snapshotting: 3 [junit] 2009-04-15 05:33:29,433 - INFO [NIOServerCxn.Factory:33221:nioserverc...@635] - Processing stat command from /127.0.0.1:51784 [junit] 2009-04-15 05:33:29,433 - WARN [NIOServerCxn.Factory:33221:nioserverc...@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-04-15 05:33:29,433 - INFO [NIOServerCxn.Factory:33221:nioserverc...@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51784] [junit] 2009-04-15 05:33:30,000 - INFO [SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop! [junit] 2009-04-15 05:33:30,000 - INFO [SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop! [junit] 2009-04-15 05:33:31,100 - INFO [main-SendThread:clientcnxn$sendthr...@800] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-04-15 05:33:31,101 - INFO [main-SendThread:clientcnxn$sendthr...@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51786 remote=/127.0.0.1:33221] [junit] 2009-04-15 05:33:31,101 - INFO [main-SendThread:clientcnxn$sendthr...@868] - Server connection successful [junit] 2009-04-15 05:33:31,101 - INFO [NIOServerCxn.Factory:33221:nioserverc...@517] - Connected to /127.0.0.1:51786 lastZxid 3 [junit] 2009-04-15 05:33:31,102 - INFO [NIOServerCxn.Factory:33221:nioserverc...@895] - Finished init of 0x120a843fd5f0000 valid:true [junit] 2009-04-15 05:33:31,102 - INFO [NIOServerCxn.Factory:33221:nioserverc...@545] - Renewing session 0x120a843fd5f0000 [junit] 2009-04-15 05:34:05,133 - INFO [main:clientb...@300] - STOPPING server [junit] 2009-04-15 05:34:05,134 - INFO [main:nioserverc...@766] - closing session:0x120a843fd5f0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51786] [junit] 2009-04-15 05:34:05,134 - WARN [main-SendThread:clientcnxn$sendthr...@898] - Exception closing session 0x120a843fd5f0000 to sun.nio.ch.selectionkeyi...@c4d04d [junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] [junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632) [junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876) [junit] 2009-04-15 05:34:05,145 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@177] - NIOServerCnxn factory exited run method [junit] 2009-04-15 05:34:05,145 - INFO [ProcessThread:-1:preprequestproces...@111] - PrepRequestProcessor exited loop! [junit] 2009-04-15 05:34:05,145 - INFO [SyncThread:0:syncrequestproces...@119] - SyncRequestProcessor exited! [junit] 2009-04-15 05:34:05,146 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-04-15 05:34:05,235 - INFO [main:clientb...@306] - STARTING server [junit] 2009-04-15 05:34:05,235 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-04-15 05:34:05,236 - INFO [main:files...@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test3606980780077583860.junit.dir/version-2/snapshot.3 [junit] 2009-04-15 05:34:05,238 - INFO [main:filetxnsnap...@198] - Snapshotting: 5 [junit] 2009-04-15 05:34:05,240 - INFO [NIOServerCxn.Factory:33221:nioserverc...@635] - Processing stat command from /127.0.0.1:51788 [junit] 2009-04-15 05:34:05,240 - WARN [NIOServerCxn.Factory:33221:nioserverc...@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-04-15 05:34:05,241 - INFO [NIOServerCxn.Factory:33221:nioserverc...@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51788] [junit] 2009-04-15 05:34:06,000 - INFO [SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop! [junit] 2009-04-15 05:34:06,376 - INFO [main-SendThread:clientcnxn$sendthr...@800] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-04-15 05:34:06,376 - INFO [main-SendThread:clientcnxn$sendthr...@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51789 remote=/127.0.0.1:33221] [junit] 2009-04-15 05:34:06,376 - INFO [main-SendThread:clientcnxn$sendthr...@868] - Server connection successful [junit] 2009-04-15 05:34:06,377 - INFO [NIOServerCxn.Factory:33221:nioserverc...@517] - Connected to /127.0.0.1:51789 lastZxid 5 [junit] 2009-04-15 05:34:06,377 - INFO [NIOServerCxn.Factory:33221:nioserverc...@895] - Finished init of 0x120a843fd5f0000 valid:true [junit] 2009-04-15 05:34:06,377 - INFO [NIOServerCxn.Factory:33221:nioserverc...@545] - Renewing session 0x120a843fd5f0000 [junit] 2009-04-15 05:34:06,391 - INFO [main:clientb...@300] - STOPPING server [junit] 2009-04-15 05:34:06,392 - INFO [main:nioserverc...@766] - closing session:0x120a843fd5f0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51789] [junit] 2009-04-15 05:34:06,392 - WARN [main-SendThread:clientcnxn$sendthr...@898] - Exception closing session 0x120a843fd5f0000 to sun.nio.ch.selectionkeyi...@354749 [junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] [junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632) [junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876) [junit] 2009-04-15 05:34:06,393 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@177] - NIOServerCnxn factory exited run method [junit] 2009-04-15 05:34:06,393 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-04-15 05:34:06,393 - INFO [ProcessThread:-1:preprequestproces...@111] - PrepRequestProcessor exited loop! [junit] 2009-04-15 05:34:06,393 - INFO [SyncThread:0:syncrequestproces...@119] - SyncRequestProcessor exited! [junit] 2009-04-15 05:34:06,493 - INFO [main:clientb...@306] - STARTING server [junit] 2009-04-15 05:34:06,493 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-04-15 05:34:06,495 - INFO [main:files...@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test3606980780077583860.junit.dir/version-2/snapshot.5 [junit] 2009-04-15 05:34:06,496 - INFO [main:filetxnsnap...@198] - Snapshotting: 6 [junit] 2009-04-15 05:34:06,498 - INFO [NIOServerCxn.Factory:33221:nioserverc...@635] - Processing stat command from /127.0.0.1:51791 [junit] 2009-04-15 05:34:06,498 - WARN [NIOServerCxn.Factory:33221:nioserverc...@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-04-15 05:34:06,499 - INFO [NIOServerCxn.Factory:33221:nioserverc...@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51791] [junit] 2009-04-15 05:34:07,880 - INFO [main-SendThread:clientcnxn$sendthr...@800] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-04-15 05:34:07,880 - INFO [main-SendThread:clientcnxn$sendthr...@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51792 remote=/127.0.0.1:33221] [junit] 2009-04-15 05:34:07,880 - INFO [main-SendThread:clientcnxn$sendthr...@868] - Server connection successful [junit] 2009-04-15 05:34:07,881 - INFO [NIOServerCxn.Factory:33221:nioserverc...@517] - Connected to /127.0.0.1:51792 lastZxid 6 [junit] 2009-04-15 05:34:07,882 - INFO [NIOServerCxn.Factory:33221:nioserverc...@895] - Finished init of 0x120a843fd5f0000 valid:true [junit] 2009-04-15 05:34:07,882 - INFO [NIOServerCxn.Factory:33221:nioserverc...@545] - Renewing session 0x120a843fd5f0000 [junit] 2009-04-15 05:34:09,000 - INFO [SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop! [junit] 2009-04-15 05:34:18,894 - INFO [main:zookee...@435] - Closing session: 0x120a843fd5f0000 [junit] 2009-04-15 05:34:18,894 - INFO [main:clientc...@999] - Closing ClientCnxn for session: 0x120a843fd5f0000 [junit] 2009-04-15 05:34:18,895 - INFO [ProcessThread:-1:preprequestproces...@365] - Processed session termination request for id: 0x120a843fd5f0000 [junit] 2009-04-15 05:34:18,895 - INFO [SyncThread:0:nioserverc...@766] - closing session:0x120a843fd5f0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51792] [junit] 2009-04-15 05:34:18,896 - INFO [main-SendThread:clientcnxn$sendthr...@892] - Exception while closing send thread for session 0x120a843fd5f0000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] [junit] 2009-04-15 05:34:18,996 - INFO [main:clientc...@985] - Disconnecting ClientCnxn for session: 0x120a843fd5f0000 [junit] 2009-04-15 05:34:18,996 - INFO [main:zookee...@443] - Session: 0x120a843fd5f0000 closed [junit] 2009-04-15 05:34:18,996 - INFO [main-EventThread:clientcnxn$eventthr...@452] - EventThread shut down [junit] 2009-04-15 05:34:18,996 - INFO [main:clientb...@312] - tearDown starting [junit] 2009-04-15 05:34:18,997 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@177] - NIOServerCnxn factory exited run method [junit] 2009-04-15 05:34:18,997 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-04-15 05:34:18,997 - INFO [SyncThread:0:syncrequestproces...@119] - SyncRequestProcessor exited! [junit] 2009-04-15 05:34:18,997 - INFO [ProcessThread:-1:preprequestproces...@111] - PrepRequestProcessor exited loop! [junit] 2009-04-15 05:34:18,999 - INFO [main:clientb...@322] - FINISHED testWatcherAutoResetDisabledWithLocal [junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 125.532 sec [junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest [junit] 2009-04-15 05:34:19,295 - INFO [main:clientb...@288] - STARTING testQuota [junit] 2009-04-15 05:34:19,308 - INFO [main:environm...@97] - Server environment:zookeeper.version=3.2.0-765051, built on 04/15/2009 05:25 GMT [junit] 2009-04-15 05:34:19,309 - INFO [main:environm...@97] - Server environment:host.name=vesta.apache.org [junit] 2009-04-15 05:34:19,310 - INFO [main:environm...@97] - Server environment:java.version=1.6.0_11 [junit] 2009-04-15 05:34:19,311 - INFO [main:environm...@97] - Server environment:java.vendor=Sun Microsystems Inc. [junit] 2009-04-15 05:34:19,312 - INFO [main:environm...@97] - Server environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre [junit] 2009-04-15 05:34:19,312 - INFO [main:environm...@97] - Server environment:java.class.path=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/280/artifact/trunk/zookeeper-dev.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/junit-4.4.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/log4j-1.2.15.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/testclasses :/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant-launcher.jar:/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant.jar:/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant-junit.jar [junit] 2009-04-15 05:34:19,313 - INFO [main:environm...@97] - Server environment:java.library.path=/home/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386/server:/home/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386:/home/hudson/tools/java/jdk1.6.0_11-32/jre/../lib/i386:/usr/java/packages/lib/i386:/lib:/usr/lib [junit] 2009-04-15 05:34:19,314 - INFO [main:environm...@97] - Server environment:java.io.tmpdir=/tmp [junit] 2009-04-15 05:34:19,315 - INFO [main:environm...@97] - Server environment:java.compiler=<NA> [junit] 2009-04-15 05:34:19,316 - INFO [main:environm...@97] - Server environment:os.name=Linux [junit] 2009-04-15 05:34:19,316 - INFO [main:environm...@97] - Server environment:os.arch=i386 [junit] 2009-04-15 05:34:19,317 - INFO [main:environm...@97] - Server environment:os.version=2.6.27-7-server [junit] 2009-04-15 05:34:19,318 - INFO [main:environm...@97] - Server environment:user.name=hudson [junit] 2009-04-15 05:34:19,319 - INFO [main:environm...@97] - Server environment:user.home=/home/hudson [junit] 2009-04-15 05:34:19,319 - INFO [main:environm...@97] - Server environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk [junit] 2009-04-15 05:34:19,323 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-04-15 05:34:19,340 - INFO [main:filetxnsnap...@198] - Snapshotting: 0 [junit] 2009-04-15 05:34:19,397 - INFO [NIOServerCxn.Factory:33221:nioserverc...@635] - Processing stat command from /127.0.0.1:51795 [junit] 2009-04-15 05:34:19,398 - WARN [NIOServerCxn.Factory:33221:nioserverc...@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-04-15 05:34:19,398 - INFO [main:clientb...@296] - Client test setup finished [junit] 2009-04-15 05:34:19,398 - INFO [NIOServerCxn.Factory:33221:nioserverc...@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51795] [junit] 2009-04-15 05:34:19,401 - INFO [main:environm...@97] - Client environment:zookeeper.version=3.2.0-765051, built on 04/15/2009 05:25 GMT [junit] 2009-04-15 05:34:19,401 - INFO [main:environm...@97] - Client environment:host.name=vesta.apache.org [junit] 2009-04-15 05:34:19,402 - INFO [main:environm...@97] - Client environment:java.version=1.6.0_11 [junit] 2009-04-15 05:34:19,402 - INFO [main:environm...@97] - Client environment:java.vendor=Sun Microsystems Inc. [junit] 2009-04-15 05:34:19,402 - INFO [main:environm...@97] - Client environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre [junit] 2009-04-15 05:34:19,403 - INFO [main:environm...@97] - Client environment:java.class.path=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/280/artifact/trunk/zookeeper-dev.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/junit-4.4.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/log4j-1.2.15.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/testclasses :/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant-launcher.jar:/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant.jar:/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant-junit.jar [junit] 2009-04-15 05:34:19,411 - INFO [main:environm...@97] - Client environment:java.library.path=/home/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386/server:/home/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386:/home/hudson/tools/java/jdk1.6.0_11-32/jre/../lib/i386:/usr/java/packages/lib/i386:/lib:/usr/lib [junit] 2009-04-15 05:34:19,412 - INFO [main:environm...@97] - Client environment:java.io.tmpdir=/tmp [junit] 2009-04-15 05:34:19,413 - INFO [main:environm...@97] - Client environment:java.compiler=<NA> [junit] 2009-04-15 05:34:19,414 - INFO [main:environm...@97] - Client environment:os.name=Linux [junit] 2009-04-15 05:34:19,415 - INFO [main:environm...@97] - Client environment:os.arch=i386 [junit] 2009-04-15 05:34:19,415 - INFO [main:environm...@97] - Client environment:os.version=2.6.27-7-server [junit] 2009-04-15 05:34:19,416 - INFO [main:environm...@97] - Client environment:user.name=hudson [junit] 2009-04-15 05:34:19,417 - INFO [main:environm...@97] - Client environment:user.home=/home/hudson [junit] 2009-04-15 05:34:19,418 - INFO [main:environm...@97] - Client environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk [junit] 2009-04-15 05:34:19,420 - INFO [main:zookee...@342] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=9000 watcher=org.apache.zookeeper.test.clientbase$countdownwatc...@1bcdbf6 [junit] 2009-04-15 05:34:19,422 - INFO [main:clientc...@91] - zookeeper.disableAutoWatchReset is false [junit] 2009-04-15 05:34:19,426 - INFO [main-SendThread:clientcnxn$sendthr...@800] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-04-15 05:34:19,427 - INFO [main-SendThread:clientcnxn$sendthr...@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51796 remote=/127.0.0.1:33221] [junit] 2009-04-15 05:34:19,430 - INFO [main-SendThread:clientcnxn$sendthr...@868] - Server connection successful [junit] 2009-04-15 05:34:19,432 - INFO [NIOServerCxn.Factory:33221:nioserverc...@517] - Connected to /127.0.0.1:51796 lastZxid 0 [junit] 2009-04-15 05:34:19,434 - INFO [NIOServerCxn.Factory:33221:nioserverc...@548] - Creating new session 0x120a844c0d00000 [junit] 2009-04-15 05:34:19,465 - INFO [SyncThread:0:nioserverc...@895] - Finished init of 0x120a844c0d00000 valid:true [junit] 2009-04-15 05:34:19,493 - INFO [main:clientb...@312] - tearDown starting [junit] 2009-04-15 05:34:19,493 - INFO [main:nioserverc...@766] - closing session:0x120a844c0d00000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51796] [junit] 2009-04-15 05:34:19,494 - WARN [main-SendThread:clientcnxn$sendthr...@898] - Exception closing session 0x120a844c0d00000 to sun.nio.ch.selectionkeyi...@1bb5c09 [junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] [junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632) [junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876) [junit] 2009-04-15 05:34:19,495 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@177] - NIOServerCnxn factory exited run method [junit] 2009-04-15 05:34:19,495 - INFO [ProcessThread:-1:preprequestproces...@111] - PrepRequestProcessor exited loop! [junit] 2009-04-15 05:34:19,496 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-04-15 05:34:19,496 - INFO [SyncThread:0:syncrequestproces...@119] - SyncRequestProcessor exited! [junit] 2009-04-15 05:34:19,498 - INFO [main:clientb...@322] - FINISHED testQuota [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.245 sec BUILD FAILED http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :644: The following error occurred while executing this line: http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :573: Tests failed! Total time: 8 minutes 30 seconds Recording fingerprints Publishing Javadoc Recording test results