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/01/30 12:45:03 UTC
Build failed in Hudson: ZooKeeper-trunk #214
See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/214/changes
Changes:
[mahadev] ZOOKEEPER-269. connectionloss- add more documentation to detail. (phunt and flavio via mahadev)
[mahadev] ZOOKEEPER-272. getchildren can fail for large number of children. (mahadev)
[mahadev] ZOOKEEPER-275. Bug in FastLeaderElection. (flavio via mahadev)
------------------------------------------
[...truncated 62276 lines...]
[junit] 2009-01-30 11:49:10,061 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-30 11:49:10,062 - INFO [main:NIOServerCnxn@732] - closing session:0x11f275eddb80000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51077]
[junit] 2009-01-30 11:49:10,062 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f275eddb80000 to sun.nio.ch.SelectionKeyImpl@1a19458
[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:631)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-30 11:49:10,063 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-30 11:49:10,063 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-30 11:49:10,063 - INFO [ProcessThread:0:PrepRequestProcessor@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-30 11:49:10,063 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-30 11:49:10,163 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-30 11:49:10,163 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-30 11:49:10,165 - INFO [main:FileSnap@70] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test1801438123754631699.junit.dir/version-2/snapshot.5
[junit] 2009-01-30 11:49:10,166 - INFO [main:FileTxnSnapLog@197] - Snapshotting: 6
[junit] 2009-01-30 11:49:10,168 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@604] - Processing stat command from /127.0.0.1:51079
[junit] 2009-01-30 11:49:10,169 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@402] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-30 11:49:10,169 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@732] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51079]
[junit] 2009-01-30 11:49:11,430 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-30 11:49:11,430 - INFO [main-SendThread:ClientCnxn$SendThread@715] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51080 remote=/127.0.0.1:33221]
[junit] 2009-01-30 11:49:11,430 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-30 11:49:11,431 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@488] - Connected to /127.0.0.1:51080 lastZxid 6
[junit] 2009-01-30 11:49:11,431 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@860] - Finished init of 0x11f275eddb80000 valid:true
[junit] 2009-01-30 11:49:11,431 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@516] - Renewing session 0x11f275eddb80000
[junit] 2009-01-30 11:49:12,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-30 11:49:12,441 - INFO [main:ZooKeeper@434] - Closing session: 0x11f275eddb80000
[junit] 2009-01-30 11:49:12,441 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x11f275eddb80000
[junit] 2009-01-30 11:49:12,442 - INFO [ProcessThread:0:PrepRequestProcessor@344] - Processed session termination request for id: 0x11f275eddb80000
[junit] 2009-01-30 11:49:12,443 - INFO [SyncThread:0:NIOServerCnxn@732] - closing session:0x11f275eddb80000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51080]
[junit] 2009-01-30 11:49:12,443 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x11f275eddb80000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-01-30 11:49:12,543 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x11f275eddb80000
[junit] 2009-01-30 11:49:12,544 - INFO [main:ZooKeeper@442] - Session: 0x11f275eddb80000 closed
[junit] 2009-01-30 11:49:12,544 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-01-30 11:49:12,544 - INFO [main:ClientBase@312] - tearDown starting
[junit] 2009-01-30 11:49:12,545 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-30 11:49:12,545 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-30 11:49:12,545 - INFO [ProcessThread:0:PrepRequestProcessor@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-30 11:49:12,545 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-30 11:49:12,546 - INFO [main:ClientBase@322] - FINISHED testWatcherAutoResetWithLocal
[junit] 2009-01-30 11:49:12,547 - INFO [main:ClientBase@288] - STARTING testWatcherAutoResetDisabledWithGlobal
[junit] 2009-01-30 11:49:12,548 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-30 11:49:12,548 - INFO [main:FileTxnSnapLog@197] - Snapshotting: 0
[junit] 2009-01-30 11:49:12,550 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@604] - Processing stat command from /127.0.0.1:51082
[junit] 2009-01-30 11:49:12,550 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@402] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-30 11:49:12,550 - INFO [main:ClientBase@296] - Client test setup finished
[junit] 2009-01-30 11:49:12,551 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@732] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51082]
[junit] 2009-01-30 11:49:12,551 - INFO [main:ZooKeeper@341] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=9000 watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@51127a
[junit] 2009-01-30 11:49:12,552 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-30 11:49:12,552 - INFO [main-SendThread:ClientCnxn$SendThread@715] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51083 remote=/127.0.0.1:33221]
[junit] 2009-01-30 11:49:12,552 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-30 11:49:12,552 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@488] - Connected to /127.0.0.1:51083 lastZxid 0
[junit] 2009-01-30 11:49:12,553 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@519] - Creating new session 0x11f275f04e50000
[junit] 2009-01-30 11:49:12,559 - INFO [SyncThread:0:NIOServerCnxn@860] - Finished init of 0x11f275f04e50000 valid:true
[junit] 2009-01-30 11:49:12,564 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-30 11:49:12,565 - INFO [main:NIOServerCnxn@732] - closing session:0x11f275f04e50000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51083]
[junit] 2009-01-30 11:49:12,566 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f275f04e50000 to sun.nio.ch.SelectionKeyImpl@691dee
[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:631)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-30 11:49:12,566 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-30 11:49:12,566 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-30 11:49:12,566 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-30 11:49:12,568 - INFO [ProcessThread:0:PrepRequestProcessor@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-30 11:49:12,666 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-30 11:49:12,667 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-30 11:49:12,667 - INFO [main:FileSnap@70] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test6315128355627669072.junit.dir/version-2/snapshot.0
[junit] 2009-01-30 11:49:12,668 - INFO [main:FileTxnSnapLog@197] - Snapshotting: 3
[junit] 2009-01-30 11:49:12,670 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@604] - Processing stat command from /127.0.0.1:51085
[junit] 2009-01-30 11:49:12,671 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@402] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-30 11:49:12,671 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@732] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51085]
[junit] 2009-01-30 11:49:14,235 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-30 11:49:14,236 - INFO [main-SendThread:ClientCnxn$SendThread@715] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51086 remote=/127.0.0.1:33221]
[junit] 2009-01-30 11:49:14,236 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-30 11:49:14,236 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@488] - Connected to /127.0.0.1:51086 lastZxid 3
[junit] 2009-01-30 11:49:14,237 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@860] - Finished init of 0x11f275f04e50000 valid:true
[junit] 2009-01-30 11:49:14,237 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@516] - Renewing session 0x11f275f04e50000
[junit] 2009-01-30 11:49:15,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-30 11:49:15,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-30 11:49:48,253 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-30 11:49:48,254 - INFO [main:NIOServerCnxn@732] - closing session:0x11f275f04e50000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51086]
[junit] 2009-01-30 11:49:48,254 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f275f04e50000 to sun.nio.ch.SelectionKeyImpl@bb494b
[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:631)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-30 11:49:48,254 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-30 11:49:48,255 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-30 11:49:48,255 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-30 11:49:48,255 - INFO [ProcessThread:0:PrepRequestProcessor@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-30 11:49:48,355 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-30 11:49:48,355 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-30 11:49:48,356 - INFO [main:FileSnap@70] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test6315128355627669072.junit.dir/version-2/snapshot.3
[junit] 2009-01-30 11:49:48,358 - INFO [main:FileTxnSnapLog@197] - Snapshotting: 5
[junit] 2009-01-30 11:49:48,360 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@604] - Processing stat command from /127.0.0.1:51088
[junit] 2009-01-30 11:49:48,360 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@402] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-30 11:49:48,360 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@732] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51088]
[junit] 2009-01-30 11:49:49,890 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-30 11:49:49,890 - INFO [main-SendThread:ClientCnxn$SendThread@715] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51089 remote=/127.0.0.1:33221]
[junit] 2009-01-30 11:49:49,890 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-30 11:49:49,890 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@488] - Connected to /127.0.0.1:51089 lastZxid 5
[junit] 2009-01-30 11:49:49,891 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@860] - Finished init of 0x11f275f04e50000 valid:true
[junit] 2009-01-30 11:49:49,891 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@516] - Renewing session 0x11f275f04e50000
[junit] 2009-01-30 11:49:49,901 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-30 11:49:49,902 - INFO [main:NIOServerCnxn@732] - closing session:0x11f275f04e50000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51089]
[junit] 2009-01-30 11:49:49,903 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f275f04e50000 to sun.nio.ch.SelectionKeyImpl@ee1ede
[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:631)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-30 11:49:49,903 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-30 11:49:49,903 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-30 11:49:49,903 - INFO [ProcessThread:0:PrepRequestProcessor@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-30 11:49:49,903 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-30 11:49:50,003 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-30 11:49:50,003 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-30 11:49:50,005 - INFO [main:FileSnap@70] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test6315128355627669072.junit.dir/version-2/snapshot.5
[junit] 2009-01-30 11:49:50,007 - INFO [main:FileTxnSnapLog@197] - Snapshotting: 6
[junit] 2009-01-30 11:49:50,008 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@604] - Processing stat command from /127.0.0.1:51091
[junit] 2009-01-30 11:49:50,009 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@402] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-30 11:49:50,009 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@732] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51091]
[junit] 2009-01-30 11:49:51,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-30 11:49:51,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-30 11:49:51,231 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-30 11:49:51,231 - INFO [main-SendThread:ClientCnxn$SendThread@715] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51092 remote=/127.0.0.1:33221]
[junit] 2009-01-30 11:49:51,232 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-30 11:49:51,232 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@488] - Connected to /127.0.0.1:51092 lastZxid 6
[junit] 2009-01-30 11:49:51,232 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@860] - Finished init of 0x11f275f04e50000 valid:true
[junit] 2009-01-30 11:49:51,233 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@516] - Renewing session 0x11f275f04e50000
[junit] 2009-01-30 11:50:02,240 - INFO [main:ZooKeeper@434] - Closing session: 0x11f275f04e50000
[junit] 2009-01-30 11:50:02,241 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x11f275f04e50000
[junit] 2009-01-30 11:50:02,242 - INFO [ProcessThread:0:PrepRequestProcessor@344] - Processed session termination request for id: 0x11f275f04e50000
[junit] 2009-01-30 11:50:02,243 - INFO [SyncThread:0:NIOServerCnxn@732] - closing session:0x11f275f04e50000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51092]
[junit] 2009-01-30 11:50:02,243 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x11f275f04e50000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-01-30 11:50:02,344 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x11f275f04e50000
[junit] 2009-01-30 11:50:02,344 - INFO [main:ZooKeeper@442] - Session: 0x11f275f04e50000 closed
[junit] 2009-01-30 11:50:02,344 - INFO [main:ClientBase@312] - tearDown starting
[junit] 2009-01-30 11:50:02,344 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-01-30 11:50:02,345 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-30 11:50:02,345 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-30 11:50:02,345 - INFO [ProcessThread:0:PrepRequestProcessor@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-30 11:50:02,345 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-30 11:50:02,347 - INFO [main:ClientBase@322] - FINISHED testWatcherAutoResetDisabledWithGlobal
[junit] 2009-01-30 11:50:02,348 - INFO [main:ClientBase@288] - STARTING testWatcherAutoResetDisabledWithLocal
[junit] 2009-01-30 11:50:02,348 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-30 11:50:02,349 - INFO [main:FileTxnSnapLog@197] - Snapshotting: 0
[junit] 2009-01-30 11:50:02,351 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@604] - Processing stat command from /127.0.0.1:51094
[junit] 2009-01-30 11:50:02,351 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@402] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-30 11:50:02,351 - INFO [main:ClientBase@296] - Client test setup finished
[junit] 2009-01-30 11:50:02,352 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@732] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51094]
[junit] 2009-01-30 11:50:02,352 - INFO [main:ZooKeeper@341] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=9000 watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@3e96cf
[junit] 2009-01-30 11:50:02,353 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-30 11:50:02,353 - INFO [main-SendThread:ClientCnxn$SendThread@715] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51095 remote=/127.0.0.1:33221]
[junit] 2009-01-30 11:50:02,353 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-30 11:50:02,354 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@488] - Connected to /127.0.0.1:51095 lastZxid 0
[junit] 2009-01-30 11:50:02,354 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@519] - Creating new session 0x11f275fc76e0000
[junit] 2009-01-30 11:50:02,362 - INFO [SyncThread:0:NIOServerCnxn@860] - Finished init of 0x11f275fc76e0000 valid:true
[junit] 2009-01-30 11:50:02,366 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-30 11:50:02,367 - INFO [main:NIOServerCnxn@732] - closing session:0x11f275fc76e0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51095]
[junit] 2009-01-30 11:50:02,367 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f275fc76e0000 to sun.nio.ch.SelectionKeyImpl@94af2f
[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:631)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-30 11:50:02,368 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-30 11:50:02,368 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-30 11:50:02,368 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-30 11:50:02,368 - INFO [ProcessThread:0:PrepRequestProcessor@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-30 11:50:02,468 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-30 11:50:02,468 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-30 11:50:02,469 - INFO [main:FileSnap@70] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test6849952115639494848.junit.dir/version-2/snapshot.0
[junit] 2009-01-30 11:50:02,470 - INFO [main:FileTxnSnapLog@197] - Snapshotting: 3
[junit] 2009-01-30 11:50:02,472 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@604] - Processing stat command from /127.0.0.1:51097
[junit] 2009-01-30 11:50:02,472 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@402] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-30 11:50:02,473 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@732] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51097]
[junit] 2009-01-30 11:50:03,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-30 11:50:03,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-30 11:50:03,891 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-30 11:50:03,891 - INFO [main-SendThread:ClientCnxn$SendThread@715] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51098 remote=/127.0.0.1:33221]
[junit] 2009-01-30 11:50:03,891 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-30 11:50:03,892 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@488] - Connected to /127.0.0.1:51098 lastZxid 3
[junit] 2009-01-30 11:50:03,893 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@860] - Finished init of 0x11f275fc76e0000 valid:true
[junit] 2009-01-30 11:50:03,893 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@516] - Renewing session 0x11f275fc76e0000
[junit] 2009-01-30 11:50:37,903 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-30 11:50:37,904 - INFO [main:NIOServerCnxn@732] - closing session:0x11f275fc76e0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51098]
[junit] 2009-01-30 11:50:37,904 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f275fc76e0000 to sun.nio.ch.SelectionKeyImpl@8ae45a
[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:631)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-30 11:50:37,937 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-30 11:50:37,937 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-30 11:50:37,938 - INFO [ProcessThread:0:PrepRequestProcessor@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-30 11:50:37,937 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-30 11:50:38,035 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-30 11:50:38,035 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-30 11:50:38,036 - INFO [main:FileSnap@70] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test6849952115639494848.junit.dir/version-2/snapshot.3
[junit] 2009-01-30 11:50:38,045 - INFO [main:FileTxnSnapLog@197] - Snapshotting: 5
[junit] 2009-01-30 11:50:38,047 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@604] - Processing stat command from /127.0.0.1:51100
[junit] 2009-01-30 11:50:38,047 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@402] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-30 11:50:38,047 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@732] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51100]
[junit] 2009-01-30 11:50:39,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-30 11:50:39,455 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-30 11:50:39,455 - INFO [main-SendThread:ClientCnxn$SendThread@715] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51101 remote=/127.0.0.1:33221]
[junit] 2009-01-30 11:50:39,455 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-30 11:50:39,455 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@488] - Connected to /127.0.0.1:51101 lastZxid 5
[junit] 2009-01-30 11:50:39,456 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@860] - Finished init of 0x11f275fc76e0000 valid:true
[junit] 2009-01-30 11:50:39,456 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@516] - Renewing session 0x11f275fc76e0000
[junit] 2009-01-30 11:50:39,471 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-30 11:50:39,472 - INFO [main:NIOServerCnxn@732] - closing session:0x11f275fc76e0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51101]
[junit] 2009-01-30 11:50:39,472 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f275fc76e0000 to sun.nio.ch.SelectionKeyImpl@1d6fbb3
[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:631)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-30 11:50:39,473 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-30 11:50:39,473 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-30 11:50:39,473 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-30 11:50:39,474 - INFO [ProcessThread:0:PrepRequestProcessor@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-30 11:50:39,573 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-30 11:50:39,573 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-30 11:50:39,574 - INFO [main:FileSnap@70] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test6849952115639494848.junit.dir/version-2/snapshot.5
[junit] 2009-01-30 11:50:39,576 - INFO [main:FileTxnSnapLog@197] - Snapshotting: 6
[junit] 2009-01-30 11:50:39,578 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@604] - Processing stat command from /127.0.0.1:51103
[junit] 2009-01-30 11:50:39,578 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@402] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-30 11:50:39,578 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@732] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51103]
[junit] 2009-01-30 11:50:41,241 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-30 11:50:41,241 - INFO [main-SendThread:ClientCnxn$SendThread@715] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51104 remote=/127.0.0.1:33221]
[junit] 2009-01-30 11:50:41,241 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-30 11:50:41,242 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@488] - Connected to /127.0.0.1:51104 lastZxid 6
[junit] 2009-01-30 11:50:41,242 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@860] - Finished init of 0x11f275fc76e0000 valid:true
[junit] 2009-01-30 11:50:41,242 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@516] - Renewing session 0x11f275fc76e0000
[junit] 2009-01-30 11:50:42,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-30 11:50:52,252 - INFO [main:ZooKeeper@434] - Closing session: 0x11f275fc76e0000
[junit] 2009-01-30 11:50:52,252 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x11f275fc76e0000
[junit] 2009-01-30 11:50:52,253 - INFO [ProcessThread:0:PrepRequestProcessor@344] - Processed session termination request for id: 0x11f275fc76e0000
[junit] 2009-01-30 11:50:52,253 - INFO [SyncThread:0:NIOServerCnxn@732] - closing session:0x11f275fc76e0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:51104]
[junit] 2009-01-30 11:50:52,254 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x11f275fc76e0000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-01-30 11:50:52,354 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x11f275fc76e0000
[junit] 2009-01-30 11:50:52,354 - INFO [main:ZooKeeper@442] - Session: 0x11f275fc76e0000 closed
[junit] 2009-01-30 11:50:52,354 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-01-30 11:50:52,354 - INFO [main:ClientBase@312] - tearDown starting
[junit] 2009-01-30 11:50:52,355 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-30 11:50:52,355 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-30 11:50:52,355 - INFO [ProcessThread:0:PrepRequestProcessor@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-30 11:50:52,355 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-30 11:50:52,357 - INFO [main:ClientBase@322] - FINISHED testWatcherAutoResetDisabledWithLocal
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 126.492 sec
BUILD FAILED
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :547: Tests failed!
Total time: 8 minutes 43 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
Hudson build is back to normal: ZooKeeper-trunk #217
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/217/changes
Build failed in Hudson: ZooKeeper-trunk #216
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/216/changes
------------------------------------------
[...truncated 63345 lines...]
[junit] 2009-02-01 11:45:08,844 - INFO [main:NIOServerCnxn@737] - closing session:0x11f31a7e8780000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56219]
[junit] 2009-02-01 11:45:08,844 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f31a7e8780000 to sun.nio.ch.SelectionKeyImpl@1f54c5f
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-02-01 11:45:08,845 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-02-01 11:45:08,845 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-02-01 11:45:08,845 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-01 11:45:08,845 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-02-01 11:45:08,945 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-01 11:45:08,945 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-02-01 11:45:08,947 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test4296859123344405422.junit.dir/version-2/snapshot.5
[junit] 2009-02-01 11:45:08,949 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 6
[junit] 2009-02-01 11:45:08,950 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:56221
[junit] 2009-02-01 11:45:08,951 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-01 11:45:08,951 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56221]
[junit] 2009-02-01 11:45:09,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-01 11:45:09,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-01 11:45:10,004 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-01 11:45:10,004 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:56222 remote=/127.0.0.1:33221]
[junit] 2009-02-01 11:45:10,005 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-01 11:45:10,005 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:56222 lastZxid 6
[junit] 2009-02-01 11:45:10,005 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f31a7e8780000 valid:true
[junit] 2009-02-01 11:45:10,006 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f31a7e8780000
[junit] 2009-02-01 11:45:11,012 - INFO [main:ZooKeeper@434] - Closing session: 0x11f31a7e8780000
[junit] 2009-02-01 11:45:11,012 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x11f31a7e8780000
[junit] 2009-02-01 11:45:11,013 - INFO [ProcessThread:0:PrepRequestProcessor@360] - Processed session termination request for id: 0x11f31a7e8780000
[junit] 2009-02-01 11:45:11,014 - INFO [SyncThread:0:NIOServerCnxn@737] - closing session:0x11f31a7e8780000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56222]
[junit] 2009-02-01 11:45:11,014 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x11f31a7e8780000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-02-01 11:45:11,114 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x11f31a7e8780000
[junit] 2009-02-01 11:45:11,114 - INFO [main:ZooKeeper@442] - Session: 0x11f31a7e8780000 closed
[junit] 2009-02-01 11:45:11,114 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-02-01 11:45:11,115 - INFO [main:ClientBase@312] - tearDown starting
[junit] 2009-02-01 11:45:11,115 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-02-01 11:45:11,116 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-02-01 11:45:11,116 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-02-01 11:45:11,116 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-01 11:45:11,118 - INFO [main:ClientBase@322] - FINISHED testWatcherAutoResetWithLocal
[junit] 2009-02-01 11:45:11,118 - INFO [main:ClientBase@288] - STARTING testWatcherAutoResetDisabledWithGlobal
[junit] 2009-02-01 11:45:11,119 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-02-01 11:45:11,120 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 0
[junit] 2009-02-01 11:45:11,121 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:56224
[junit] 2009-02-01 11:45:11,121 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-01 11:45:11,122 - INFO [main:ClientBase@296] - Client test setup finished
[junit] 2009-02-01 11:45:11,122 - INFO [main:ZooKeeper@341] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=9000 watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@d1e233
[junit] 2009-02-01 11:45:11,122 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56224]
[junit] 2009-02-01 11:45:11,123 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-01 11:45:11,123 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:56225 remote=/127.0.0.1:33221]
[junit] 2009-02-01 11:45:11,123 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-01 11:45:11,124 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:56225 lastZxid 0
[junit] 2009-02-01 11:45:11,124 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@524] - Creating new session 0x11f31a80dd00000
[junit] 2009-02-01 11:45:11,141 - INFO [SyncThread:0:NIOServerCnxn@865] - Finished init of 0x11f31a80dd00000 valid:true
[junit] 2009-02-01 11:45:11,146 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-02-01 11:45:11,147 - INFO [main:NIOServerCnxn@737] - closing session:0x11f31a80dd00000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56225]
[junit] 2009-02-01 11:45:11,147 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f31a80dd00000 to sun.nio.ch.SelectionKeyImpl@7976c1
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-02-01 11:45:11,148 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-02-01 11:45:11,148 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-02-01 11:45:11,148 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-01 11:45:11,148 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-02-01 11:45:11,248 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-01 11:45:11,248 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-02-01 11:45:11,249 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test5883751898880163489.junit.dir/version-2/snapshot.0
[junit] 2009-02-01 11:45:11,250 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 3
[junit] 2009-02-01 11:45:11,252 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:56227
[junit] 2009-02-01 11:45:11,253 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-01 11:45:11,253 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56227]
[junit] 2009-02-01 11:45:12,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-01 11:45:12,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-01 11:45:12,527 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-01 11:45:12,527 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:56228 remote=/127.0.0.1:33221]
[junit] 2009-02-01 11:45:12,527 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-01 11:45:12,528 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:56228 lastZxid 3
[junit] 2009-02-01 11:45:12,528 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f31a80dd00000 valid:true
[junit] 2009-02-01 11:45:12,528 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f31a80dd00000
[junit] 2009-02-01 11:45:46,551 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-02-01 11:45:46,551 - INFO [main:NIOServerCnxn@737] - closing session:0x11f31a80dd00000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56228]
[junit] 2009-02-01 11:45:46,552 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f31a80dd00000 to sun.nio.ch.SelectionKeyImpl@1236cd5
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-02-01 11:45:46,552 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-02-01 11:45:46,553 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-02-01 11:45:46,553 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-02-01 11:45:46,553 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-01 11:45:46,652 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-01 11:45:46,653 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-02-01 11:45:46,654 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test5883751898880163489.junit.dir/version-2/snapshot.3
[junit] 2009-02-01 11:45:46,655 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 5
[junit] 2009-02-01 11:45:46,657 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:56230
[junit] 2009-02-01 11:45:46,658 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-01 11:45:46,658 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56230]
[junit] 2009-02-01 11:45:47,680 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-01 11:45:47,681 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:56231 remote=/127.0.0.1:33221]
[junit] 2009-02-01 11:45:47,681 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-01 11:45:47,681 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:56231 lastZxid 5
[junit] 2009-02-01 11:45:47,682 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f31a80dd00000 valid:true
[junit] 2009-02-01 11:45:47,682 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f31a80dd00000
[junit] 2009-02-01 11:45:47,701 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-02-01 11:45:47,702 - INFO [main:NIOServerCnxn@737] - closing session:0x11f31a80dd00000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56231]
[junit] 2009-02-01 11:45:47,702 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f31a80dd00000 to sun.nio.ch.SelectionKeyImpl@1eb5666
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-02-01 11:45:47,702 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-02-01 11:45:47,703 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-02-01 11:45:47,703 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-01 11:45:47,703 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-02-01 11:45:47,802 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-01 11:45:47,803 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-02-01 11:45:47,804 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test5883751898880163489.junit.dir/version-2/snapshot.5
[junit] 2009-02-01 11:45:47,806 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 6
[junit] 2009-02-01 11:45:47,808 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:56233
[junit] 2009-02-01 11:45:47,808 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-01 11:45:47,809 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56233]
[junit] 2009-02-01 11:45:48,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-01 11:45:48,001 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-01 11:45:49,428 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-01 11:45:49,429 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:56234 remote=/127.0.0.1:33221]
[junit] 2009-02-01 11:45:49,429 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-01 11:45:49,429 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:56234 lastZxid 6
[junit] 2009-02-01 11:45:49,430 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f31a80dd00000 valid:true
[junit] 2009-02-01 11:45:49,430 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f31a80dd00000
[junit] 2009-02-01 11:46:00,442 - INFO [main:ZooKeeper@434] - Closing session: 0x11f31a80dd00000
[junit] 2009-02-01 11:46:00,442 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x11f31a80dd00000
[junit] 2009-02-01 11:46:00,443 - INFO [ProcessThread:0:PrepRequestProcessor@360] - Processed session termination request for id: 0x11f31a80dd00000
[junit] 2009-02-01 11:46:00,444 - INFO [SyncThread:0:NIOServerCnxn@737] - closing session:0x11f31a80dd00000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56234]
[junit] 2009-02-01 11:46:00,444 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x11f31a80dd00000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-02-01 11:46:00,544 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x11f31a80dd00000
[junit] 2009-02-01 11:46:00,544 - INFO [main:ZooKeeper@442] - Session: 0x11f31a80dd00000 closed
[junit] 2009-02-01 11:46:00,544 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-02-01 11:46:00,545 - INFO [main:ClientBase@312] - tearDown starting
[junit] 2009-02-01 11:46:00,545 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-02-01 11:46:00,546 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-02-01 11:46:00,546 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-01 11:46:00,546 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-02-01 11:46:00,547 - INFO [main:ClientBase@322] - FINISHED testWatcherAutoResetDisabledWithGlobal
[junit] 2009-02-01 11:46:00,548 - INFO [main:ClientBase@288] - STARTING testWatcherAutoResetDisabledWithLocal
[junit] 2009-02-01 11:46:00,549 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-02-01 11:46:00,550 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 0
[junit] 2009-02-01 11:46:00,551 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:56236
[junit] 2009-02-01 11:46:00,552 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-01 11:46:00,552 - INFO [main:ClientBase@296] - Client test setup finished
[junit] 2009-02-01 11:46:00,552 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56236]
[junit] 2009-02-01 11:46:00,552 - INFO [main:ZooKeeper@341] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=9000 watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@29c204
[junit] 2009-02-01 11:46:00,553 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-01 11:46:00,554 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:56237 remote=/127.0.0.1:33221]
[junit] 2009-02-01 11:46:00,554 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-01 11:46:00,554 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:56237 lastZxid 0
[junit] 2009-02-01 11:46:00,554 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@524] - Creating new session 0x11f31a8cee60000
[junit] 2009-02-01 11:46:00,561 - INFO [SyncThread:0:NIOServerCnxn@865] - Finished init of 0x11f31a8cee60000 valid:true
[junit] 2009-02-01 11:46:00,566 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-02-01 11:46:00,567 - INFO [main:NIOServerCnxn@737] - closing session:0x11f31a8cee60000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56237]
[junit] 2009-02-01 11:46:00,567 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f31a8cee60000 to sun.nio.ch.SelectionKeyImpl@df48c4
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-02-01 11:46:00,568 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-02-01 11:46:00,568 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-02-01 11:46:00,568 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-01 11:46:00,568 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-02-01 11:46:00,668 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-01 11:46:00,668 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-02-01 11:46:00,669 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test2427092952603938520.junit.dir/version-2/snapshot.0
[junit] 2009-02-01 11:46:00,670 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 3
[junit] 2009-02-01 11:46:00,672 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:56239
[junit] 2009-02-01 11:46:00,672 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-01 11:46:00,673 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56239]
[junit] 2009-02-01 11:46:01,780 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-01 11:46:01,781 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:56240 remote=/127.0.0.1:33221]
[junit] 2009-02-01 11:46:01,781 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-01 11:46:01,782 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:56240 lastZxid 3
[junit] 2009-02-01 11:46:01,783 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f31a8cee60000 valid:true
[junit] 2009-02-01 11:46:01,783 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f31a8cee60000
[junit] 2009-02-01 11:46:03,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-01 11:46:03,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-01 11:46:35,794 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-02-01 11:46:35,795 - INFO [main:NIOServerCnxn@737] - closing session:0x11f31a8cee60000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56240]
[junit] 2009-02-01 11:46:35,795 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f31a8cee60000 to sun.nio.ch.SelectionKeyImpl@3afb99
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-02-01 11:46:35,806 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-02-01 11:46:35,807 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-02-01 11:46:35,807 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-02-01 11:46:35,807 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-01 11:46:35,896 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-01 11:46:35,896 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-02-01 11:46:35,902 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test2427092952603938520.junit.dir/version-2/snapshot.3
[junit] 2009-02-01 11:46:35,905 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 5
[junit] 2009-02-01 11:46:35,907 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:56242
[junit] 2009-02-01 11:46:35,908 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-01 11:46:35,908 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56242]
[junit] 2009-02-01 11:46:36,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-01 11:46:37,235 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-01 11:46:37,235 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:56243 remote=/127.0.0.1:33221]
[junit] 2009-02-01 11:46:37,235 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-01 11:46:37,235 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:56243 lastZxid 5
[junit] 2009-02-01 11:46:37,236 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f31a8cee60000 valid:true
[junit] 2009-02-01 11:46:37,236 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f31a8cee60000
[junit] 2009-02-01 11:46:37,249 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-02-01 11:46:37,249 - INFO [main:NIOServerCnxn@737] - closing session:0x11f31a8cee60000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56243]
[junit] 2009-02-01 11:46:37,250 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f31a8cee60000 to sun.nio.ch.SelectionKeyImpl@d1e7c2
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-02-01 11:46:37,250 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-02-01 11:46:37,250 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-02-01 11:46:37,250 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-02-01 11:46:37,250 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-01 11:46:37,350 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-01 11:46:37,350 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-02-01 11:46:37,352 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test2427092952603938520.junit.dir/version-2/snapshot.5
[junit] 2009-02-01 11:46:37,353 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 6
[junit] 2009-02-01 11:46:37,355 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:56245
[junit] 2009-02-01 11:46:37,355 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-01 11:46:37,356 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56245]
[junit] 2009-02-01 11:46:38,498 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-01 11:46:38,498 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:56246 remote=/127.0.0.1:33221]
[junit] 2009-02-01 11:46:38,498 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-01 11:46:38,499 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:56246 lastZxid 6
[junit] 2009-02-01 11:46:38,499 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f31a8cee60000 valid:true
[junit] 2009-02-01 11:46:38,499 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f31a8cee60000
[junit] 2009-02-01 11:46:39,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-01 11:46:49,511 - INFO [main:ZooKeeper@434] - Closing session: 0x11f31a8cee60000
[junit] 2009-02-01 11:46:49,512 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x11f31a8cee60000
[junit] 2009-02-01 11:46:49,512 - INFO [ProcessThread:0:PrepRequestProcessor@360] - Processed session termination request for id: 0x11f31a8cee60000
[junit] 2009-02-01 11:46:49,513 - INFO [SyncThread:0:NIOServerCnxn@737] - closing session:0x11f31a8cee60000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:56246]
[junit] 2009-02-01 11:46:49,513 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x11f31a8cee60000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-02-01 11:46:49,613 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x11f31a8cee60000
[junit] 2009-02-01 11:46:49,614 - INFO [main:ZooKeeper@442] - Session: 0x11f31a8cee60000 closed
[junit] 2009-02-01 11:46:49,614 - INFO [main:ClientBase@312] - tearDown starting
[junit] 2009-02-01 11:46:49,614 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-02-01 11:46:49,614 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-02-01 11:46:49,615 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-02-01 11:46:49,615 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-02-01 11:46:49,615 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-01 11:46:49,616 - INFO [main:ClientBase@322] - FINISHED testWatcherAutoResetDisabledWithLocal
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 124.105 sec
BUILD FAILED
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :554: Tests failed!
Total time: 8 minutes 31 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
Build failed in Hudson: ZooKeeper-trunk #215
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/215/changes
Changes:
[phunt] ZOOKEEPER-229. improve documentation regarding user's responsibility to cleanup datadir (snaps/logs)
[phunt] ZOOKEEPER-252. PurgeTxnLog is not handling the new dataDir directory structure
[phunt] ZOOKEEPER-215. expand system test environment
[mahadev] ZOOKEEPER-16. Need to do path validation. (pat, mahadev)
[phunt] ZOOKEEPER-260. document the recommended values for server id's
[mahadev] ZOOKEEPER-276. Bookkeeper contribution (Flavio and Luca Telloli via mahadev)
------------------------------------------
[...truncated 62302 lines...]
[junit] 2009-01-31 11:46:54,241 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-31 11:46:54,242 - INFO [main:NIOServerCnxn@737] - closing session:0x11f2c8328070000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:45427]
[junit] 2009-01-31 11:46:54,242 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f2c8328070000 to sun.nio.ch.SelectionKeyImpl@19ba640
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-31 11:46:54,242 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-31 11:46:54,243 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-31 11:46:54,243 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-01-31 11:46:54,243 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-31 11:46:54,342 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-31 11:46:54,343 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-31 11:46:54,344 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test6064899344319696207.junit.dir/version-2/snapshot.5
[junit] 2009-01-31 11:46:54,346 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 6
[junit] 2009-01-31 11:46:54,347 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:45429
[junit] 2009-01-31 11:46:54,348 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-31 11:46:54,349 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:45429]
[junit] 2009-01-31 11:46:55,725 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-31 11:46:55,726 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:45430 remote=/127.0.0.1:33221]
[junit] 2009-01-31 11:46:55,726 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-31 11:46:55,726 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:45430 lastZxid 6
[junit] 2009-01-31 11:46:55,727 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f2c8328070000 valid:true
[junit] 2009-01-31 11:46:55,727 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f2c8328070000
[junit] 2009-01-31 11:46:56,751 - INFO [main:ZooKeeper@434] - Closing session: 0x11f2c8328070000
[junit] 2009-01-31 11:46:56,752 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x11f2c8328070000
[junit] 2009-01-31 11:46:56,753 - INFO [ProcessThread:0:PrepRequestProcessor@360] - Processed session termination request for id: 0x11f2c8328070000
[junit] 2009-01-31 11:46:56,754 - INFO [SyncThread:0:NIOServerCnxn@737] - closing session:0x11f2c8328070000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:45430]
[junit] 2009-01-31 11:46:56,754 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x11f2c8328070000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-01-31 11:46:56,854 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x11f2c8328070000
[junit] 2009-01-31 11:46:56,855 - INFO [main:ZooKeeper@442] - Session: 0x11f2c8328070000 closed
[junit] 2009-01-31 11:46:56,855 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-01-31 11:46:56,856 - INFO [main:ClientBase@312] - tearDown starting
[junit] 2009-01-31 11:46:56,857 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-31 11:46:56,858 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-31 11:46:56,858 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-31 11:46:56,858 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-01-31 11:46:56,859 - INFO [main:ClientBase@322] - FINISHED testWatcherAutoResetWithLocal
[junit] 2009-01-31 11:46:56,860 - INFO [main:ClientBase@288] - STARTING testWatcherAutoResetDisabledWithGlobal
[junit] 2009-01-31 11:46:56,860 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-31 11:46:56,861 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 0
[junit] 2009-01-31 11:46:56,863 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:45432
[junit] 2009-01-31 11:46:56,863 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-31 11:46:56,863 - INFO [main:ClientBase@296] - Client test setup finished
[junit] 2009-01-31 11:46:56,863 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:45432]
[junit] 2009-01-31 11:46:56,864 - INFO [main:ZooKeeper@341] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=9000 watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@6835fb
[junit] 2009-01-31 11:46:56,865 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-31 11:46:56,865 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:45433 remote=/127.0.0.1:33221]
[junit] 2009-01-31 11:46:56,865 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-31 11:46:56,866 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:45433 lastZxid 0
[junit] 2009-01-31 11:46:56,866 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@524] - Creating new session 0x11f2c834ede0000
[junit] 2009-01-31 11:46:56,870 - INFO [SyncThread:0:NIOServerCnxn@865] - Finished init of 0x11f2c834ede0000 valid:true
[junit] 2009-01-31 11:46:56,874 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-31 11:46:56,875 - INFO [main:NIOServerCnxn@737] - closing session:0x11f2c834ede0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:45433]
[junit] 2009-01-31 11:46:56,876 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f2c834ede0000 to sun.nio.ch.SelectionKeyImpl@1c8efd1
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-31 11:46:56,876 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-31 11:46:56,876 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-31 11:46:56,876 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-31 11:46:56,876 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-01-31 11:46:56,976 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-31 11:46:56,976 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-31 11:46:56,977 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test4597051642932905888.junit.dir/version-2/snapshot.0
[junit] 2009-01-31 11:46:56,978 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 3
[junit] 2009-01-31 11:46:56,980 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:45435
[junit] 2009-01-31 11:46:56,980 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-31 11:46:56,981 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:45435]
[junit] 2009-01-31 11:46:57,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-31 11:46:57,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-31 11:46:57,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-31 11:46:58,382 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-31 11:46:58,382 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:45436 remote=/127.0.0.1:33221]
[junit] 2009-01-31 11:46:58,382 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-31 11:46:58,383 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:45436 lastZxid 3
[junit] 2009-01-31 11:46:58,383 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f2c834ede0000 valid:true
[junit] 2009-01-31 11:46:58,383 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f2c834ede0000
[junit] 2009-01-31 11:47:32,394 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-31 11:47:32,395 - INFO [main:NIOServerCnxn@737] - closing session:0x11f2c834ede0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:45436]
[junit] 2009-01-31 11:47:32,395 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f2c834ede0000 to sun.nio.ch.SelectionKeyImpl@8b8a47
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-31 11:47:32,396 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-31 11:47:32,396 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-31 11:47:32,396 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-31 11:47:32,396 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-01-31 11:47:32,496 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-31 11:47:32,496 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-31 11:47:32,497 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test4597051642932905888.junit.dir/version-2/snapshot.3
[junit] 2009-01-31 11:47:32,517 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 5
[junit] 2009-01-31 11:47:32,519 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:59883
[junit] 2009-01-31 11:47:32,529 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-31 11:47:32,530 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:59883]
[junit] 2009-01-31 11:47:33,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-31 11:47:34,111 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-31 11:47:34,111 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59884 remote=/127.0.0.1:33221]
[junit] 2009-01-31 11:47:34,111 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-31 11:47:34,111 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:59884 lastZxid 5
[junit] 2009-01-31 11:47:34,112 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f2c834ede0000 valid:true
[junit] 2009-01-31 11:47:34,112 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f2c834ede0000
[junit] 2009-01-31 11:47:34,123 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-31 11:47:34,124 - INFO [main:NIOServerCnxn@737] - closing session:0x11f2c834ede0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:59884]
[junit] 2009-01-31 11:47:34,124 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f2c834ede0000 to sun.nio.ch.SelectionKeyImpl@10deb5f
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-31 11:47:34,125 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-31 11:47:34,125 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-31 11:47:34,125 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-31 11:47:34,125 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-01-31 11:47:34,225 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-31 11:47:34,225 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-31 11:47:34,226 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test4597051642932905888.junit.dir/version-2/snapshot.5
[junit] 2009-01-31 11:47:34,228 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 6
[junit] 2009-01-31 11:47:34,230 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:59886
[junit] 2009-01-31 11:47:34,231 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-31 11:47:34,231 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:59886]
[junit] 2009-01-31 11:47:35,401 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-31 11:47:35,401 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59887 remote=/127.0.0.1:33221]
[junit] 2009-01-31 11:47:35,401 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-31 11:47:35,402 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:59887 lastZxid 6
[junit] 2009-01-31 11:47:35,402 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f2c834ede0000 valid:true
[junit] 2009-01-31 11:47:35,402 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f2c834ede0000
[junit] 2009-01-31 11:47:36,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-31 11:47:46,414 - INFO [main:ZooKeeper@434] - Closing session: 0x11f2c834ede0000
[junit] 2009-01-31 11:47:46,414 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x11f2c834ede0000
[junit] 2009-01-31 11:47:46,415 - INFO [ProcessThread:0:PrepRequestProcessor@360] - Processed session termination request for id: 0x11f2c834ede0000
[junit] 2009-01-31 11:47:46,416 - INFO [SyncThread:0:NIOServerCnxn@737] - closing session:0x11f2c834ede0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:59887]
[junit] 2009-01-31 11:47:46,416 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x11f2c834ede0000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-01-31 11:47:46,516 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x11f2c834ede0000
[junit] 2009-01-31 11:47:46,517 - INFO [main:ZooKeeper@442] - Session: 0x11f2c834ede0000 closed
[junit] 2009-01-31 11:47:46,517 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-01-31 11:47:46,517 - INFO [main:ClientBase@312] - tearDown starting
[junit] 2009-01-31 11:47:46,517 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-31 11:47:46,518 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-31 11:47:46,518 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-31 11:47:46,518 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-01-31 11:47:46,519 - INFO [main:ClientBase@322] - FINISHED testWatcherAutoResetDisabledWithGlobal
[junit] 2009-01-31 11:47:46,520 - INFO [main:ClientBase@288] - STARTING testWatcherAutoResetDisabledWithLocal
[junit] 2009-01-31 11:47:46,520 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-31 11:47:46,521 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 0
[junit] 2009-01-31 11:47:46,523 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:59889
[junit] 2009-01-31 11:47:46,523 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-31 11:47:46,523 - INFO [main:ClientBase@296] - Client test setup finished
[junit] 2009-01-31 11:47:46,523 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:59889]
[junit] 2009-01-31 11:47:46,524 - INFO [main:ZooKeeper@341] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=9000 watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@a53de4
[junit] 2009-01-31 11:47:46,525 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-31 11:47:46,525 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59890 remote=/127.0.0.1:33221]
[junit] 2009-01-31 11:47:46,525 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-31 11:47:46,526 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:59890 lastZxid 0
[junit] 2009-01-31 11:47:46,526 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@524] - Creating new session 0x11f2c8410da0000
[junit] 2009-01-31 11:47:46,533 - INFO [SyncThread:0:NIOServerCnxn@865] - Finished init of 0x11f2c8410da0000 valid:true
[junit] 2009-01-31 11:47:46,538 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-31 11:47:46,539 - INFO [main:NIOServerCnxn@737] - closing session:0x11f2c8410da0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:59890]
[junit] 2009-01-31 11:47:46,539 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f2c8410da0000 to sun.nio.ch.SelectionKeyImpl@b4be3d
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-31 11:47:46,539 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-31 11:47:46,540 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-31 11:47:46,540 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-31 11:47:46,541 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-01-31 11:47:46,640 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-31 11:47:46,640 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-31 11:47:46,641 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test637807701887696278.junit.dir/version-2/snapshot.0
[junit] 2009-01-31 11:47:46,642 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 3
[junit] 2009-01-31 11:47:46,644 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:59892
[junit] 2009-01-31 11:47:46,644 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-31 11:47:46,645 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:59892]
[junit] 2009-01-31 11:47:48,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-31 11:47:48,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-31 11:47:48,285 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-31 11:47:48,285 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59893 remote=/127.0.0.1:33221]
[junit] 2009-01-31 11:47:48,285 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-31 11:47:48,285 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:59893 lastZxid 3
[junit] 2009-01-31 11:47:48,286 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f2c8410da0000 valid:true
[junit] 2009-01-31 11:47:48,286 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f2c8410da0000
[junit] 2009-01-31 11:48:22,294 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-31 11:48:22,295 - INFO [main:NIOServerCnxn@737] - closing session:0x11f2c8410da0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:59893]
[junit] 2009-01-31 11:48:22,295 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f2c8410da0000 to sun.nio.ch.SelectionKeyImpl@57ea52
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-31 11:48:22,312 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-31 11:48:22,313 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-31 11:48:22,313 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-31 11:48:22,313 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-01-31 11:48:22,412 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-31 11:48:22,413 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-31 11:48:22,413 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test637807701887696278.junit.dir/version-2/snapshot.3
[junit] 2009-01-31 11:48:22,415 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 5
[junit] 2009-01-31 11:48:22,423 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:59895
[junit] 2009-01-31 11:48:22,424 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-31 11:48:22,424 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:59895]
[junit] 2009-01-31 11:48:23,640 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-31 11:48:23,641 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59896 remote=/127.0.0.1:33221]
[junit] 2009-01-31 11:48:23,641 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-31 11:48:23,641 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:59896 lastZxid 5
[junit] 2009-01-31 11:48:23,642 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f2c8410da0000 valid:true
[junit] 2009-01-31 11:48:23,642 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f2c8410da0000
[junit] 2009-01-31 11:48:23,659 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-01-31 11:48:23,660 - INFO [main:NIOServerCnxn@737] - closing session:0x11f2c8410da0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:59896]
[junit] 2009-01-31 11:48:23,660 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f2c8410da0000 to sun.nio.ch.SelectionKeyImpl@126d3df
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-01-31 11:48:23,662 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-31 11:48:23,662 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-31 11:48:23,662 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-01-31 11:48:23,662 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-31 11:48:23,761 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-01-31 11:48:23,761 - INFO [main:ZooKeeperServer@157] - Created server
[junit] 2009-01-31 11:48:23,762 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test637807701887696278.junit.dir/version-2/snapshot.5
[junit] 2009-01-31 11:48:23,768 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 6
[junit] 2009-01-31 11:48:23,792 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@609] - Processing stat command from /127.0.0.1:59898
[junit] 2009-01-31 11:48:23,792 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@407] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-31 11:48:23,792 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@737] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:59898]
[junit] 2009-01-31 11:48:24,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-31 11:48:24,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-31 11:48:25,252 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-01-31 11:48:25,252 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:59899 remote=/127.0.0.1:33221]
[junit] 2009-01-31 11:48:25,252 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-01-31 11:48:25,253 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@493] - Connected to /127.0.0.1:59899 lastZxid 6
[junit] 2009-01-31 11:48:25,254 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@865] - Finished init of 0x11f2c8410da0000 valid:true
[junit] 2009-01-31 11:48:25,254 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@521] - Renewing session 0x11f2c8410da0000
[junit] 2009-01-31 11:48:36,264 - INFO [main:ZooKeeper@434] - Closing session: 0x11f2c8410da0000
[junit] 2009-01-31 11:48:36,264 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x11f2c8410da0000
[junit] 2009-01-31 11:48:36,265 - INFO [ProcessThread:0:PrepRequestProcessor@360] - Processed session termination request for id: 0x11f2c8410da0000
[junit] 2009-01-31 11:48:36,265 - INFO [SyncThread:0:NIOServerCnxn@737] - closing session:0x11f2c8410da0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:59899]
[junit] 2009-01-31 11:48:36,268 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x11f2c8410da0000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-01-31 11:48:36,368 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x11f2c8410da0000
[junit] 2009-01-31 11:48:36,369 - INFO [main:ZooKeeper@442] - Session: 0x11f2c8410da0000 closed
[junit] 2009-01-31 11:48:36,369 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-01-31 11:48:36,369 - INFO [main:ClientBase@312] - tearDown starting
[junit] 2009-01-31 11:48:36,369 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@171] - NIOServerCnxn factory exited run method
[junit] 2009-01-31 11:48:36,370 - INFO [main:FinalRequestProcessor@265] - shutdown of request processor complete
[junit] 2009-01-31 11:48:36,370 - INFO [SyncThread:0:SyncRequestProcessor@117] - SyncRequestProcessor exited!
[junit] 2009-01-31 11:48:36,370 - INFO [ProcessThread:0:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-01-31 11:48:36,371 - INFO [main:ClientBase@322] - FINISHED testWatcherAutoResetDisabledWithLocal
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 125.538 sec
BUILD FAILED
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :554: Tests failed!
Total time: 8 minutes 31 seconds
Recording fingerprints
Publishing Javadoc
Recording test results