This seems unrelated to the patch - a failure in testCnxManager ( http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/492/testReport/org.apache.zookeeper.test/CnxManagerTest/testCnxManager/) where Selector.open() threw an IO exception.
Looks like it could be related to this: http://bugs.sun.com/view_bug.do?bug_id=6427854 ? On Fri, Oct 9, 2009 at 3:51 AM, Apache Hudson Server < [email protected]> wrote: > See <http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/492/changes > > > > Changes: > > [mahadev] ZOOKEEPER-510. zkpython lumps all exceptions as IOError, needs > specialized exceptions for KeeperException types (henry & pat via mahadev) > > ------------------------------------------ > [...truncated 177143 lines...] > [junit] 2009-10-09 10:51:12,142 - INFO > [NIOServerCxn.Factory:11225:nioserverc...@613] - Renewing session > 0x12438ec66900000 > [junit] 2009-10-09 10:51:13,149 - INFO [main:zookee...@502] - Closing > session: 0x12438ec66900000 > [junit] 2009-10-09 10:51:13,149 - INFO [main:clientc...@1070] - > Closing ClientCnxn for session: 0x12438ec66900000 > [junit] 2009-10-09 10:51:13,150 - INFO > [ProcessThread:-1:preprequestproces...@384] - Processed session > termination request for id: 0x12438ec66900000 > [junit] 2009-10-09 10:51:13,151 - INFO [SyncThread:0:nioserverc...@834] > - closing session:0x12438ec66900000 NIOServerCnxn: > java.nio.channels.SocketChannel[connected local=/127.0.0.1:11225 remote=/ > 127.0.0.1:47155] > [junit] 2009-10-09 10:51:13,152 - INFO > [main-SendThread(localhost:11225):clientcnxn$sendthr...@963] - Exception > while closing send thread for session 0x12438ec66900000 : Read error rc = -1 > java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] > [junit] 2009-10-09 10:51:13,252 - INFO [main:clientc...@1056] - > Disconnecting ClientCnxn for session: 0x12438ec66900000 > [junit] 2009-10-09 10:51:13,252 - INFO [main:zookee...@510] - Session: > 0x12438ec66900000 closed > [junit] 2009-10-09 10:51:13,252 - INFO > [main-EventThread:clientcnxn$eventthr...@514] - EventThread shut down > [junit] 2009-10-09 10:51:13,253 - INFO [main:clientb...@397] - > tearDown starting > [junit] 2009-10-09 10:51:13,253 - INFO [main:clientb...@409] - fdcount > after test is: 42 > [junit] 2009-10-09 10:51:13,253 - INFO [main:zookee...@502] - Closing > session: 0x12438ec66900000 > [junit] 2009-10-09 10:51:13,253 - INFO [main:clientc...@1070] - > Closing ClientCnxn for session: 0x12438ec66900000 > [junit] 2009-10-09 10:51:13,254 - INFO [main:clientc...@1056] - > Disconnecting ClientCnxn for session: 0x12438ec66900000 > [junit] 2009-10-09 10:51:13,254 - INFO [main:zookee...@510] - Session: > 0x12438ec66900000 closed > [junit] 2009-10-09 10:51:13,254 - INFO [main:clientb...@374] - > STOPPING server > [junit] 2009-10-09 10:51:13,254 - INFO > [NIOServerCxn.Factory:11225:nioservercnxn$fact...@236] - NIOServerCnxn > factory exited run method > [junit] 2009-10-09 10:51:13,255 - INFO [main:finalrequestproces...@283] > - shutdown of request processor complete > [junit] 2009-10-09 10:51:13,255 - INFO > [ProcessThread:-1:preprequestproces...@119] - PrepRequestProcessor exited > loop! > [junit] 2009-10-09 10:51:13,256 - INFO > [SyncThread:0:syncrequestproces...@134] - SyncRequestProcessor exited! > [junit] ensureOnly:[] > [junit] 2009-10-09 10:51:13,258 - INFO [main:clientb...@428] - > FINISHED testWatcherAutoResetDisabledWithGlobal > [junit] 2009-10-09 10:51:13,259 - INFO [main:clientb...@338] - > STARTING testWatcherAutoResetDisabledWithLocal > [junit] 2009-10-09 10:51:13,264 - INFO [main:clientb...@367] - > STARTING server > [junit] 2009-10-09 10:51:13,265 - INFO [main:zookeeperser...@160] - > Created server > [junit] 2009-10-09 10:51:13,265 - INFO [main:nioservercnxn$fact...@122] > - binding to port 11226 > [junit] 2009-10-09 10:51:13,266 - INFO [main:filetxnsnap...@208] - > Snapshotting: 0 > [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port] > [junit] 2009-10-09 10:51:13,268 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@699] - Processing stat command > from /127.0.0.1:42009 > [junit] 2009-10-09 10:51:13,268 - WARN > [NIOServerCxn.Factory:11226:nioserverc...@495] - Exception causing close > of session 0x0 due to java.io.IOException: Responded to info probe > [junit] 2009-10-09 10:51:13,268 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@834] - closing session:0x0 > NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/ > 127.0.0.1:11226 remote=/127.0.0.1:42009] > [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-10-09 10:51:13,269 - INFO [main:clientb...@359] - Initial > fdcount is: 42 > [junit] 2009-10-09 10:51:13,270 - INFO [main:clientb...@363] - Client > test setup finished > [junit] 2009-10-09 10:51:13,270 - INFO [main:zookee...@369] - > Initiating client connection, connectString=127.0.0.1:11226sessionTimeout=5000 > watcher=org.apache.zookeeper.test.watchertest$mywatc...@1784427 > [junit] 2009-10-09 10:51:13,270 - INFO > [main-SendThread():clientcnxn$sendthr...@869] - Attempting connection to > server /127.0.0.1:11226 > [junit] 2009-10-09 10:51:13,271 - INFO > [main-SendThread(localhost:11226):clientcnxn$sendthr...@785] - Priming > connection to java.nio.channels.SocketChannel[connected local=/ > 127.0.0.1:42010 remote=localhost/127.0.0.1:11226] > [junit] 2009-10-09 10:51:13,271 - INFO > [main-SendThread(localhost:11226):clientcnxn$sendthr...@939] - Server > connection successful > [junit] 2009-10-09 10:51:13,271 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@584] - Connected to / > 127.0.0.1:42010 lastZxid 0 > [junit] 2009-10-09 10:51:13,272 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@616] - Creating new session > 0x12438ec7df20000 > [junit] 2009-10-09 10:51:13,281 - INFO [SyncThread:0:nioserverc...@965] > - Finished init of 0x12438ec7df20000 valid:true > [junit] expect:0x12438ec7df20000 > [junit] found:0x12438ec7df20000 > org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x12438ec7df20000 > [junit] 2009-10-09 10:51:13,288 - INFO [main:clientb...@374] - > STOPPING server > [junit] 2009-10-09 10:51:13,289 - INFO [main:nioserverc...@834] - > closing session:0x12438ec7df20000 NIOServerCnxn: > java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/ > 127.0.0.1:42010] > [junit] 2009-10-09 10:51:13,289 - WARN > [main-SendThread(localhost:11226):clientcnxn$sendthr...@969] - Exception > closing session 0x12438ec7df20000 to sun.nio.ch.selectionkeyi...@1758cd1 > [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:701) > [junit] at > org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:947) > [junit] 2009-10-09 10:51:13,290 - INFO > [NIOServerCxn.Factory:11226:nioservercnxn$fact...@236] - NIOServerCnxn > factory exited run method > [junit] 2009-10-09 10:51:13,290 - INFO [main:finalrequestproces...@283] > - shutdown of request processor complete > [junit] 2009-10-09 10:51:13,290 - INFO > [SyncThread:0:syncrequestproces...@134] - SyncRequestProcessor exited! > [junit] 2009-10-09 10:51:13,290 - INFO > [ProcessThread:-1:preprequestproces...@119] - PrepRequestProcessor exited > loop! > [junit] ensureOnly:[] > [junit] 2009-10-09 10:51:13,390 - INFO [main:clientb...@367] - > STARTING server > [junit] 2009-10-09 10:51:13,390 - INFO [main:zookeeperser...@160] - > Created server > [junit] 2009-10-09 10:51:13,391 - INFO [main:nioservercnxn$fact...@122] > - binding to port 11226 > [junit] 2009-10-09 10:51:13,391 - INFO [main:files...@81] - Reading > snapshot < > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test2173434690947717231.junit.dir/version-2/snapshot.0 > > > [junit] 2009-10-09 10:51:13,393 - INFO [main:filetxnsnap...@208] - > Snapshotting: 3 > [junit] 2009-10-09 10:51:13,395 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@699] - Processing stat command > from /127.0.0.1:42012 > [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port] > [junit] 2009-10-09 10:51:13,396 - WARN > [NIOServerCxn.Factory:11226:nioserverc...@495] - Exception causing close > of session 0x0 due to java.io.IOException: Responded to info probe > [junit] 2009-10-09 10:51:13,396 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@834] - closing session:0x0 > NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/ > 127.0.0.1:11226 remote=/127.0.0.1:42012] > [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-10-09 10:51:14,846 - INFO > [main-SendThread(localhost:11226):clientcnxn$sendthr...@869] - Attempting > connection to server localhost/127.0.0.1:11226 > [junit] 2009-10-09 10:51:14,846 - INFO > [main-SendThread(localhost:11226):clientcnxn$sendthr...@785] - Priming > connection to java.nio.channels.SocketChannel[connected local=/ > 127.0.0.1:42014 remote=localhost/127.0.0.1:11226] > [junit] 2009-10-09 10:51:14,847 - INFO > [main-SendThread(localhost:11226):clientcnxn$sendthr...@939] - Server > connection successful > [junit] 2009-10-09 10:51:14,847 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@584] - Connected to / > 127.0.0.1:42014 lastZxid 3 > [junit] 2009-10-09 10:51:14,848 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@965] - Finished init of > 0x12438ec7df20000 valid:true > [junit] 2009-10-09 10:51:14,848 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@613] - Renewing session > 0x12438ec7df20000 > [junit] 2009-10-09 10:51:14,857 - INFO [main:clientb...@374] - > STOPPING server > [junit] 2009-10-09 10:51:14,858 - INFO [main:nioserverc...@834] - > closing session:0x12438ec7df20000 NIOServerCnxn: > java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/ > 127.0.0.1:42014] > [junit] 2009-10-09 10:51:14,858 - WARN > [main-SendThread(localhost:11226):clientcnxn$sendthr...@969] - Exception > closing session 0x12438ec7df20000 to sun.nio.ch.selectionkeyi...@f268de > [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:701) > [junit] at > org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:947) > [junit] 2009-10-09 10:51:14,859 - INFO > [NIOServerCxn.Factory:11226:nioservercnxn$fact...@236] - NIOServerCnxn > factory exited run method > [junit] 2009-10-09 10:51:14,859 - INFO [main:finalrequestproces...@283] > - shutdown of request processor complete > [junit] 2009-10-09 10:51:14,859 - INFO > [ProcessThread:-1:preprequestproces...@119] - PrepRequestProcessor exited > loop! > [junit] 2009-10-09 10:51:14,859 - INFO > [SyncThread:0:syncrequestproces...@134] - SyncRequestProcessor exited! > [junit] ensureOnly:[] > [junit] 2009-10-09 10:51:14,959 - INFO [main:clientb...@367] - > STARTING server > [junit] 2009-10-09 10:51:14,959 - INFO [main:zookeeperser...@160] - > Created server > [junit] 2009-10-09 10:51:14,959 - INFO [main:nioservercnxn$fact...@122] > - binding to port 11226 > [junit] 2009-10-09 10:51:14,960 - INFO [main:files...@81] - Reading > snapshot < > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test2173434690947717231.junit.dir/version-2/snapshot.3 > > > [junit] 2009-10-09 10:51:14,962 - INFO [main:filetxnsnap...@208] - > Snapshotting: 5 > [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port] > [junit] 2009-10-09 10:51:14,964 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@699] - Processing stat command > from /127.0.0.1:42016 > [junit] 2009-10-09 10:51:14,965 - WARN > [NIOServerCxn.Factory:11226:nioserverc...@495] - Exception causing close > of session 0x0 due to java.io.IOException: Responded to info probe > [junit] 2009-10-09 10:51:14,965 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@834] - closing session:0x0 > NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/ > 127.0.0.1:11226 remote=/127.0.0.1:42016] > [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-10-09 10:51:15,000 - INFO > [SessionTracker:sessiontrackeri...@143] - SessionTrackerImpl exited loop! > [junit] 2009-10-09 10:51:15,000 - INFO > [SessionTracker:sessiontrackeri...@143] - SessionTrackerImpl exited loop! > [junit] 2009-10-09 10:51:15,001 - INFO > [SessionTracker:sessiontrackeri...@143] - SessionTrackerImpl exited loop! > [junit] 2009-10-09 10:51:16,089 - INFO > [main-SendThread(localhost:11226):clientcnxn$sendthr...@869] - Attempting > connection to server localhost/127.0.0.1:11226 > [junit] 2009-10-09 10:51:16,089 - INFO > [main-SendThread(localhost:11226):clientcnxn$sendthr...@785] - Priming > connection to java.nio.channels.SocketChannel[connected local=/ > 127.0.0.1:42017 remote=localhost/127.0.0.1:11226] > [junit] 2009-10-09 10:51:16,089 - INFO > [main-SendThread(localhost:11226):clientcnxn$sendthr...@939] - Server > connection successful > [junit] 2009-10-09 10:51:16,090 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@584] - Connected to / > 127.0.0.1:42017 lastZxid 5 > [junit] 2009-10-09 10:51:16,090 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@965] - Finished init of > 0x12438ec7df20000 valid:true > [junit] 2009-10-09 10:51:16,090 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@613] - Renewing session > 0x12438ec7df20000 > [junit] 2009-10-09 10:51:16,100 - INFO [main:clientb...@374] - > STOPPING server > [junit] 2009-10-09 10:51:16,101 - INFO [main:nioserverc...@834] - > closing session:0x12438ec7df20000 NIOServerCnxn: > java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/ > 127.0.0.1:42017] > [junit] 2009-10-09 10:51:16,101 - WARN > [main-SendThread(localhost:11226):clientcnxn$sendthr...@969] - Exception > closing session 0x12438ec7df20000 to sun.nio.ch.selectionkeyi...@1ac1e22 > [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:701) > [junit] at > org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:947) > [junit] 2009-10-09 10:51:16,102 - INFO > [NIOServerCxn.Factory:11226:nioservercnxn$fact...@236] - NIOServerCnxn > factory exited run method > [junit] 2009-10-09 10:51:16,102 - INFO [main:finalrequestproces...@283] > - shutdown of request processor complete > [junit] 2009-10-09 10:51:16,102 - INFO > [SyncThread:0:syncrequestproces...@134] - SyncRequestProcessor exited! > [junit] 2009-10-09 10:51:16,102 - INFO > [ProcessThread:-1:preprequestproces...@119] - PrepRequestProcessor exited > loop! > [junit] ensureOnly:[] > [junit] 2009-10-09 10:51:16,202 - INFO [main:clientb...@367] - > STARTING server > [junit] 2009-10-09 10:51:16,202 - INFO [main:zookeeperser...@160] - > Created server > [junit] 2009-10-09 10:51:16,202 - INFO [main:nioservercnxn$fact...@122] > - binding to port 11226 > [junit] 2009-10-09 10:51:16,204 - INFO [main:files...@81] - Reading > snapshot < > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test2173434690947717231.junit.dir/version-2/snapshot.5 > > > [junit] 2009-10-09 10:51:16,206 - INFO [main:filetxnsnap...@208] - > Snapshotting: 6 > [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port] > [junit] 2009-10-09 10:51:16,208 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@699] - Processing stat command > from /127.0.0.1:42019 > [junit] 2009-10-09 10:51:16,208 - WARN > [NIOServerCxn.Factory:11226:nioserverc...@495] - Exception causing close > of session 0x0 due to java.io.IOException: Responded to info probe > [junit] 2009-10-09 10:51:16,208 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@834] - closing session:0x0 > NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/ > 127.0.0.1:11226 remote=/127.0.0.1:42019] > [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-10-09 10:51:17,230 - INFO > [main-SendThread(localhost:11226):clientcnxn$sendthr...@869] - Attempting > connection to server localhost/127.0.0.1:11226 > [junit] 2009-10-09 10:51:17,230 - INFO > [main-SendThread(localhost:11226):clientcnxn$sendthr...@785] - Priming > connection to java.nio.channels.SocketChannel[connected local=/ > 127.0.0.1:42020 remote=localhost/127.0.0.1:11226] > [junit] 2009-10-09 10:51:17,230 - INFO > [main-SendThread(localhost:11226):clientcnxn$sendthr...@939] - Server > connection successful > [junit] 2009-10-09 10:51:17,231 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@584] - Connected to / > 127.0.0.1:42020 lastZxid 6 > [junit] 2009-10-09 10:51:17,231 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@965] - Finished init of > 0x12438ec7df20000 valid:true > [junit] 2009-10-09 10:51:17,231 - INFO > [NIOServerCxn.Factory:11226:nioserverc...@613] - Renewing session > 0x12438ec7df20000 > [junit] 2009-10-09 10:51:18,000 - INFO > [SessionTracker:sessiontrackeri...@143] - SessionTrackerImpl exited loop! > [junit] 2009-10-09 10:51:18,240 - INFO [main:zookee...@502] - Closing > session: 0x12438ec7df20000 > [junit] 2009-10-09 10:51:18,240 - INFO [main:clientc...@1070] - > Closing ClientCnxn for session: 0x12438ec7df20000 > [junit] 2009-10-09 10:51:18,241 - INFO > [ProcessThread:-1:preprequestproces...@384] - Processed session > termination request for id: 0x12438ec7df20000 > [junit] 2009-10-09 10:51:18,242 - INFO [SyncThread:0:nioserverc...@834] > - closing session:0x12438ec7df20000 NIOServerCnxn: > java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/ > 127.0.0.1:42020] > [junit] 2009-10-09 10:51:18,242 - INFO > [main-SendThread(localhost:11226):clientcnxn$sendthr...@963] - Exception > while closing send thread for session 0x12438ec7df20000 : Read error rc = -1 > java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] > [junit] 2009-10-09 10:51:18,342 - INFO [main:clientc...@1056] - > Disconnecting ClientCnxn for session: 0x12438ec7df20000 > [junit] 2009-10-09 10:51:18,343 - INFO [main:zookee...@510] - Session: > 0x12438ec7df20000 closed > [junit] 2009-10-09 10:51:18,343 - INFO > [main-EventThread:clientcnxn$eventthr...@514] - EventThread shut down > [junit] 2009-10-09 10:51:18,343 - INFO [main:clientb...@397] - > tearDown starting > [junit] 2009-10-09 10:51:18,344 - INFO [main:clientb...@409] - fdcount > after test is: 40 > [junit] 2009-10-09 10:51:18,344 - INFO [main:zookee...@502] - Closing > session: 0x12438ec7df20000 > [junit] 2009-10-09 10:51:18,344 - INFO [main:clientc...@1070] - > Closing ClientCnxn for session: 0x12438ec7df20000 > [junit] 2009-10-09 10:51:18,344 - INFO [main:clientc...@1056] - > Disconnecting ClientCnxn for session: 0x12438ec7df20000 > [junit] 2009-10-09 10:51:18,344 - INFO [main:zookee...@510] - Session: > 0x12438ec7df20000 closed > [junit] 2009-10-09 10:51:18,345 - INFO [main:clientb...@374] - > STOPPING server > [junit] 2009-10-09 10:51:18,345 - INFO > [NIOServerCxn.Factory:11226:nioservercnxn$fact...@236] - NIOServerCnxn > factory exited run method > [junit] 2009-10-09 10:51:18,345 - INFO [main:finalrequestproces...@283] > - shutdown of request processor complete > [junit] 2009-10-09 10:51:18,345 - INFO > [ProcessThread:-1:preprequestproces...@119] - PrepRequestProcessor exited > loop! > [junit] 2009-10-09 10:51:18,345 - INFO > [SyncThread:0:syncrequestproces...@134] - SyncRequestProcessor exited! > [junit] ensureOnly:[] > [junit] 2009-10-09 10:51:18,348 - INFO [main:clientb...@428] - > FINISHED testWatcherAutoResetDisabledWithLocal > [junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 27.22 sec > [junit] 2009-10-09 10:51:19,018 - INFO [main:portassignm...@31] - > assigning port 11221 > [junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest > [junit] 2009-10-09 10:51:19,063 - INFO [main:clientb...@338] - > STARTING testQuota > [junit] 2009-10-09 10:51:19,234 - INFO [main:clientb...@367] - > STARTING server > [junit] 2009-10-09 10:51:19,243 - INFO [main:environm...@97] - Server > environment:zookeeper.version=3.3.0-823506, built on 10/09/2009 10:43 GMT > [junit] 2009-10-09 10:51:19,244 - INFO [main:environm...@97] - Server > environment:host.name=h8.grid.sp2.yahoo.net > [junit] 2009-10-09 10:51:19,245 - INFO [main:environm...@97] - Server > environment:java.version=1.6.0_11 > [junit] 2009-10-09 10:51:19,245 - INFO [main:environm...@97] - Server > environment:java.vendor=Sun Microsystems Inc. > [junit] 2009-10-09 10:51:19,246 - INFO [main:environm...@97] - Server > environment:java.home=/homes/hudson/tools/java/jdk1.6.0_11-32/jre > [junit] 2009-10-09 10:51:19,247 - INFO [main:environm...@97] - Server > environment:java.class.path=< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/classes > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/antlr-2.7.6.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/checkstyle-5.0.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/commons-beanutils-core-1.7.0.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/commons-cli-1.0.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/commons-collections-2.0.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/commons-lang-1.0.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/commons-logging-1.0.3.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/google-collections-0.9.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/junit-4.7.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/classes > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/ivy-2.1.0-rc2.jar > >:/homes/hudson/tools/ant/apache-ant-1.7.0/lib/ant.jar:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/lib/jline-0.9.94.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/lib/log4j-1.2.15.jar > >:/homes/hudson/tools/clover/latest/lib/clover.jar:/homes/hudson/tools/ant/apache-ant-1.7.0/lib/ant-launcher.jar:/homes/hudson/tools/ant/apache-ant-1.7.0/lib/ant-junit.jar > [junit] 2009-10-09 10:51:19,247 - INFO [main:environm...@97] - Server > environment:java.library.path=/homes/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386/server:/homes/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386:/homes/hudson/tools/java/jdk1.6.0_11-32/jre/../lib/i386:/usr/java/packages/lib/i386:/lib:/usr/lib > [junit] 2009-10-09 10:51:19,248 - INFO [main:environm...@97] - Server > environment:java.io.tmpdir=/tmp > [junit] 2009-10-09 10:51:19,249 - INFO [main:environm...@97] - Server > environment:java.compiler=<NA> > [junit] 2009-10-09 10:51:19,249 - INFO [main:environm...@97] - Server > environment:os.name=Linux > [junit] 2009-10-09 10:51:19,250 - INFO [main:environm...@97] - Server > environment:os.arch=i386 > [junit] 2009-10-09 10:51:19,250 - INFO [main:environm...@97] - Server > environment:os.version=2.6.28-15-generic > [junit] 2009-10-09 10:51:19,251 - INFO [main:environm...@97] - Server > environment:user.name=hudson > [junit] 2009-10-09 10:51:19,251 - INFO [main:environm...@97] - Server > environment:user.home=/homes/hudson > [junit] 2009-10-09 10:51:19,252 - INFO [main:environm...@97] - Server > environment:user.dir=< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk> > [junit] 2009-10-09 10:51:19,258 - INFO [main:zookeeperser...@160] - > Created server > [junit] 2009-10-09 10:51:19,272 - INFO [main:nioservercnxn$fact...@122] > - binding to port 11221 > [junit] 2009-10-09 10:51:19,289 - INFO [main:filetxnsnap...@208] - > Snapshotting: 0 > [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port] > [junit] 2009-10-09 10:51:19,320 - INFO > [NIOServerCxn.Factory:11221:nioserverc...@699] - Processing stat command > from /127.0.0.1:35184 > [junit] 2009-10-09 10:51:19,321 - WARN > [NIOServerCxn.Factory:11221:nioserverc...@495] - Exception causing close > of session 0x0 due to java.io.IOException: Responded to info probe > [junit] 2009-10-09 10:51:19,322 - INFO > [NIOServerCxn.Factory:11221:nioserverc...@834] - closing session:0x0 > NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/ > 127.0.0.1:11221 remote=/127.0.0.1:35184] > [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-10-09 10:51:19,338 - INFO [main:clientb...@359] - Initial > fdcount is: 32 > [junit] 2009-10-09 10:51:19,339 - INFO [main:clientb...@363] - Client > test setup finished > [junit] 2009-10-09 10:51:19,344 - INFO [main:environm...@97] - Client > environment:zookeeper.version=3.3.0-823506, built on 10/09/2009 10:43 GMT > [junit] 2009-10-09 10:51:19,344 - INFO [main:environm...@97] - Client > environment:host.name=h8.grid.sp2.yahoo.net > [junit] 2009-10-09 10:51:19,345 - INFO [main:environm...@97] - Client > environment:java.version=1.6.0_11 > [junit] 2009-10-09 10:51:19,345 - INFO [main:environm...@97] - Client > environment:java.vendor=Sun Microsystems Inc. > [junit] 2009-10-09 10:51:19,346 - INFO [main:environm...@97] - Client > environment:java.home=/homes/hudson/tools/java/jdk1.6.0_11-32/jre > [junit] 2009-10-09 10:51:19,346 - INFO [main:environm...@97] - Client > environment:java.class.path=< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/classes > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/antlr-2.7.6.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/checkstyle-5.0.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/commons-beanutils-core-1.7.0.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/commons-cli-1.0.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/commons-collections-2.0.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/commons-lang-1.0.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/commons-logging-1.0.3.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/google-collections-0.9.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/lib/junit-4.7.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/classes > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/ivy-2.1.0-rc2.jar > >:/homes/hudson/tools/ant/apache-ant-1.7.0/lib/ant.jar:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/lib/jline-0.9.94.jar > >:< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/lib/log4j-1.2.15.jar > >:/homes/hudson/tools/clover/latest/lib/clover.jar:/homes/hudson/tools/ant/apache-ant-1.7.0/lib/ant-launcher.jar:/homes/hudson/tools/ant/apache-ant-1.7.0/lib/ant-junit.jar > [junit] 2009-10-09 10:51:19,347 - INFO [main:environm...@97] - Client > environment:java.library.path=/homes/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386/server:/homes/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386:/homes/hudson/tools/java/jdk1.6.0_11-32/jre/../lib/i386:/usr/java/packages/lib/i386:/lib:/usr/lib > [junit] 2009-10-09 10:51:19,347 - INFO [main:environm...@97] - Client > environment:java.io.tmpdir=/tmp > [junit] 2009-10-09 10:51:19,348 - INFO [main:environm...@97] - Client > environment:java.compiler=<NA> > [junit] 2009-10-09 10:51:19,348 - INFO [main:environm...@97] - Client > environment:os.name=Linux > [junit] 2009-10-09 10:51:19,349 - INFO [main:environm...@97] - Client > environment:os.arch=i386 > [junit] 2009-10-09 10:51:19,349 - INFO [main:environm...@97] - Client > environment:os.version=2.6.28-15-generic > [junit] 2009-10-09 10:51:19,350 - INFO [main:environm...@97] - Client > environment:user.name=hudson > [junit] 2009-10-09 10:51:19,350 - INFO [main:environm...@97] - Client > environment:user.home=/homes/hudson > [junit] 2009-10-09 10:51:19,351 - INFO [main:environm...@97] - Client > environment:user.dir=< > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk> > [junit] 2009-10-09 10:51:19,352 - INFO [main:zookee...@369] - > Initiating client connection, > connectString=127.0.0.1:11221sessionTimeout=30000 > watcher=org.apache.zookeeper.test.clientbase$countdownwatc...@a00185 > [junit] 2009-10-09 10:51:19,354 - INFO [main:clientc...@92] - > zookeeper.disableAutoWatchReset is false > [junit] 2009-10-09 10:51:19,362 - INFO > [main-SendThread():clientcnxn$sendthr...@869] - Attempting connection to > server /127.0.0.1:11221 > [junit] 2009-10-09 10:51:19,363 - INFO > [main-SendThread(localhost:11221):clientcnxn$sendthr...@785] - Priming > connection to java.nio.channels.SocketChannel[connected local=/ > 127.0.0.1:35185 remote=localhost/127.0.0.1:11221] > [junit] 2009-10-09 10:51:19,367 - INFO > [main-SendThread(localhost:11221):clientcnxn$sendthr...@939] - Server > connection successful > [junit] 2009-10-09 10:51:19,369 - INFO > [NIOServerCxn.Factory:11221:nioserverc...@584] - Connected to / > 127.0.0.1:35185 lastZxid 0 > [junit] 2009-10-09 10:51:19,371 - INFO > [NIOServerCxn.Factory:11221:nioserverc...@616] - Creating new session > 0x12438ec957f0000 > [junit] 2009-10-09 10:51:19,390 - INFO [SyncThread:0:nioserverc...@965] > - Finished init of 0x12438ec957f0000 valid:true > [junit] expect:0x12438ec957f0000 > [junit] found:0x12438ec957f0000 > org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x12438ec957f0000 > [junit] 2009-10-09 10:51:19,446 - INFO [main:clientb...@397] - > tearDown starting > [junit] 2009-10-09 10:51:19,447 - INFO [main:clientb...@409] - fdcount > after test is: 38 > [junit] 2009-10-09 10:51:19,447 - INFO [main:zookee...@502] - Closing > session: 0x12438ec957f0000 > [junit] 2009-10-09 10:51:19,448 - INFO [main:clientc...@1070] - > Closing ClientCnxn for session: 0x12438ec957f0000 > [junit] 2009-10-09 10:51:19,448 - INFO > [ProcessThread:-1:preprequestproces...@384] - Processed session > termination request for id: 0x12438ec957f0000 > [junit] 2009-10-09 10:51:19,450 - INFO [SyncThread:0:nioserverc...@834] > - closing session:0x12438ec957f0000 NIOServerCnxn: > java.nio.channels.SocketChannel[connected local=/127.0.0.1:11221 remote=/ > 127.0.0.1:35185] > [junit] 2009-10-09 10:51:19,450 - INFO > [main-SendThread(localhost:11221):clientcnxn$sendthr...@963] - Exception > while closing send thread for session 0x12438ec957f0000 : Read error rc = -1 > java.nio.DirectByteBuffer[pos=0 lim=4 cap=4] > [junit] 2009-10-09 10:51:19,551 - INFO [main:clientc...@1056] - > Disconnecting ClientCnxn for session: 0x12438ec957f0000 > [junit] 2009-10-09 10:51:19,551 - INFO [main:zookee...@510] - Session: > 0x12438ec957f0000 closed > [junit] 2009-10-09 10:51:19,551 - INFO > [main-EventThread:clientcnxn$eventthr...@514] - EventThread shut down > [junit] 2009-10-09 10:51:19,552 - INFO [main:clientb...@374] - > STOPPING server > [junit] 2009-10-09 10:51:19,552 - INFO > [NIOServerCxn.Factory:11221:nioservercnxn$fact...@236] - NIOServerCnxn > factory exited run method > [junit] 2009-10-09 10:51:19,553 - INFO [main:finalrequestproces...@283] > - shutdown of request processor complete > [junit] 2009-10-09 10:51:19,553 - INFO > [ProcessThread:-1:preprequestproces...@119] - PrepRequestProcessor exited > loop! > [junit] 2009-10-09 10:51:19,553 - INFO > [SyncThread:0:syncrequestproces...@134] - SyncRequestProcessor exited! > [junit] ensureOnly:[] > [junit] 2009-10-09 10:51:19,556 - INFO [main:clientb...@428] - > FINISHED testQuota > [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.537 sec > > BUILD FAILED > < > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml>:798: > The following error occurred while executing this line: > < > http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml>:709: > Tests failed! > > Total time: 7 minutes 39 seconds > Publishing Javadoc > Archiving artifacts > Recording test results > Recording fingerprints > Publishing Clover coverage report... > No Clover report will be published due to a Build Failure > >
