You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@zookeeper.apache.org by Apache Hudson Server <hu...@hudson.zones.apache.org> on 2009/10/09 12:51:37 UTC
Build failed in Hudson: ZooKeeper-trunk #492
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:NIOServerCnxn@613] - Renewing session 0x12438ec66900000
[junit] 2009-10-09 10:51:13,149 - INFO [main:ZooKeeper@502] - Closing session: 0x12438ec66900000
[junit] 2009-10-09 10:51:13,149 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x12438ec66900000
[junit] 2009-10-09 10:51:13,150 - INFO [ProcessThread:-1:PrepRequestProcessor@384] - Processed session termination request for id: 0x12438ec66900000
[junit] 2009-10-09 10:51:13,151 - INFO [SyncThread:0:NIOServerCnxn@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$SendThread@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:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x12438ec66900000
[junit] 2009-10-09 10:51:13,252 - INFO [main:ZooKeeper@510] - Session: 0x12438ec66900000 closed
[junit] 2009-10-09 10:51:13,252 - INFO [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
[junit] 2009-10-09 10:51:13,253 - INFO [main:ClientBase@397] - tearDown starting
[junit] 2009-10-09 10:51:13,253 - INFO [main:ClientBase@409] - fdcount after test is: 42
[junit] 2009-10-09 10:51:13,253 - INFO [main:ZooKeeper@502] - Closing session: 0x12438ec66900000
[junit] 2009-10-09 10:51:13,253 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x12438ec66900000
[junit] 2009-10-09 10:51:13,254 - INFO [main:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x12438ec66900000
[junit] 2009-10-09 10:51:13,254 - INFO [main:ZooKeeper@510] - Session: 0x12438ec66900000 closed
[junit] 2009-10-09 10:51:13,254 - INFO [main:ClientBase@374] - STOPPING server
[junit] 2009-10-09 10:51:13,254 - INFO [NIOServerCxn.Factory:11225:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-10-09 10:51:13,255 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-10-09 10:51:13,255 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] 2009-10-09 10:51:13,256 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] ensureOnly:[]
[junit] 2009-10-09 10:51:13,258 - INFO [main:ClientBase@428] - FINISHED testWatcherAutoResetDisabledWithGlobal
[junit] 2009-10-09 10:51:13,259 - INFO [main:ClientBase@338] - STARTING testWatcherAutoResetDisabledWithLocal
[junit] 2009-10-09 10:51:13,264 - INFO [main:ClientBase@367] - STARTING server
[junit] 2009-10-09 10:51:13,265 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-10-09 10:51:13,265 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11226
[junit] 2009-10-09 10:51:13,266 - INFO [main:FileTxnSnapLog@208] - Snapshotting: 0
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-10-09 10:51:13,268 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:42009
[junit] 2009-10-09 10:51:13,268 - WARN [NIOServerCxn.Factory:11226:NIOServerCnxn@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:NIOServerCnxn@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:ClientBase@359] - Initial fdcount is: 42
[junit] 2009-10-09 10:51:13,270 - INFO [main:ClientBase@363] - Client test setup finished
[junit] 2009-10-09 10:51:13,270 - INFO [main:ZooKeeper@369] - Initiating client connection, connectString=127.0.0.1:11226 sessionTimeout=5000 watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@1784427
[junit] 2009-10-09 10:51:13,270 - INFO [main-SendThread():ClientCnxn$SendThread@869] - Attempting connection to server /127.0.0.1:11226
[junit] 2009-10-09 10:51:13,271 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@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$SendThread@939] - Server connection successful
[junit] 2009-10-09 10:51:13,271 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /127.0.0.1:42010 lastZxid 0
[junit] 2009-10-09 10:51:13,272 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@616] - Creating new session 0x12438ec7df20000
[junit] 2009-10-09 10:51:13,281 - INFO [SyncThread:0:NIOServerCnxn@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:ClientBase@374] - STOPPING server
[junit] 2009-10-09 10:51:13,289 - INFO [main:NIOServerCnxn@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$SendThread@969] - Exception closing session 0x12438ec7df20000 to sun.nio.ch.SelectionKeyImpl@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$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-10-09 10:51:13,290 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-10-09 10:51:13,290 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] 2009-10-09 10:51:13,290 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] ensureOnly:[]
[junit] 2009-10-09 10:51:13,390 - INFO [main:ClientBase@367] - STARTING server
[junit] 2009-10-09 10:51:13,390 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-10-09 10:51:13,391 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11226
[junit] 2009-10-09 10:51:13,391 - INFO [main:FileSnap@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:FileTxnSnapLog@208] - Snapshotting: 3
[junit] 2009-10-09 10:51:13,395 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@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:NIOServerCnxn@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:NIOServerCnxn@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$SendThread@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$SendThread@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$SendThread@939] - Server connection successful
[junit] 2009-10-09 10:51:14,847 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /127.0.0.1:42014 lastZxid 3
[junit] 2009-10-09 10:51:14,848 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of 0x12438ec7df20000 valid:true
[junit] 2009-10-09 10:51:14,848 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session 0x12438ec7df20000
[junit] 2009-10-09 10:51:14,857 - INFO [main:ClientBase@374] - STOPPING server
[junit] 2009-10-09 10:51:14,858 - INFO [main:NIOServerCnxn@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$SendThread@969] - Exception closing session 0x12438ec7df20000 to sun.nio.ch.SelectionKeyImpl@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$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-10-09 10:51:14,859 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-10-09 10:51:14,859 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] 2009-10-09 10:51:14,859 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] ensureOnly:[]
[junit] 2009-10-09 10:51:14,959 - INFO [main:ClientBase@367] - STARTING server
[junit] 2009-10-09 10:51:14,959 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-10-09 10:51:14,959 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11226
[junit] 2009-10-09 10:51:14,960 - INFO [main:FileSnap@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:FileTxnSnapLog@208] - Snapshotting: 5
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-10-09 10:51:14,964 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:42016
[junit] 2009-10-09 10:51:14,965 - WARN [NIOServerCxn.Factory:11226:NIOServerCnxn@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:NIOServerCnxn@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:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-10-09 10:51:15,000 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-10-09 10:51:15,001 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-10-09 10:51:16,089 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@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$SendThread@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$SendThread@939] - Server connection successful
[junit] 2009-10-09 10:51:16,090 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /127.0.0.1:42017 lastZxid 5
[junit] 2009-10-09 10:51:16,090 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of 0x12438ec7df20000 valid:true
[junit] 2009-10-09 10:51:16,090 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session 0x12438ec7df20000
[junit] 2009-10-09 10:51:16,100 - INFO [main:ClientBase@374] - STOPPING server
[junit] 2009-10-09 10:51:16,101 - INFO [main:NIOServerCnxn@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$SendThread@969] - Exception closing session 0x12438ec7df20000 to sun.nio.ch.SelectionKeyImpl@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$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-10-09 10:51:16,102 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-10-09 10:51:16,102 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] 2009-10-09 10:51:16,102 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] ensureOnly:[]
[junit] 2009-10-09 10:51:16,202 - INFO [main:ClientBase@367] - STARTING server
[junit] 2009-10-09 10:51:16,202 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-10-09 10:51:16,202 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11226
[junit] 2009-10-09 10:51:16,204 - INFO [main:FileSnap@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:FileTxnSnapLog@208] - Snapshotting: 6
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-10-09 10:51:16,208 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:42019
[junit] 2009-10-09 10:51:16,208 - WARN [NIOServerCxn.Factory:11226:NIOServerCnxn@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:NIOServerCnxn@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$SendThread@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$SendThread@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$SendThread@939] - Server connection successful
[junit] 2009-10-09 10:51:17,231 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /127.0.0.1:42020 lastZxid 6
[junit] 2009-10-09 10:51:17,231 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of 0x12438ec7df20000 valid:true
[junit] 2009-10-09 10:51:17,231 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session 0x12438ec7df20000
[junit] 2009-10-09 10:51:18,000 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-10-09 10:51:18,240 - INFO [main:ZooKeeper@502] - Closing session: 0x12438ec7df20000
[junit] 2009-10-09 10:51:18,240 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x12438ec7df20000
[junit] 2009-10-09 10:51:18,241 - INFO [ProcessThread:-1:PrepRequestProcessor@384] - Processed session termination request for id: 0x12438ec7df20000
[junit] 2009-10-09 10:51:18,242 - INFO [SyncThread:0:NIOServerCnxn@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$SendThread@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:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x12438ec7df20000
[junit] 2009-10-09 10:51:18,343 - INFO [main:ZooKeeper@510] - Session: 0x12438ec7df20000 closed
[junit] 2009-10-09 10:51:18,343 - INFO [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
[junit] 2009-10-09 10:51:18,343 - INFO [main:ClientBase@397] - tearDown starting
[junit] 2009-10-09 10:51:18,344 - INFO [main:ClientBase@409] - fdcount after test is: 40
[junit] 2009-10-09 10:51:18,344 - INFO [main:ZooKeeper@502] - Closing session: 0x12438ec7df20000
[junit] 2009-10-09 10:51:18,344 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x12438ec7df20000
[junit] 2009-10-09 10:51:18,344 - INFO [main:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x12438ec7df20000
[junit] 2009-10-09 10:51:18,344 - INFO [main:ZooKeeper@510] - Session: 0x12438ec7df20000 closed
[junit] 2009-10-09 10:51:18,345 - INFO [main:ClientBase@374] - STOPPING server
[junit] 2009-10-09 10:51:18,345 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-10-09 10:51:18,345 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-10-09 10:51:18,345 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] 2009-10-09 10:51:18,345 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] ensureOnly:[]
[junit] 2009-10-09 10:51:18,348 - INFO [main:ClientBase@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:PortAssignment@31] - assigning port 11221
[junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest
[junit] 2009-10-09 10:51:19,063 - INFO [main:ClientBase@338] - STARTING testQuota
[junit] 2009-10-09 10:51:19,234 - INFO [main:ClientBase@367] - STARTING server
[junit] 2009-10-09 10:51:19,243 - INFO [main:Environment@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:Environment@97] - Server environment:host.name=h8.grid.sp2.yahoo.net
[junit] 2009-10-09 10:51:19,245 - INFO [main:Environment@97] - Server environment:java.version=1.6.0_11
[junit] 2009-10-09 10:51:19,245 - INFO [main:Environment@97] - Server environment:java.vendor=Sun Microsystems Inc.
[junit] 2009-10-09 10:51:19,246 - INFO [main:Environment@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:Environment@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:Environment@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:Environment@97] - Server environment:java.io.tmpdir=/tmp
[junit] 2009-10-09 10:51:19,249 - INFO [main:Environment@97] - Server environment:java.compiler=<NA>
[junit] 2009-10-09 10:51:19,249 - INFO [main:Environment@97] - Server environment:os.name=Linux
[junit] 2009-10-09 10:51:19,250 - INFO [main:Environment@97] - Server environment:os.arch=i386
[junit] 2009-10-09 10:51:19,250 - INFO [main:Environment@97] - Server environment:os.version=2.6.28-15-generic
[junit] 2009-10-09 10:51:19,251 - INFO [main:Environment@97] - Server environment:user.name=hudson
[junit] 2009-10-09 10:51:19,251 - INFO [main:Environment@97] - Server environment:user.home=/homes/hudson
[junit] 2009-10-09 10:51:19,252 - INFO [main:Environment@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:ZooKeeperServer@160] - Created server
[junit] 2009-10-09 10:51:19,272 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11221
[junit] 2009-10-09 10:51:19,289 - INFO [main:FileTxnSnapLog@208] - Snapshotting: 0
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-10-09 10:51:19,320 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:35184
[junit] 2009-10-09 10:51:19,321 - WARN [NIOServerCxn.Factory:11221:NIOServerCnxn@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:NIOServerCnxn@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:ClientBase@359] - Initial fdcount is: 32
[junit] 2009-10-09 10:51:19,339 - INFO [main:ClientBase@363] - Client test setup finished
[junit] 2009-10-09 10:51:19,344 - INFO [main:Environment@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:Environment@97] - Client environment:host.name=h8.grid.sp2.yahoo.net
[junit] 2009-10-09 10:51:19,345 - INFO [main:Environment@97] - Client environment:java.version=1.6.0_11
[junit] 2009-10-09 10:51:19,345 - INFO [main:Environment@97] - Client environment:java.vendor=Sun Microsystems Inc.
[junit] 2009-10-09 10:51:19,346 - INFO [main:Environment@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:Environment@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:Environment@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:Environment@97] - Client environment:java.io.tmpdir=/tmp
[junit] 2009-10-09 10:51:19,348 - INFO [main:Environment@97] - Client environment:java.compiler=<NA>
[junit] 2009-10-09 10:51:19,348 - INFO [main:Environment@97] - Client environment:os.name=Linux
[junit] 2009-10-09 10:51:19,349 - INFO [main:Environment@97] - Client environment:os.arch=i386
[junit] 2009-10-09 10:51:19,349 - INFO [main:Environment@97] - Client environment:os.version=2.6.28-15-generic
[junit] 2009-10-09 10:51:19,350 - INFO [main:Environment@97] - Client environment:user.name=hudson
[junit] 2009-10-09 10:51:19,350 - INFO [main:Environment@97] - Client environment:user.home=/homes/hudson
[junit] 2009-10-09 10:51:19,351 - INFO [main:Environment@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:ZooKeeper@369] - Initiating client connection, connectString=127.0.0.1:11221 sessionTimeout=30000 watcher=org.apache.zookeeper.test.ClientBase$CountdownWatcher@a00185
[junit] 2009-10-09 10:51:19,354 - INFO [main:ClientCnxn@92] - zookeeper.disableAutoWatchReset is false
[junit] 2009-10-09 10:51:19,362 - INFO [main-SendThread():ClientCnxn$SendThread@869] - Attempting connection to server /127.0.0.1:11221
[junit] 2009-10-09 10:51:19,363 - INFO [main-SendThread(localhost:11221):ClientCnxn$SendThread@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$SendThread@939] - Server connection successful
[junit] 2009-10-09 10:51:19,369 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn@584] - Connected to /127.0.0.1:35185 lastZxid 0
[junit] 2009-10-09 10:51:19,371 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn@616] - Creating new session 0x12438ec957f0000
[junit] 2009-10-09 10:51:19,390 - INFO [SyncThread:0:NIOServerCnxn@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:ClientBase@397] - tearDown starting
[junit] 2009-10-09 10:51:19,447 - INFO [main:ClientBase@409] - fdcount after test is: 38
[junit] 2009-10-09 10:51:19,447 - INFO [main:ZooKeeper@502] - Closing session: 0x12438ec957f0000
[junit] 2009-10-09 10:51:19,448 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x12438ec957f0000
[junit] 2009-10-09 10:51:19,448 - INFO [ProcessThread:-1:PrepRequestProcessor@384] - Processed session termination request for id: 0x12438ec957f0000
[junit] 2009-10-09 10:51:19,450 - INFO [SyncThread:0:NIOServerCnxn@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$SendThread@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:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x12438ec957f0000
[junit] 2009-10-09 10:51:19,551 - INFO [main:ZooKeeper@510] - Session: 0x12438ec957f0000 closed
[junit] 2009-10-09 10:51:19,551 - INFO [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
[junit] 2009-10-09 10:51:19,552 - INFO [main:ClientBase@374] - STOPPING server
[junit] 2009-10-09 10:51:19,552 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-10-09 10:51:19,553 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-10-09 10:51:19,553 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] 2009-10-09 10:51:19,553 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] ensureOnly:[]
[junit] 2009-10-09 10:51:19,556 - INFO [main:ClientBase@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
Hudson build is back to normal: ZooKeeper-trunk #493
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See <http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/493/>
Re: Build failed in Hudson: ZooKeeper-trunk #492
Posted by Patrick Hunt <ph...@apache.org>.
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 <
> hudson@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:NIOServerCnxn@613] - Renewing session
>> 0x12438ec66900000
>> [junit] 2009-10-09 10:51:13,149 - INFO [main:ZooKeeper@502] - Closing
>> session: 0x12438ec66900000
>> [junit] 2009-10-09 10:51:13,149 - INFO [main:ClientCnxn@1070] -
>> Closing ClientCnxn for session: 0x12438ec66900000
>> [junit] 2009-10-09 10:51:13,150 - INFO
>> [ProcessThread:-1:PrepRequestProcessor@384] - Processed session
>> termination request for id: 0x12438ec66900000
>> [junit] 2009-10-09 10:51:13,151 - INFO [SyncThread:0:NIOServerCnxn@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$SendThread@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:ClientCnxn@1056] -
>> Disconnecting ClientCnxn for session: 0x12438ec66900000
>> [junit] 2009-10-09 10:51:13,252 - INFO [main:ZooKeeper@510] - Session:
>> 0x12438ec66900000 closed
>> [junit] 2009-10-09 10:51:13,252 - INFO
>> [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
>> [junit] 2009-10-09 10:51:13,253 - INFO [main:ClientBase@397] -
>> tearDown starting
>> [junit] 2009-10-09 10:51:13,253 - INFO [main:ClientBase@409] - fdcount
>> after test is: 42
>> [junit] 2009-10-09 10:51:13,253 - INFO [main:ZooKeeper@502] - Closing
>> session: 0x12438ec66900000
>> [junit] 2009-10-09 10:51:13,253 - INFO [main:ClientCnxn@1070] -
>> Closing ClientCnxn for session: 0x12438ec66900000
>> [junit] 2009-10-09 10:51:13,254 - INFO [main:ClientCnxn@1056] -
>> Disconnecting ClientCnxn for session: 0x12438ec66900000
>> [junit] 2009-10-09 10:51:13,254 - INFO [main:ZooKeeper@510] - Session:
>> 0x12438ec66900000 closed
>> [junit] 2009-10-09 10:51:13,254 - INFO [main:ClientBase@374] -
>> STOPPING server
>> [junit] 2009-10-09 10:51:13,254 - INFO
>> [NIOServerCxn.Factory:11225:NIOServerCnxn$Factory@236] - NIOServerCnxn
>> factory exited run method
>> [junit] 2009-10-09 10:51:13,255 - INFO [main:FinalRequestProcessor@283]
>> - shutdown of request processor complete
>> [junit] 2009-10-09 10:51:13,255 - INFO
>> [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited
>> loop!
>> [junit] 2009-10-09 10:51:13,256 - INFO
>> [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
>> [junit] ensureOnly:[]
>> [junit] 2009-10-09 10:51:13,258 - INFO [main:ClientBase@428] -
>> FINISHED testWatcherAutoResetDisabledWithGlobal
>> [junit] 2009-10-09 10:51:13,259 - INFO [main:ClientBase@338] -
>> STARTING testWatcherAutoResetDisabledWithLocal
>> [junit] 2009-10-09 10:51:13,264 - INFO [main:ClientBase@367] -
>> STARTING server
>> [junit] 2009-10-09 10:51:13,265 - INFO [main:ZooKeeperServer@160] -
>> Created server
>> [junit] 2009-10-09 10:51:13,265 - INFO [main:NIOServerCnxn$Factory@122]
>> - binding to port 11226
>> [junit] 2009-10-09 10:51:13,266 - INFO [main:FileTxnSnapLog@208] -
>> Snapshotting: 0
>> [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
>> [junit] 2009-10-09 10:51:13,268 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command
>> from /127.0.0.1:42009
>> [junit] 2009-10-09 10:51:13,268 - WARN
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@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:NIOServerCnxn@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:ClientBase@359] - Initial
>> fdcount is: 42
>> [junit] 2009-10-09 10:51:13,270 - INFO [main:ClientBase@363] - Client
>> test setup finished
>> [junit] 2009-10-09 10:51:13,270 - INFO [main:ZooKeeper@369] -
>> Initiating client connection, connectString=127.0.0.1:11226sessionTimeout=5000
>> watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@1784427
>> [junit] 2009-10-09 10:51:13,270 - INFO
>> [main-SendThread():ClientCnxn$SendThread@869] - Attempting connection to
>> server /127.0.0.1:11226
>> [junit] 2009-10-09 10:51:13,271 - INFO
>> [main-SendThread(localhost:11226):ClientCnxn$SendThread@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$SendThread@939] - Server
>> connection successful
>> [junit] 2009-10-09 10:51:13,271 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /
>> 127.0.0.1:42010 lastZxid 0
>> [junit] 2009-10-09 10:51:13,272 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@616] - Creating new session
>> 0x12438ec7df20000
>> [junit] 2009-10-09 10:51:13,281 - INFO [SyncThread:0:NIOServerCnxn@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:ClientBase@374] -
>> STOPPING server
>> [junit] 2009-10-09 10:51:13,289 - INFO [main:NIOServerCnxn@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$SendThread@969] - Exception
>> closing session 0x12438ec7df20000 to sun.nio.ch.SelectionKeyImpl@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$Factory@236] - NIOServerCnxn
>> factory exited run method
>> [junit] 2009-10-09 10:51:13,290 - INFO [main:FinalRequestProcessor@283]
>> - shutdown of request processor complete
>> [junit] 2009-10-09 10:51:13,290 - INFO
>> [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
>> [junit] 2009-10-09 10:51:13,290 - INFO
>> [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited
>> loop!
>> [junit] ensureOnly:[]
>> [junit] 2009-10-09 10:51:13,390 - INFO [main:ClientBase@367] -
>> STARTING server
>> [junit] 2009-10-09 10:51:13,390 - INFO [main:ZooKeeperServer@160] -
>> Created server
>> [junit] 2009-10-09 10:51:13,391 - INFO [main:NIOServerCnxn$Factory@122]
>> - binding to port 11226
>> [junit] 2009-10-09 10:51:13,391 - INFO [main:FileSnap@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:FileTxnSnapLog@208] -
>> Snapshotting: 3
>> [junit] 2009-10-09 10:51:13,395 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@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:NIOServerCnxn@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:NIOServerCnxn@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$SendThread@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$SendThread@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$SendThread@939] - Server
>> connection successful
>> [junit] 2009-10-09 10:51:14,847 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /
>> 127.0.0.1:42014 lastZxid 3
>> [junit] 2009-10-09 10:51:14,848 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of
>> 0x12438ec7df20000 valid:true
>> [junit] 2009-10-09 10:51:14,848 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session
>> 0x12438ec7df20000
>> [junit] 2009-10-09 10:51:14,857 - INFO [main:ClientBase@374] -
>> STOPPING server
>> [junit] 2009-10-09 10:51:14,858 - INFO [main:NIOServerCnxn@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$SendThread@969] - Exception
>> closing session 0x12438ec7df20000 to sun.nio.ch.SelectionKeyImpl@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$Factory@236] - NIOServerCnxn
>> factory exited run method
>> [junit] 2009-10-09 10:51:14,859 - INFO [main:FinalRequestProcessor@283]
>> - shutdown of request processor complete
>> [junit] 2009-10-09 10:51:14,859 - INFO
>> [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited
>> loop!
>> [junit] 2009-10-09 10:51:14,859 - INFO
>> [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
>> [junit] ensureOnly:[]
>> [junit] 2009-10-09 10:51:14,959 - INFO [main:ClientBase@367] -
>> STARTING server
>> [junit] 2009-10-09 10:51:14,959 - INFO [main:ZooKeeperServer@160] -
>> Created server
>> [junit] 2009-10-09 10:51:14,959 - INFO [main:NIOServerCnxn$Factory@122]
>> - binding to port 11226
>> [junit] 2009-10-09 10:51:14,960 - INFO [main:FileSnap@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:FileTxnSnapLog@208] -
>> Snapshotting: 5
>> [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
>> [junit] 2009-10-09 10:51:14,964 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command
>> from /127.0.0.1:42016
>> [junit] 2009-10-09 10:51:14,965 - WARN
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@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:NIOServerCnxn@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:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
>> [junit] 2009-10-09 10:51:15,000 - INFO
>> [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
>> [junit] 2009-10-09 10:51:15,001 - INFO
>> [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
>> [junit] 2009-10-09 10:51:16,089 - INFO
>> [main-SendThread(localhost:11226):ClientCnxn$SendThread@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$SendThread@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$SendThread@939] - Server
>> connection successful
>> [junit] 2009-10-09 10:51:16,090 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /
>> 127.0.0.1:42017 lastZxid 5
>> [junit] 2009-10-09 10:51:16,090 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of
>> 0x12438ec7df20000 valid:true
>> [junit] 2009-10-09 10:51:16,090 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session
>> 0x12438ec7df20000
>> [junit] 2009-10-09 10:51:16,100 - INFO [main:ClientBase@374] -
>> STOPPING server
>> [junit] 2009-10-09 10:51:16,101 - INFO [main:NIOServerCnxn@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$SendThread@969] - Exception
>> closing session 0x12438ec7df20000 to sun.nio.ch.SelectionKeyImpl@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$Factory@236] - NIOServerCnxn
>> factory exited run method
>> [junit] 2009-10-09 10:51:16,102 - INFO [main:FinalRequestProcessor@283]
>> - shutdown of request processor complete
>> [junit] 2009-10-09 10:51:16,102 - INFO
>> [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
>> [junit] 2009-10-09 10:51:16,102 - INFO
>> [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited
>> loop!
>> [junit] ensureOnly:[]
>> [junit] 2009-10-09 10:51:16,202 - INFO [main:ClientBase@367] -
>> STARTING server
>> [junit] 2009-10-09 10:51:16,202 - INFO [main:ZooKeeperServer@160] -
>> Created server
>> [junit] 2009-10-09 10:51:16,202 - INFO [main:NIOServerCnxn$Factory@122]
>> - binding to port 11226
>> [junit] 2009-10-09 10:51:16,204 - INFO [main:FileSnap@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:FileTxnSnapLog@208] -
>> Snapshotting: 6
>> [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
>> [junit] 2009-10-09 10:51:16,208 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command
>> from /127.0.0.1:42019
>> [junit] 2009-10-09 10:51:16,208 - WARN
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@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:NIOServerCnxn@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$SendThread@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$SendThread@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$SendThread@939] - Server
>> connection successful
>> [junit] 2009-10-09 10:51:17,231 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /
>> 127.0.0.1:42020 lastZxid 6
>> [junit] 2009-10-09 10:51:17,231 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of
>> 0x12438ec7df20000 valid:true
>> [junit] 2009-10-09 10:51:17,231 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session
>> 0x12438ec7df20000
>> [junit] 2009-10-09 10:51:18,000 - INFO
>> [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
>> [junit] 2009-10-09 10:51:18,240 - INFO [main:ZooKeeper@502] - Closing
>> session: 0x12438ec7df20000
>> [junit] 2009-10-09 10:51:18,240 - INFO [main:ClientCnxn@1070] -
>> Closing ClientCnxn for session: 0x12438ec7df20000
>> [junit] 2009-10-09 10:51:18,241 - INFO
>> [ProcessThread:-1:PrepRequestProcessor@384] - Processed session
>> termination request for id: 0x12438ec7df20000
>> [junit] 2009-10-09 10:51:18,242 - INFO [SyncThread:0:NIOServerCnxn@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$SendThread@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:ClientCnxn@1056] -
>> Disconnecting ClientCnxn for session: 0x12438ec7df20000
>> [junit] 2009-10-09 10:51:18,343 - INFO [main:ZooKeeper@510] - Session:
>> 0x12438ec7df20000 closed
>> [junit] 2009-10-09 10:51:18,343 - INFO
>> [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
>> [junit] 2009-10-09 10:51:18,343 - INFO [main:ClientBase@397] -
>> tearDown starting
>> [junit] 2009-10-09 10:51:18,344 - INFO [main:ClientBase@409] - fdcount
>> after test is: 40
>> [junit] 2009-10-09 10:51:18,344 - INFO [main:ZooKeeper@502] - Closing
>> session: 0x12438ec7df20000
>> [junit] 2009-10-09 10:51:18,344 - INFO [main:ClientCnxn@1070] -
>> Closing ClientCnxn for session: 0x12438ec7df20000
>> [junit] 2009-10-09 10:51:18,344 - INFO [main:ClientCnxn@1056] -
>> Disconnecting ClientCnxn for session: 0x12438ec7df20000
>> [junit] 2009-10-09 10:51:18,344 - INFO [main:ZooKeeper@510] - Session:
>> 0x12438ec7df20000 closed
>> [junit] 2009-10-09 10:51:18,345 - INFO [main:ClientBase@374] -
>> STOPPING server
>> [junit] 2009-10-09 10:51:18,345 - INFO
>> [NIOServerCxn.Factory:11226:NIOServerCnxn$Factory@236] - NIOServerCnxn
>> factory exited run method
>> [junit] 2009-10-09 10:51:18,345 - INFO [main:FinalRequestProcessor@283]
>> - shutdown of request processor complete
>> [junit] 2009-10-09 10:51:18,345 - INFO
>> [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited
>> loop!
>> [junit] 2009-10-09 10:51:18,345 - INFO
>> [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
>> [junit] ensureOnly:[]
>> [junit] 2009-10-09 10:51:18,348 - INFO [main:ClientBase@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:PortAssignment@31] -
>> assigning port 11221
>> [junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest
>> [junit] 2009-10-09 10:51:19,063 - INFO [main:ClientBase@338] -
>> STARTING testQuota
>> [junit] 2009-10-09 10:51:19,234 - INFO [main:ClientBase@367] -
>> STARTING server
>> [junit] 2009-10-09 10:51:19,243 - INFO [main:Environment@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:Environment@97] - Server
>> environment:host.name=h8.grid.sp2.yahoo.net
>> [junit] 2009-10-09 10:51:19,245 - INFO [main:Environment@97] - Server
>> environment:java.version=1.6.0_11
>> [junit] 2009-10-09 10:51:19,245 - INFO [main:Environment@97] - Server
>> environment:java.vendor=Sun Microsystems Inc.
>> [junit] 2009-10-09 10:51:19,246 - INFO [main:Environment@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:Environment@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:Environment@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:Environment@97] - Server
>> environment:java.io.tmpdir=/tmp
>> [junit] 2009-10-09 10:51:19,249 - INFO [main:Environment@97] - Server
>> environment:java.compiler=<NA>
>> [junit] 2009-10-09 10:51:19,249 - INFO [main:Environment@97] - Server
>> environment:os.name=Linux
>> [junit] 2009-10-09 10:51:19,250 - INFO [main:Environment@97] - Server
>> environment:os.arch=i386
>> [junit] 2009-10-09 10:51:19,250 - INFO [main:Environment@97] - Server
>> environment:os.version=2.6.28-15-generic
>> [junit] 2009-10-09 10:51:19,251 - INFO [main:Environment@97] - Server
>> environment:user.name=hudson
>> [junit] 2009-10-09 10:51:19,251 - INFO [main:Environment@97] - Server
>> environment:user.home=/homes/hudson
>> [junit] 2009-10-09 10:51:19,252 - INFO [main:Environment@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:ZooKeeperServer@160] -
>> Created server
>> [junit] 2009-10-09 10:51:19,272 - INFO [main:NIOServerCnxn$Factory@122]
>> - binding to port 11221
>> [junit] 2009-10-09 10:51:19,289 - INFO [main:FileTxnSnapLog@208] -
>> Snapshotting: 0
>> [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
>> [junit] 2009-10-09 10:51:19,320 - INFO
>> [NIOServerCxn.Factory:11221:NIOServerCnxn@699] - Processing stat command
>> from /127.0.0.1:35184
>> [junit] 2009-10-09 10:51:19,321 - WARN
>> [NIOServerCxn.Factory:11221:NIOServerCnxn@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:NIOServerCnxn@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:ClientBase@359] - Initial
>> fdcount is: 32
>> [junit] 2009-10-09 10:51:19,339 - INFO [main:ClientBase@363] - Client
>> test setup finished
>> [junit] 2009-10-09 10:51:19,344 - INFO [main:Environment@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:Environment@97] - Client
>> environment:host.name=h8.grid.sp2.yahoo.net
>> [junit] 2009-10-09 10:51:19,345 - INFO [main:Environment@97] - Client
>> environment:java.version=1.6.0_11
>> [junit] 2009-10-09 10:51:19,345 - INFO [main:Environment@97] - Client
>> environment:java.vendor=Sun Microsystems Inc.
>> [junit] 2009-10-09 10:51:19,346 - INFO [main:Environment@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:Environment@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:Environment@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:Environment@97] - Client
>> environment:java.io.tmpdir=/tmp
>> [junit] 2009-10-09 10:51:19,348 - INFO [main:Environment@97] - Client
>> environment:java.compiler=<NA>
>> [junit] 2009-10-09 10:51:19,348 - INFO [main:Environment@97] - Client
>> environment:os.name=Linux
>> [junit] 2009-10-09 10:51:19,349 - INFO [main:Environment@97] - Client
>> environment:os.arch=i386
>> [junit] 2009-10-09 10:51:19,349 - INFO [main:Environment@97] - Client
>> environment:os.version=2.6.28-15-generic
>> [junit] 2009-10-09 10:51:19,350 - INFO [main:Environment@97] - Client
>> environment:user.name=hudson
>> [junit] 2009-10-09 10:51:19,350 - INFO [main:Environment@97] - Client
>> environment:user.home=/homes/hudson
>> [junit] 2009-10-09 10:51:19,351 - INFO [main:Environment@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:ZooKeeper@369] -
>> Initiating client connection, connectString=127.0.0.1:11221sessionTimeout=30000
>> watcher=org.apache.zookeeper.test.ClientBase$CountdownWatcher@a00185
>> [junit] 2009-10-09 10:51:19,354 - INFO [main:ClientCnxn@92] -
>> zookeeper.disableAutoWatchReset is false
>> [junit] 2009-10-09 10:51:19,362 - INFO
>> [main-SendThread():ClientCnxn$SendThread@869] - Attempting connection to
>> server /127.0.0.1:11221
>> [junit] 2009-10-09 10:51:19,363 - INFO
>> [main-SendThread(localhost:11221):ClientCnxn$SendThread@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$SendThread@939] - Server
>> connection successful
>> [junit] 2009-10-09 10:51:19,369 - INFO
>> [NIOServerCxn.Factory:11221:NIOServerCnxn@584] - Connected to /
>> 127.0.0.1:35185 lastZxid 0
>> [junit] 2009-10-09 10:51:19,371 - INFO
>> [NIOServerCxn.Factory:11221:NIOServerCnxn@616] - Creating new session
>> 0x12438ec957f0000
>> [junit] 2009-10-09 10:51:19,390 - INFO [SyncThread:0:NIOServerCnxn@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:ClientBase@397] -
>> tearDown starting
>> [junit] 2009-10-09 10:51:19,447 - INFO [main:ClientBase@409] - fdcount
>> after test is: 38
>> [junit] 2009-10-09 10:51:19,447 - INFO [main:ZooKeeper@502] - Closing
>> session: 0x12438ec957f0000
>> [junit] 2009-10-09 10:51:19,448 - INFO [main:ClientCnxn@1070] -
>> Closing ClientCnxn for session: 0x12438ec957f0000
>> [junit] 2009-10-09 10:51:19,448 - INFO
>> [ProcessThread:-1:PrepRequestProcessor@384] - Processed session
>> termination request for id: 0x12438ec957f0000
>> [junit] 2009-10-09 10:51:19,450 - INFO [SyncThread:0:NIOServerCnxn@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$SendThread@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:ClientCnxn@1056] -
>> Disconnecting ClientCnxn for session: 0x12438ec957f0000
>> [junit] 2009-10-09 10:51:19,551 - INFO [main:ZooKeeper@510] - Session:
>> 0x12438ec957f0000 closed
>> [junit] 2009-10-09 10:51:19,551 - INFO
>> [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
>> [junit] 2009-10-09 10:51:19,552 - INFO [main:ClientBase@374] -
>> STOPPING server
>> [junit] 2009-10-09 10:51:19,552 - INFO
>> [NIOServerCxn.Factory:11221:NIOServerCnxn$Factory@236] - NIOServerCnxn
>> factory exited run method
>> [junit] 2009-10-09 10:51:19,553 - INFO [main:FinalRequestProcessor@283]
>> - shutdown of request processor complete
>> [junit] 2009-10-09 10:51:19,553 - INFO
>> [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited
>> loop!
>> [junit] 2009-10-09 10:51:19,553 - INFO
>> [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
>> [junit] ensureOnly:[]
>> [junit] 2009-10-09 10:51:19,556 - INFO [main:ClientBase@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
>>
>>
>
Re: Build failed in Hudson: ZooKeeper-trunk #492
Posted by Henry Robinson <he...@cloudera.com>.
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 <
hudson@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:NIOServerCnxn@613] - Renewing session
> 0x12438ec66900000
> [junit] 2009-10-09 10:51:13,149 - INFO [main:ZooKeeper@502] - Closing
> session: 0x12438ec66900000
> [junit] 2009-10-09 10:51:13,149 - INFO [main:ClientCnxn@1070] -
> Closing ClientCnxn for session: 0x12438ec66900000
> [junit] 2009-10-09 10:51:13,150 - INFO
> [ProcessThread:-1:PrepRequestProcessor@384] - Processed session
> termination request for id: 0x12438ec66900000
> [junit] 2009-10-09 10:51:13,151 - INFO [SyncThread:0:NIOServerCnxn@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$SendThread@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:ClientCnxn@1056] -
> Disconnecting ClientCnxn for session: 0x12438ec66900000
> [junit] 2009-10-09 10:51:13,252 - INFO [main:ZooKeeper@510] - Session:
> 0x12438ec66900000 closed
> [junit] 2009-10-09 10:51:13,252 - INFO
> [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
> [junit] 2009-10-09 10:51:13,253 - INFO [main:ClientBase@397] -
> tearDown starting
> [junit] 2009-10-09 10:51:13,253 - INFO [main:ClientBase@409] - fdcount
> after test is: 42
> [junit] 2009-10-09 10:51:13,253 - INFO [main:ZooKeeper@502] - Closing
> session: 0x12438ec66900000
> [junit] 2009-10-09 10:51:13,253 - INFO [main:ClientCnxn@1070] -
> Closing ClientCnxn for session: 0x12438ec66900000
> [junit] 2009-10-09 10:51:13,254 - INFO [main:ClientCnxn@1056] -
> Disconnecting ClientCnxn for session: 0x12438ec66900000
> [junit] 2009-10-09 10:51:13,254 - INFO [main:ZooKeeper@510] - Session:
> 0x12438ec66900000 closed
> [junit] 2009-10-09 10:51:13,254 - INFO [main:ClientBase@374] -
> STOPPING server
> [junit] 2009-10-09 10:51:13,254 - INFO
> [NIOServerCxn.Factory:11225:NIOServerCnxn$Factory@236] - NIOServerCnxn
> factory exited run method
> [junit] 2009-10-09 10:51:13,255 - INFO [main:FinalRequestProcessor@283]
> - shutdown of request processor complete
> [junit] 2009-10-09 10:51:13,255 - INFO
> [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited
> loop!
> [junit] 2009-10-09 10:51:13,256 - INFO
> [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
> [junit] ensureOnly:[]
> [junit] 2009-10-09 10:51:13,258 - INFO [main:ClientBase@428] -
> FINISHED testWatcherAutoResetDisabledWithGlobal
> [junit] 2009-10-09 10:51:13,259 - INFO [main:ClientBase@338] -
> STARTING testWatcherAutoResetDisabledWithLocal
> [junit] 2009-10-09 10:51:13,264 - INFO [main:ClientBase@367] -
> STARTING server
> [junit] 2009-10-09 10:51:13,265 - INFO [main:ZooKeeperServer@160] -
> Created server
> [junit] 2009-10-09 10:51:13,265 - INFO [main:NIOServerCnxn$Factory@122]
> - binding to port 11226
> [junit] 2009-10-09 10:51:13,266 - INFO [main:FileTxnSnapLog@208] -
> Snapshotting: 0
> [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
> [junit] 2009-10-09 10:51:13,268 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command
> from /127.0.0.1:42009
> [junit] 2009-10-09 10:51:13,268 - WARN
> [NIOServerCxn.Factory:11226:NIOServerCnxn@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:NIOServerCnxn@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:ClientBase@359] - Initial
> fdcount is: 42
> [junit] 2009-10-09 10:51:13,270 - INFO [main:ClientBase@363] - Client
> test setup finished
> [junit] 2009-10-09 10:51:13,270 - INFO [main:ZooKeeper@369] -
> Initiating client connection, connectString=127.0.0.1:11226sessionTimeout=5000
> watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@1784427
> [junit] 2009-10-09 10:51:13,270 - INFO
> [main-SendThread():ClientCnxn$SendThread@869] - Attempting connection to
> server /127.0.0.1:11226
> [junit] 2009-10-09 10:51:13,271 - INFO
> [main-SendThread(localhost:11226):ClientCnxn$SendThread@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$SendThread@939] - Server
> connection successful
> [junit] 2009-10-09 10:51:13,271 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /
> 127.0.0.1:42010 lastZxid 0
> [junit] 2009-10-09 10:51:13,272 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@616] - Creating new session
> 0x12438ec7df20000
> [junit] 2009-10-09 10:51:13,281 - INFO [SyncThread:0:NIOServerCnxn@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:ClientBase@374] -
> STOPPING server
> [junit] 2009-10-09 10:51:13,289 - INFO [main:NIOServerCnxn@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$SendThread@969] - Exception
> closing session 0x12438ec7df20000 to sun.nio.ch.SelectionKeyImpl@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$Factory@236] - NIOServerCnxn
> factory exited run method
> [junit] 2009-10-09 10:51:13,290 - INFO [main:FinalRequestProcessor@283]
> - shutdown of request processor complete
> [junit] 2009-10-09 10:51:13,290 - INFO
> [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
> [junit] 2009-10-09 10:51:13,290 - INFO
> [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited
> loop!
> [junit] ensureOnly:[]
> [junit] 2009-10-09 10:51:13,390 - INFO [main:ClientBase@367] -
> STARTING server
> [junit] 2009-10-09 10:51:13,390 - INFO [main:ZooKeeperServer@160] -
> Created server
> [junit] 2009-10-09 10:51:13,391 - INFO [main:NIOServerCnxn$Factory@122]
> - binding to port 11226
> [junit] 2009-10-09 10:51:13,391 - INFO [main:FileSnap@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:FileTxnSnapLog@208] -
> Snapshotting: 3
> [junit] 2009-10-09 10:51:13,395 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@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:NIOServerCnxn@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:NIOServerCnxn@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$SendThread@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$SendThread@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$SendThread@939] - Server
> connection successful
> [junit] 2009-10-09 10:51:14,847 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /
> 127.0.0.1:42014 lastZxid 3
> [junit] 2009-10-09 10:51:14,848 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of
> 0x12438ec7df20000 valid:true
> [junit] 2009-10-09 10:51:14,848 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session
> 0x12438ec7df20000
> [junit] 2009-10-09 10:51:14,857 - INFO [main:ClientBase@374] -
> STOPPING server
> [junit] 2009-10-09 10:51:14,858 - INFO [main:NIOServerCnxn@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$SendThread@969] - Exception
> closing session 0x12438ec7df20000 to sun.nio.ch.SelectionKeyImpl@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$Factory@236] - NIOServerCnxn
> factory exited run method
> [junit] 2009-10-09 10:51:14,859 - INFO [main:FinalRequestProcessor@283]
> - shutdown of request processor complete
> [junit] 2009-10-09 10:51:14,859 - INFO
> [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited
> loop!
> [junit] 2009-10-09 10:51:14,859 - INFO
> [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
> [junit] ensureOnly:[]
> [junit] 2009-10-09 10:51:14,959 - INFO [main:ClientBase@367] -
> STARTING server
> [junit] 2009-10-09 10:51:14,959 - INFO [main:ZooKeeperServer@160] -
> Created server
> [junit] 2009-10-09 10:51:14,959 - INFO [main:NIOServerCnxn$Factory@122]
> - binding to port 11226
> [junit] 2009-10-09 10:51:14,960 - INFO [main:FileSnap@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:FileTxnSnapLog@208] -
> Snapshotting: 5
> [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
> [junit] 2009-10-09 10:51:14,964 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command
> from /127.0.0.1:42016
> [junit] 2009-10-09 10:51:14,965 - WARN
> [NIOServerCxn.Factory:11226:NIOServerCnxn@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:NIOServerCnxn@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:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
> [junit] 2009-10-09 10:51:15,000 - INFO
> [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
> [junit] 2009-10-09 10:51:15,001 - INFO
> [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
> [junit] 2009-10-09 10:51:16,089 - INFO
> [main-SendThread(localhost:11226):ClientCnxn$SendThread@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$SendThread@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$SendThread@939] - Server
> connection successful
> [junit] 2009-10-09 10:51:16,090 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /
> 127.0.0.1:42017 lastZxid 5
> [junit] 2009-10-09 10:51:16,090 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of
> 0x12438ec7df20000 valid:true
> [junit] 2009-10-09 10:51:16,090 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session
> 0x12438ec7df20000
> [junit] 2009-10-09 10:51:16,100 - INFO [main:ClientBase@374] -
> STOPPING server
> [junit] 2009-10-09 10:51:16,101 - INFO [main:NIOServerCnxn@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$SendThread@969] - Exception
> closing session 0x12438ec7df20000 to sun.nio.ch.SelectionKeyImpl@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$Factory@236] - NIOServerCnxn
> factory exited run method
> [junit] 2009-10-09 10:51:16,102 - INFO [main:FinalRequestProcessor@283]
> - shutdown of request processor complete
> [junit] 2009-10-09 10:51:16,102 - INFO
> [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
> [junit] 2009-10-09 10:51:16,102 - INFO
> [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited
> loop!
> [junit] ensureOnly:[]
> [junit] 2009-10-09 10:51:16,202 - INFO [main:ClientBase@367] -
> STARTING server
> [junit] 2009-10-09 10:51:16,202 - INFO [main:ZooKeeperServer@160] -
> Created server
> [junit] 2009-10-09 10:51:16,202 - INFO [main:NIOServerCnxn$Factory@122]
> - binding to port 11226
> [junit] 2009-10-09 10:51:16,204 - INFO [main:FileSnap@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:FileTxnSnapLog@208] -
> Snapshotting: 6
> [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
> [junit] 2009-10-09 10:51:16,208 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command
> from /127.0.0.1:42019
> [junit] 2009-10-09 10:51:16,208 - WARN
> [NIOServerCxn.Factory:11226:NIOServerCnxn@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:NIOServerCnxn@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$SendThread@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$SendThread@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$SendThread@939] - Server
> connection successful
> [junit] 2009-10-09 10:51:17,231 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /
> 127.0.0.1:42020 lastZxid 6
> [junit] 2009-10-09 10:51:17,231 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of
> 0x12438ec7df20000 valid:true
> [junit] 2009-10-09 10:51:17,231 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session
> 0x12438ec7df20000
> [junit] 2009-10-09 10:51:18,000 - INFO
> [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
> [junit] 2009-10-09 10:51:18,240 - INFO [main:ZooKeeper@502] - Closing
> session: 0x12438ec7df20000
> [junit] 2009-10-09 10:51:18,240 - INFO [main:ClientCnxn@1070] -
> Closing ClientCnxn for session: 0x12438ec7df20000
> [junit] 2009-10-09 10:51:18,241 - INFO
> [ProcessThread:-1:PrepRequestProcessor@384] - Processed session
> termination request for id: 0x12438ec7df20000
> [junit] 2009-10-09 10:51:18,242 - INFO [SyncThread:0:NIOServerCnxn@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$SendThread@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:ClientCnxn@1056] -
> Disconnecting ClientCnxn for session: 0x12438ec7df20000
> [junit] 2009-10-09 10:51:18,343 - INFO [main:ZooKeeper@510] - Session:
> 0x12438ec7df20000 closed
> [junit] 2009-10-09 10:51:18,343 - INFO
> [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
> [junit] 2009-10-09 10:51:18,343 - INFO [main:ClientBase@397] -
> tearDown starting
> [junit] 2009-10-09 10:51:18,344 - INFO [main:ClientBase@409] - fdcount
> after test is: 40
> [junit] 2009-10-09 10:51:18,344 - INFO [main:ZooKeeper@502] - Closing
> session: 0x12438ec7df20000
> [junit] 2009-10-09 10:51:18,344 - INFO [main:ClientCnxn@1070] -
> Closing ClientCnxn for session: 0x12438ec7df20000
> [junit] 2009-10-09 10:51:18,344 - INFO [main:ClientCnxn@1056] -
> Disconnecting ClientCnxn for session: 0x12438ec7df20000
> [junit] 2009-10-09 10:51:18,344 - INFO [main:ZooKeeper@510] - Session:
> 0x12438ec7df20000 closed
> [junit] 2009-10-09 10:51:18,345 - INFO [main:ClientBase@374] -
> STOPPING server
> [junit] 2009-10-09 10:51:18,345 - INFO
> [NIOServerCxn.Factory:11226:NIOServerCnxn$Factory@236] - NIOServerCnxn
> factory exited run method
> [junit] 2009-10-09 10:51:18,345 - INFO [main:FinalRequestProcessor@283]
> - shutdown of request processor complete
> [junit] 2009-10-09 10:51:18,345 - INFO
> [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited
> loop!
> [junit] 2009-10-09 10:51:18,345 - INFO
> [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
> [junit] ensureOnly:[]
> [junit] 2009-10-09 10:51:18,348 - INFO [main:ClientBase@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:PortAssignment@31] -
> assigning port 11221
> [junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest
> [junit] 2009-10-09 10:51:19,063 - INFO [main:ClientBase@338] -
> STARTING testQuota
> [junit] 2009-10-09 10:51:19,234 - INFO [main:ClientBase@367] -
> STARTING server
> [junit] 2009-10-09 10:51:19,243 - INFO [main:Environment@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:Environment@97] - Server
> environment:host.name=h8.grid.sp2.yahoo.net
> [junit] 2009-10-09 10:51:19,245 - INFO [main:Environment@97] - Server
> environment:java.version=1.6.0_11
> [junit] 2009-10-09 10:51:19,245 - INFO [main:Environment@97] - Server
> environment:java.vendor=Sun Microsystems Inc.
> [junit] 2009-10-09 10:51:19,246 - INFO [main:Environment@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:Environment@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:Environment@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:Environment@97] - Server
> environment:java.io.tmpdir=/tmp
> [junit] 2009-10-09 10:51:19,249 - INFO [main:Environment@97] - Server
> environment:java.compiler=<NA>
> [junit] 2009-10-09 10:51:19,249 - INFO [main:Environment@97] - Server
> environment:os.name=Linux
> [junit] 2009-10-09 10:51:19,250 - INFO [main:Environment@97] - Server
> environment:os.arch=i386
> [junit] 2009-10-09 10:51:19,250 - INFO [main:Environment@97] - Server
> environment:os.version=2.6.28-15-generic
> [junit] 2009-10-09 10:51:19,251 - INFO [main:Environment@97] - Server
> environment:user.name=hudson
> [junit] 2009-10-09 10:51:19,251 - INFO [main:Environment@97] - Server
> environment:user.home=/homes/hudson
> [junit] 2009-10-09 10:51:19,252 - INFO [main:Environment@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:ZooKeeperServer@160] -
> Created server
> [junit] 2009-10-09 10:51:19,272 - INFO [main:NIOServerCnxn$Factory@122]
> - binding to port 11221
> [junit] 2009-10-09 10:51:19,289 - INFO [main:FileTxnSnapLog@208] -
> Snapshotting: 0
> [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
> [junit] 2009-10-09 10:51:19,320 - INFO
> [NIOServerCxn.Factory:11221:NIOServerCnxn@699] - Processing stat command
> from /127.0.0.1:35184
> [junit] 2009-10-09 10:51:19,321 - WARN
> [NIOServerCxn.Factory:11221:NIOServerCnxn@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:NIOServerCnxn@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:ClientBase@359] - Initial
> fdcount is: 32
> [junit] 2009-10-09 10:51:19,339 - INFO [main:ClientBase@363] - Client
> test setup finished
> [junit] 2009-10-09 10:51:19,344 - INFO [main:Environment@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:Environment@97] - Client
> environment:host.name=h8.grid.sp2.yahoo.net
> [junit] 2009-10-09 10:51:19,345 - INFO [main:Environment@97] - Client
> environment:java.version=1.6.0_11
> [junit] 2009-10-09 10:51:19,345 - INFO [main:Environment@97] - Client
> environment:java.vendor=Sun Microsystems Inc.
> [junit] 2009-10-09 10:51:19,346 - INFO [main:Environment@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:Environment@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:Environment@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:Environment@97] - Client
> environment:java.io.tmpdir=/tmp
> [junit] 2009-10-09 10:51:19,348 - INFO [main:Environment@97] - Client
> environment:java.compiler=<NA>
> [junit] 2009-10-09 10:51:19,348 - INFO [main:Environment@97] - Client
> environment:os.name=Linux
> [junit] 2009-10-09 10:51:19,349 - INFO [main:Environment@97] - Client
> environment:os.arch=i386
> [junit] 2009-10-09 10:51:19,349 - INFO [main:Environment@97] - Client
> environment:os.version=2.6.28-15-generic
> [junit] 2009-10-09 10:51:19,350 - INFO [main:Environment@97] - Client
> environment:user.name=hudson
> [junit] 2009-10-09 10:51:19,350 - INFO [main:Environment@97] - Client
> environment:user.home=/homes/hudson
> [junit] 2009-10-09 10:51:19,351 - INFO [main:Environment@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:ZooKeeper@369] -
> Initiating client connection, connectString=127.0.0.1:11221sessionTimeout=30000
> watcher=org.apache.zookeeper.test.ClientBase$CountdownWatcher@a00185
> [junit] 2009-10-09 10:51:19,354 - INFO [main:ClientCnxn@92] -
> zookeeper.disableAutoWatchReset is false
> [junit] 2009-10-09 10:51:19,362 - INFO
> [main-SendThread():ClientCnxn$SendThread@869] - Attempting connection to
> server /127.0.0.1:11221
> [junit] 2009-10-09 10:51:19,363 - INFO
> [main-SendThread(localhost:11221):ClientCnxn$SendThread@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$SendThread@939] - Server
> connection successful
> [junit] 2009-10-09 10:51:19,369 - INFO
> [NIOServerCxn.Factory:11221:NIOServerCnxn@584] - Connected to /
> 127.0.0.1:35185 lastZxid 0
> [junit] 2009-10-09 10:51:19,371 - INFO
> [NIOServerCxn.Factory:11221:NIOServerCnxn@616] - Creating new session
> 0x12438ec957f0000
> [junit] 2009-10-09 10:51:19,390 - INFO [SyncThread:0:NIOServerCnxn@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:ClientBase@397] -
> tearDown starting
> [junit] 2009-10-09 10:51:19,447 - INFO [main:ClientBase@409] - fdcount
> after test is: 38
> [junit] 2009-10-09 10:51:19,447 - INFO [main:ZooKeeper@502] - Closing
> session: 0x12438ec957f0000
> [junit] 2009-10-09 10:51:19,448 - INFO [main:ClientCnxn@1070] -
> Closing ClientCnxn for session: 0x12438ec957f0000
> [junit] 2009-10-09 10:51:19,448 - INFO
> [ProcessThread:-1:PrepRequestProcessor@384] - Processed session
> termination request for id: 0x12438ec957f0000
> [junit] 2009-10-09 10:51:19,450 - INFO [SyncThread:0:NIOServerCnxn@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$SendThread@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:ClientCnxn@1056] -
> Disconnecting ClientCnxn for session: 0x12438ec957f0000
> [junit] 2009-10-09 10:51:19,551 - INFO [main:ZooKeeper@510] - Session:
> 0x12438ec957f0000 closed
> [junit] 2009-10-09 10:51:19,551 - INFO
> [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
> [junit] 2009-10-09 10:51:19,552 - INFO [main:ClientBase@374] -
> STOPPING server
> [junit] 2009-10-09 10:51:19,552 - INFO
> [NIOServerCxn.Factory:11221:NIOServerCnxn$Factory@236] - NIOServerCnxn
> factory exited run method
> [junit] 2009-10-09 10:51:19,553 - INFO [main:FinalRequestProcessor@283]
> - shutdown of request processor complete
> [junit] 2009-10-09 10:51:19,553 - INFO
> [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited
> loop!
> [junit] 2009-10-09 10:51:19,553 - INFO
> [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
> [junit] ensureOnly:[]
> [junit] 2009-10-09 10:51:19,556 - INFO [main:ClientBase@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
>
>