See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/320/
------------------------------------------ [...truncated 125963 lines...] [junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:653) [junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:897) [junit] 2009-05-21 19:18:58,212 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@190] - NIOServerCnxn factory exited run method [junit] 2009-05-21 19:18:58,213 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-05-21 19:18:58,213 - INFO [SyncThread:0:syncrequestproces...@118] - SyncRequestProcessor exited! [junit] ensureOnly:[] [junit] 2009-05-21 19:18:58,213 - INFO [ProcessThread:-1:preprequestproces...@109] - PrepRequestProcessor exited loop! [junit] 2009-05-21 19:18:58,312 - INFO [main:clientb...@316] - STARTING server [junit] 2009-05-21 19:18:58,313 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-05-21 19:18:58,314 - INFO [main:files...@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test5747648790557940842.junit.dir/version-2/snapshot.5 [junit] 2009-05-21 19:18:58,316 - INFO [main:filetxnsnap...@198] - Snapshotting: 6 [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port] [junit] 2009-05-21 19:18:58,318 - INFO [NIOServerCxn.Factory:33221:nioserverc...@646] - Processing stat command from /127.0.0.1:60901 [junit] 2009-05-21 19:18:58,318 - WARN [NIOServerCxn.Factory:33221:nioserverc...@444] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-05-21 19:18:58,319 - INFO [NIOServerCxn.Factory:33221:nioserverc...@777] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60901] [junit] expect:InMemoryDataTree [junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree [junit] expect:StandaloneServer_port [junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1 [junit] 2009-05-21 19:18:59,874 - INFO [main-SendThread:clientcnxn$sendthr...@821] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-05-21 19:18:59,874 - INFO [main-SendThread:clientcnxn$sendthr...@737] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:60902 remote=/127.0.0.1:33221] [junit] 2009-05-21 19:18:59,875 - INFO [main-SendThread:clientcnxn$sendthr...@889] - Server connection successful [junit] 2009-05-21 19:18:59,875 - INFO [NIOServerCxn.Factory:33221:nioserverc...@532] - Connected to /127.0.0.1:60902 lastZxid 6 [junit] 2009-05-21 19:18:59,875 - INFO [NIOServerCxn.Factory:33221:nioserverc...@906] - Finished init of 0x121649c1c690000 valid:true [junit] 2009-05-21 19:18:59,876 - INFO [NIOServerCxn.Factory:33221:nioserverc...@560] - Renewing session 0x121649c1c690000 [junit] 2009-05-21 19:19:00,000 - INFO [SessionTracker:sessiontrackeri...@141] - SessionTrackerImpl exited loop! [junit] 2009-05-21 19:19:10,962 - INFO [main:zookee...@437] - Closing session: 0x121649c1c690000 [junit] 2009-05-21 19:19:10,962 - INFO [main:clientc...@1020] - Closing ClientCnxn for session: 0x121649c1c690000 [junit] 2009-05-21 19:19:10,963 - INFO [ProcessThread:-1:preprequestproces...@363] - Processed session termination request for id: 0x121649c1c690000 [junit] 2009-05-21 19:19:10,973 - INFO [SyncThread:0:nioserverc...@777] - closing session:0x121649c1c690000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60902] [junit] 2009-05-21 19:19:10,974 - INFO [main-SendThread:clientcnxn$sendthr...@913] - Exception while closing send thread for session 0x121649c1c690000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] [junit] 2009-05-21 19:19:11,074 - INFO [main:clientc...@1006] - Disconnecting ClientCnxn for session: 0x121649c1c690000 [junit] 2009-05-21 19:19:11,075 - INFO [main:zookee...@445] - Session: 0x121649c1c690000 closed [junit] 2009-05-21 19:19:11,075 - INFO [main-EventThread:clientcnxn$eventthr...@473] - EventThread shut down [junit] 2009-05-21 19:19:11,075 - INFO [main:clientb...@332] - tearDown starting [junit] 2009-05-21 19:19:11,075 - INFO [main:clientb...@323] - STOPPING server [junit] 2009-05-21 19:19:11,076 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@190] - NIOServerCnxn factory exited run method [junit] 2009-05-21 19:19:11,076 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-05-21 19:19:11,076 - INFO [ProcessThread:-1:preprequestproces...@109] - PrepRequestProcessor exited loop! [junit] 2009-05-21 19:19:11,076 - INFO [SyncThread:0:syncrequestproces...@118] - SyncRequestProcessor exited! [junit] ensureOnly:[] [junit] 2009-05-21 19:19:11,079 - INFO [main:clientb...@344] - FINISHED testWatcherAutoResetDisabledWithGlobal [junit] 2009-05-21 19:19:11,080 - INFO [main:clientb...@302] - STARTING testWatcherAutoResetDisabledWithLocal [junit] 2009-05-21 19:19:11,084 - INFO [main:clientb...@316] - STARTING server [junit] 2009-05-21 19:19:11,085 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-05-21 19:19:11,086 - INFO [main:filetxnsnap...@198] - Snapshotting: 0 [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port] [junit] 2009-05-21 19:19:11,087 - INFO [NIOServerCxn.Factory:33221:nioserverc...@646] - Processing stat command from /127.0.0.1:60904 [junit] 2009-05-21 19:19:11,088 - WARN [NIOServerCxn.Factory:33221:nioserverc...@444] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-05-21 19:19:11,088 - INFO [NIOServerCxn.Factory:33221:nioserverc...@777] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60904] [junit] expect:InMemoryDataTree [junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree [junit] expect:StandaloneServer_port [junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1 [junit] 2009-05-21 19:19:11,089 - INFO [main:clientb...@312] - Client test setup finished [junit] 2009-05-21 19:19:11,089 - INFO [main:zookee...@342] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=30000 watcher=org.apache.zookeeper.test.watchertest$mywatc...@adf5be [junit] 2009-05-21 19:19:11,089 - INFO [main-SendThread:clientcnxn$sendthr...@821] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-05-21 19:19:11,090 - INFO [main-SendThread:clientcnxn$sendthr...@737] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:60905 remote=/127.0.0.1:33221] [junit] 2009-05-21 19:19:11,090 - INFO [main-SendThread:clientcnxn$sendthr...@889] - Server connection successful [junit] 2009-05-21 19:19:11,090 - INFO [NIOServerCxn.Factory:33221:nioserverc...@532] - Connected to /127.0.0.1:60905 lastZxid 0 [junit] 2009-05-21 19:19:11,091 - INFO [NIOServerCxn.Factory:33221:nioserverc...@563] - Creating new session 0x121649cdfee0000 [junit] 2009-05-21 19:19:11,175 - INFO [SyncThread:0:nioserverc...@906] - Finished init of 0x121649cdfee0000 valid:true [junit] expect:0x121649cdfee0000 [junit] found:0x121649cdfee0000 org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x121649cdfee0000 [junit] 2009-05-21 19:19:11,192 - INFO [main:clientb...@323] - STOPPING server [junit] 2009-05-21 19:19:11,193 - INFO [main:nioserverc...@777] - closing session:0x121649cdfee0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60905] [junit] 2009-05-21 19:19:11,193 - WARN [main-SendThread:clientcnxn$sendthr...@919] - Exception closing session 0x121649cdfee0000 to sun.nio.ch.selectionkeyi...@9fdee [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:653) [junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:897) [junit] 2009-05-21 19:19:11,193 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@190] - NIOServerCnxn factory exited run method [junit] 2009-05-21 19:19:11,194 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-05-21 19:19:11,194 - INFO [SyncThread:0:syncrequestproces...@118] - SyncRequestProcessor exited! [junit] 2009-05-21 19:19:11,194 - INFO [ProcessThread:-1:preprequestproces...@109] - PrepRequestProcessor exited loop! [junit] ensureOnly:[] [junit] 2009-05-21 19:19:11,293 - INFO [main:clientb...@316] - STARTING server [junit] 2009-05-21 19:19:11,294 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-05-21 19:19:11,295 - INFO [main:files...@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8897024993216438962.junit.dir/version-2/snapshot.0 [junit] 2009-05-21 19:19:11,296 - INFO [main:filetxnsnap...@198] - Snapshotting: 3 [junit] 2009-05-21 19:19:11,299 - INFO [NIOServerCxn.Factory:33221:nioserverc...@646] - Processing stat command from /127.0.0.1:60907 [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port] [junit] 2009-05-21 19:19:11,299 - WARN [NIOServerCxn.Factory:33221:nioserverc...@444] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-05-21 19:19:11,300 - INFO [NIOServerCxn.Factory:33221:nioserverc...@777] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60907] [junit] expect:InMemoryDataTree [junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree [junit] expect:StandaloneServer_port [junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1 [junit] 2009-05-21 19:19:12,000 - INFO [SessionTracker:sessiontrackeri...@141] - SessionTrackerImpl exited loop! [junit] 2009-05-21 19:19:12,000 - INFO [SessionTracker:sessiontrackeri...@141] - SessionTrackerImpl exited loop! [junit] 2009-05-21 19:19:13,105 - INFO [main-SendThread:clientcnxn$sendthr...@821] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-05-21 19:19:13,106 - INFO [main-SendThread:clientcnxn$sendthr...@737] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:60908 remote=/127.0.0.1:33221] [junit] 2009-05-21 19:19:13,106 - INFO [main-SendThread:clientcnxn$sendthr...@889] - Server connection successful [junit] 2009-05-21 19:19:13,106 - INFO [NIOServerCxn.Factory:33221:nioserverc...@532] - Connected to /127.0.0.1:60908 lastZxid 3 [junit] 2009-05-21 19:19:13,107 - INFO [NIOServerCxn.Factory:33221:nioserverc...@906] - Finished init of 0x121649cdfee0000 valid:true [junit] 2009-05-21 19:19:13,107 - INFO [NIOServerCxn.Factory:33221:nioserverc...@560] - Renewing session 0x121649cdfee0000 [junit] 2009-05-21 19:19:47,184 - INFO [main:clientb...@323] - STOPPING server [junit] 2009-05-21 19:19:47,184 - INFO [main:nioserverc...@777] - closing session:0x121649cdfee0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60908] [junit] 2009-05-21 19:19:47,185 - WARN [main-SendThread:clientcnxn$sendthr...@919] - Exception closing session 0x121649cdfee0000 to sun.nio.ch.selectionkeyi...@18b1f8f [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:653) [junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:897) [junit] 2009-05-21 19:19:47,185 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@190] - NIOServerCnxn factory exited run method [junit] 2009-05-21 19:19:47,186 - INFO [ProcessThread:-1:preprequestproces...@109] - PrepRequestProcessor exited loop! [junit] 2009-05-21 19:19:47,186 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-05-21 19:19:47,186 - INFO [SyncThread:0:syncrequestproces...@118] - SyncRequestProcessor exited! [junit] ensureOnly:[] [junit] 2009-05-21 19:19:47,285 - INFO [main:clientb...@316] - STARTING server [junit] 2009-05-21 19:19:47,285 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-05-21 19:19:47,287 - INFO [main:files...@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8897024993216438962.junit.dir/version-2/snapshot.3 [junit] 2009-05-21 19:19:47,288 - INFO [main:filetxnsnap...@198] - Snapshotting: 5 [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port] [junit] 2009-05-21 19:19:47,290 - INFO [NIOServerCxn.Factory:33221:nioserverc...@646] - Processing stat command from /127.0.0.1:60911 [junit] 2009-05-21 19:19:47,291 - WARN [NIOServerCxn.Factory:33221:nioserverc...@444] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-05-21 19:19:47,291 - INFO [NIOServerCxn.Factory:33221:nioserverc...@777] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60911] [junit] expect:InMemoryDataTree [junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree [junit] expect:StandaloneServer_port [junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1 [junit] 2009-05-21 19:19:48,000 - INFO [SessionTracker:sessiontrackeri...@141] - SessionTrackerImpl exited loop! [junit] 2009-05-21 19:19:49,222 - INFO [main-SendThread:clientcnxn$sendthr...@821] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-05-21 19:19:49,222 - INFO [main-SendThread:clientcnxn$sendthr...@737] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:60912 remote=/127.0.0.1:33221] [junit] 2009-05-21 19:19:49,222 - INFO [main-SendThread:clientcnxn$sendthr...@889] - Server connection successful [junit] 2009-05-21 19:19:49,223 - INFO [NIOServerCxn.Factory:33221:nioserverc...@532] - Connected to /127.0.0.1:60912 lastZxid 5 [junit] 2009-05-21 19:19:49,223 - INFO [NIOServerCxn.Factory:33221:nioserverc...@906] - Finished init of 0x121649cdfee0000 valid:true [junit] 2009-05-21 19:19:49,223 - INFO [NIOServerCxn.Factory:33221:nioserverc...@560] - Renewing session 0x121649cdfee0000 [junit] 2009-05-21 19:19:49,270 - INFO [main:clientb...@323] - STOPPING server [junit] 2009-05-21 19:19:49,271 - INFO [main:nioserverc...@777] - closing session:0x121649cdfee0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60912] [junit] 2009-05-21 19:19:49,271 - WARN [main-SendThread:clientcnxn$sendthr...@919] - Exception closing session 0x121649cdfee0000 to sun.nio.ch.selectionkeyi...@5ff916 [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:653) [junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:897) [junit] 2009-05-21 19:19:49,273 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@190] - NIOServerCnxn factory exited run method [junit] 2009-05-21 19:19:49,273 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-05-21 19:19:49,273 - INFO [SyncThread:0:syncrequestproces...@118] - SyncRequestProcessor exited! [junit] ensureOnly:[] [junit] 2009-05-21 19:19:49,273 - INFO [ProcessThread:-1:preprequestproces...@109] - PrepRequestProcessor exited loop! [junit] 2009-05-21 19:19:49,372 - INFO [main:clientb...@316] - STARTING server [junit] 2009-05-21 19:19:49,372 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-05-21 19:19:49,373 - INFO [main:files...@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8897024993216438962.junit.dir/version-2/snapshot.5 [junit] 2009-05-21 19:19:49,375 - INFO [main:filetxnsnap...@198] - Snapshotting: 6 [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port] [junit] 2009-05-21 19:19:49,377 - INFO [NIOServerCxn.Factory:33221:nioserverc...@646] - Processing stat command from /127.0.0.1:60914 [junit] 2009-05-21 19:19:49,377 - WARN [NIOServerCxn.Factory:33221:nioserverc...@444] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-05-21 19:19:49,377 - INFO [NIOServerCxn.Factory:33221:nioserverc...@777] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60914] [junit] expect:InMemoryDataTree [junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree [junit] expect:StandaloneServer_port [junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1 [junit] 2009-05-21 19:19:50,784 - INFO [main-SendThread:clientcnxn$sendthr...@821] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-05-21 19:19:50,784 - INFO [main-SendThread:clientcnxn$sendthr...@737] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:60915 remote=/127.0.0.1:33221] [junit] 2009-05-21 19:19:50,784 - INFO [main-SendThread:clientcnxn$sendthr...@889] - Server connection successful [junit] 2009-05-21 19:19:50,784 - INFO [NIOServerCxn.Factory:33221:nioserverc...@532] - Connected to /127.0.0.1:60915 lastZxid 6 [junit] 2009-05-21 19:19:50,785 - INFO [NIOServerCxn.Factory:33221:nioserverc...@906] - Finished init of 0x121649cdfee0000 valid:true [junit] 2009-05-21 19:19:50,785 - INFO [NIOServerCxn.Factory:33221:nioserverc...@560] - Renewing session 0x121649cdfee0000 [junit] 2009-05-21 19:19:51,000 - INFO [SessionTracker:sessiontrackeri...@141] - SessionTrackerImpl exited loop! [junit] 2009-05-21 19:20:01,871 - INFO [main:zookee...@437] - Closing session: 0x121649cdfee0000 [junit] 2009-05-21 19:20:01,871 - INFO [main:clientc...@1020] - Closing ClientCnxn for session: 0x121649cdfee0000 [junit] 2009-05-21 19:20:01,872 - INFO [ProcessThread:-1:preprequestproces...@363] - Processed session termination request for id: 0x121649cdfee0000 [junit] 2009-05-21 19:20:01,881 - INFO [SyncThread:0:nioserverc...@777] - closing session:0x121649cdfee0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60915] [junit] 2009-05-21 19:20:01,882 - INFO [main-SendThread:clientcnxn$sendthr...@913] - Exception while closing send thread for session 0x121649cdfee0000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] [junit] 2009-05-21 19:20:01,982 - INFO [main:clientc...@1006] - Disconnecting ClientCnxn for session: 0x121649cdfee0000 [junit] 2009-05-21 19:20:01,982 - INFO [main:zookee...@445] - Session: 0x121649cdfee0000 closed [junit] 2009-05-21 19:20:01,982 - INFO [main-EventThread:clientcnxn$eventthr...@473] - EventThread shut down [junit] 2009-05-21 19:20:01,982 - INFO [main:clientb...@332] - tearDown starting [junit] 2009-05-21 19:20:01,983 - INFO [main:clientb...@323] - STOPPING server [junit] 2009-05-21 19:20:01,983 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@190] - NIOServerCnxn factory exited run method [junit] 2009-05-21 19:20:01,984 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-05-21 19:20:01,984 - INFO [ProcessThread:-1:preprequestproces...@109] - PrepRequestProcessor exited loop! [junit] 2009-05-21 19:20:01,984 - INFO [SyncThread:0:syncrequestproces...@118] - SyncRequestProcessor exited! [junit] ensureOnly:[] [junit] 2009-05-21 19:20:01,987 - INFO [main:clientb...@344] - FINISHED testWatcherAutoResetDisabledWithLocal [junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 127.33 sec [junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest [junit] 2009-05-21 19:20:02,642 - INFO [main:clientb...@302] - STARTING testQuota [junit] 2009-05-21 19:20:02,783 - INFO [main:clientb...@316] - STARTING server [junit] 2009-05-21 19:20:02,788 - INFO [main:environm...@97] - Server environment:zookeeper.version=3.2.0-777217, built on 05/21/2009 19:06 GMT [junit] 2009-05-21 19:20:02,789 - INFO [main:environm...@97] - Server environment:host.name=vesta.apache.org [junit] 2009-05-21 19:20:02,790 - INFO [main:environm...@97] - Server environment:java.version=1.6.0_11 [junit] 2009-05-21 19:20:02,790 - INFO [main:environm...@97] - Server environment:java.vendor=Sun Microsystems Inc. [junit] 2009-05-21 19:20:02,792 - INFO [main:environm...@97] - Server environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre [junit] 2009-05-21 19:20:02,793 - INFO [main:environm...@97] - Server environment:java.class.path=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/zookeeper-dev.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/jdiff-1.0.9.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/jline-0.9.94.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/src/java/lib/xerces-1.4.4.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-05-21 19:20:02,796 - 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-05-21 19:20:02,796 - INFO [main:environm...@97] - Server environment:java.io.tmpdir=/tmp [junit] 2009-05-21 19:20:02,796 - INFO [main:environm...@97] - Server environment:java.compiler=<NA> [junit] 2009-05-21 19:20:02,802 - INFO [main:environm...@97] - Server environment:os.name=Linux [junit] 2009-05-21 19:20:02,803 - INFO [main:environm...@97] - Server environment:os.arch=i386 [junit] 2009-05-21 19:20:02,803 - INFO [main:environm...@97] - Server environment:os.version=2.6.27-7-server [junit] 2009-05-21 19:20:02,803 - INFO [main:environm...@97] - Server environment:user.name=hudson [junit] 2009-05-21 19:20:02,804 - INFO [main:environm...@97] - Server environment:user.home=/home/hudson [junit] 2009-05-21 19:20:02,804 - INFO [main:environm...@97] - Server environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk [junit] 2009-05-21 19:20:02,808 - INFO [main:zookeeperser...@160] - Created server [junit] 2009-05-21 19:20:02,822 - INFO [main:filetxnsnap...@198] - Snapshotting: 0 [junit] 2009-05-21 19:20:02,840 - INFO [NIOServerCxn.Factory:33221:nioserverc...@646] - Processing stat command from /127.0.0.1:60919 [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port] [junit] 2009-05-21 19:20:02,841 - WARN [NIOServerCxn.Factory:33221:nioserverc...@444] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe [junit] 2009-05-21 19:20:02,842 - INFO [NIOServerCxn.Factory:33221:nioserverc...@777] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60919] [junit] expect:InMemoryDataTree [junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree [junit] expect:StandaloneServer_port [junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1 [junit] 2009-05-21 19:20:02,877 - INFO [main:clientb...@312] - Client test setup finished [junit] 2009-05-21 19:20:02,880 - INFO [main:environm...@97] - Client environment:zookeeper.version=3.2.0-777217, built on 05/21/2009 19:06 GMT [junit] 2009-05-21 19:20:02,880 - INFO [main:environm...@97] - Client environment:host.name=vesta.apache.org [junit] 2009-05-21 19:20:02,881 - INFO [main:environm...@97] - Client environment:java.version=1.6.0_11 [junit] 2009-05-21 19:20:02,899 - INFO [main:environm...@97] - Client environment:java.vendor=Sun Microsystems Inc. [junit] 2009-05-21 19:20:02,899 - INFO [main:environm...@97] - Client environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre [junit] 2009-05-21 19:20:02,899 - INFO [main:environm...@97] - Client environment:java.class.path=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/zookeeper-dev.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/jdiff-1.0.9.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/jline-0.9.94.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/src/java/lib/xerces-1.4.4.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-05-21 19:20:02,913 - 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-05-21 19:20:02,913 - INFO [main:environm...@97] - Client environment:java.io.tmpdir=/tmp [junit] 2009-05-21 19:20:02,913 - INFO [main:environm...@97] - Client environment:java.compiler=<NA> [junit] 2009-05-21 19:20:02,914 - INFO [main:environm...@97] - Client environment:os.name=Linux [junit] 2009-05-21 19:20:02,914 - INFO [main:environm...@97] - Client environment:os.arch=i386 [junit] 2009-05-21 19:20:02,915 - INFO [main:environm...@97] - Client environment:os.version=2.6.27-7-server [junit] 2009-05-21 19:20:02,915 - INFO [main:environm...@97] - Client environment:user.name=hudson [junit] 2009-05-21 19:20:02,915 - INFO [main:environm...@97] - Client environment:user.home=/home/hudson [junit] 2009-05-21 19:20:02,916 - INFO [main:environm...@97] - Client environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk [junit] 2009-05-21 19:20:02,917 - INFO [main:zookee...@342] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=30000 watcher=org.apache.zookeeper.test.clientbase$countdownwatc...@76e8a7 [junit] 2009-05-21 19:20:02,918 - INFO [main:clientc...@91] - zookeeper.disableAutoWatchReset is false [junit] 2009-05-21 19:20:02,923 - INFO [main-SendThread:clientcnxn$sendthr...@821] - Attempting connection to server /127.0.0.1:33221 [junit] 2009-05-21 19:20:02,924 - INFO [main-SendThread:clientcnxn$sendthr...@737] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:60920 remote=/127.0.0.1:33221] [junit] 2009-05-21 19:20:02,927 - INFO [main-SendThread:clientcnxn$sendthr...@889] - Server connection successful [junit] 2009-05-21 19:20:02,929 - INFO [NIOServerCxn.Factory:33221:nioserverc...@532] - Connected to /127.0.0.1:60920 lastZxid 0 [junit] 2009-05-21 19:20:02,930 - INFO [NIOServerCxn.Factory:33221:nioserverc...@563] - Creating new session 0x121649daa090000 [junit] 2009-05-21 19:20:03,011 - INFO [SyncThread:0:nioserverc...@906] - Finished init of 0x121649daa090000 valid:true [junit] expect:0x121649daa090000 [junit] found:0x121649daa090000 org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x121649daa090000 [junit] 2009-05-21 19:20:03,105 - INFO [main:clientb...@332] - tearDown starting [junit] 2009-05-21 19:20:03,106 - INFO [main:clientb...@323] - STOPPING server [junit] 2009-05-21 19:20:03,107 - INFO [main:nioserverc...@777] - closing session:0x121649daa090000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60920] [junit] 2009-05-21 19:20:03,108 - WARN [main-SendThread:clientcnxn$sendthr...@919] - Exception closing session 0x121649daa090000 to sun.nio.ch.selectionkeyi...@983d95 [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:653) [junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:897) [junit] 2009-05-21 19:20:03,108 - INFO [NIOServerCxn.Factory:33221:nioservercnxn$fact...@190] - NIOServerCnxn factory exited run method [junit] 2009-05-21 19:20:03,109 - INFO [main:finalrequestproces...@268] - shutdown of request processor complete [junit] 2009-05-21 19:20:03,109 - INFO [SyncThread:0:syncrequestproces...@118] - SyncRequestProcessor exited! [junit] 2009-05-21 19:20:03,109 - INFO [ProcessThread:-1:preprequestproces...@109] - PrepRequestProcessor exited loop! [junit] ensureOnly:[] [junit] 2009-05-21 19:20:03,112 - INFO [main:clientb...@344] - FINISHED testQuota [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.557 sec BUILD FAILED http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :732: The following error occurred while executing this line: http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :644: Tests failed! Total time: 12 minutes 5 seconds Publishing Javadoc Recording test results Recording fingerprints