Yes, we have a JIRA on this particular issue (closed now), it crops up every so often. Sun seems to be fixing it in java 7 (not sure why they are waiting).

Patrick

Henry Robinson wrote:
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 <
hud...@hudson.zones.apache.org> 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



Reply via email to