See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/204/changes
------------------------------------------
[...truncated 62537 lines...]
[junit] 2009-01-21 06:57:48,531 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-21 06:57:48,532 - INFO [main:nioserverc...@732] - closing
session:0x11ef7fae51e0000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44149]
[junit] 2009-01-21 06:57:48,533 - WARN
[main-SendThread:clientcnxn$sendthr...@881] - Exception closing session
0x11ef7fae51e0000 to sun.nio.ch.selectionkeyi...@1ba94d
[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:614)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:859)
[junit] 2009-01-21 06:57:48,533 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-21 06:57:48,533 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-21 06:57:48,533 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-21 06:57:48,533 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-21 06:57:48,633 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-21 06:57:48,633 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-21 06:57:48,635 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test9046005971203408691.junit.dir/version-2/snapshot.5
[junit] 2009-01-21 06:57:48,637 - INFO [main:filetxnsnap...@197] -
Snapshotting: 6
[junit] 2009-01-21 06:57:48,640 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:44151
[junit] 2009-01-21 06:57:48,640 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-21 06:57:48,641 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@732] - closing session:0x0
NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44151]
[junit] 2009-01-21 06:57:50,344 - INFO
[main-SendThread:clientcnxn$sendthr...@783] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-21 06:57:50,344 - INFO
[main-SendThread:clientcnxn$sendthr...@698] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:44152
remote=/127.0.0.1:33221]
[junit] 2009-01-21 06:57:50,344 - INFO
[main-SendThread:clientcnxn$sendthr...@851] - Server connection successful
[junit] 2009-01-21 06:57:50,345 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:44152
lastZxid 6
[junit] 2009-01-21 06:57:50,345 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11ef7fae51e0000 valid:true
[junit] 2009-01-21 06:57:50,345 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11ef7fae51e0000
[junit] 2009-01-21 06:57:51,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-21 06:57:51,364 - INFO [main:zookee...@418] - Closing
session: 0x11ef7fae51e0000
[junit] 2009-01-21 06:57:51,364 - INFO [main:clientc...@982] - Closing
ClientCnxn for session: 0x11ef7fae51e0000
[junit] 2009-01-21 06:57:51,365 - INFO
[ProcessThread:0:preprequestproces...@344] - Processed session termination
request for id: 0x11ef7fae51e0000
[junit] 2009-01-21 06:57:51,365 - INFO [SyncThread:0:nioserverc...@732] -
closing session:0x11ef7fae51e0000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44152]
[junit] 2009-01-21 06:57:51,366 - INFO
[main-SendThread:clientcnxn$sendthr...@875] - Exception while closing send
thread for session 0x11ef7fae51e0000 : Read error rc = -1
java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-01-21 06:57:51,466 - INFO [main:clientc...@968] -
Disconnecting ClientCnxn for session: 0x11ef7fae51e0000
[junit] 2009-01-21 06:57:51,466 - INFO
[main-EventThread:clientcnxn$eventthr...@435] - EventThread shut down
[junit] 2009-01-21 06:57:51,467 - INFO [main:zookee...@426] - Session:
0x11ef7fae51e0000 closed
[junit] 2009-01-21 06:57:51,467 - INFO [main:clientb...@312] - tearDown
starting
[junit] 2009-01-21 06:57:51,467 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-21 06:57:51,468 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-21 06:57:51,468 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-21 06:57:51,468 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-21 06:57:51,470 - INFO [main:clientb...@322] - FINISHED
testWatcherAutoResetWithLocal
[junit] 2009-01-21 06:57:51,470 - INFO [main:clientb...@288] - STARTING
testWatcherAutoResetDisabledWithGlobal
[junit] 2009-01-21 06:57:51,471 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-21 06:57:51,471 - INFO [main:filetxnsnap...@197] -
Snapshotting: 0
[junit] 2009-01-21 06:57:51,473 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:44154
[junit] 2009-01-21 06:57:51,473 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-21 06:57:51,473 - INFO [main:clientb...@296] - Client test
setup finished
[junit] 2009-01-21 06:57:51,474 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@732] - closing session:0x0
NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44154]
[junit] 2009-01-21 06:57:51,474 - INFO [main:zookee...@324] - Initiating
client connection, host=127.0.0.1:33221 sessionTimeout=9000
watcher=org.apache.zookeeper.test.watchertest$mywatc...@149105b
[junit] 2009-01-21 06:57:51,475 - INFO
[main-SendThread:clientcnxn$sendthr...@783] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-21 06:57:51,475 - INFO
[main-SendThread:clientcnxn$sendthr...@698] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:44155
remote=/127.0.0.1:33221]
[junit] 2009-01-21 06:57:51,475 - INFO
[main-SendThread:clientcnxn$sendthr...@851] - Server connection successful
[junit] 2009-01-21 06:57:51,476 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:44155
lastZxid 0
[junit] 2009-01-21 06:57:51,476 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@519] - Creating new session
0x11ef7fb0b700000
[junit] 2009-01-21 06:57:51,482 - INFO [SyncThread:0:nioserverc...@860] -
Finished init of 0x11ef7fb0b700000 valid:true
[junit] 2009-01-21 06:57:51,487 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-21 06:57:51,488 - INFO [main:nioserverc...@732] - closing
session:0x11ef7fb0b700000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44155]
[junit] 2009-01-21 06:57:51,488 - WARN
[main-SendThread:clientcnxn$sendthr...@881] - Exception closing session
0x11ef7fb0b700000 to sun.nio.ch.selectionkeyi...@196f4b5
[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:614)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:859)
[junit] 2009-01-21 06:57:51,489 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-21 06:57:51,489 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-21 06:57:51,489 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-21 06:57:51,489 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-21 06:57:51,589 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-21 06:57:51,589 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-21 06:57:51,590 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test9192105909817864477.junit.dir/version-2/snapshot.0
[junit] 2009-01-21 06:57:51,591 - INFO [main:filetxnsnap...@197] -
Snapshotting: 3
[junit] 2009-01-21 06:57:51,593 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:44157
[junit] 2009-01-21 06:57:51,593 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-21 06:57:51,594 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@732] - closing session:0x0
NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44157]
[junit] 2009-01-21 06:57:52,723 - INFO
[main-SendThread:clientcnxn$sendthr...@783] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-21 06:57:52,723 - INFO
[main-SendThread:clientcnxn$sendthr...@698] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:44158
remote=/127.0.0.1:33221]
[junit] 2009-01-21 06:57:52,723 - INFO
[main-SendThread:clientcnxn$sendthr...@851] - Server connection successful
[junit] 2009-01-21 06:57:52,724 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:44158
lastZxid 3
[junit] 2009-01-21 06:57:52,724 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11ef7fb0b700000 valid:true
[junit] 2009-01-21 06:57:52,724 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11ef7fb0b700000
[junit] 2009-01-21 06:57:54,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-21 06:57:54,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-21 06:58:26,732 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-21 06:58:26,733 - INFO [main:nioserverc...@732] - closing
session:0x11ef7fb0b700000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44158]
[junit] 2009-01-21 06:58:26,734 - WARN
[main-SendThread:clientcnxn$sendthr...@881] - Exception closing session
0x11ef7fb0b700000 to sun.nio.ch.selectionkeyi...@a2220f
[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:614)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:859)
[junit] 2009-01-21 06:58:26,735 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-21 06:58:26,735 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-21 06:58:26,735 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-21 06:58:26,735 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-21 06:58:26,834 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-21 06:58:26,835 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-21 06:58:26,836 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test9192105909817864477.junit.dir/version-2/snapshot.3
[junit] 2009-01-21 06:58:26,837 - INFO [main:filetxnsnap...@197] -
Snapshotting: 5
[junit] 2009-01-21 06:58:26,839 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:44160
[junit] 2009-01-21 06:58:26,849 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-21 06:58:26,849 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@732] - closing session:0x0
NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44160]
[junit] 2009-01-21 06:58:27,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-21 06:58:28,637 - INFO
[main-SendThread:clientcnxn$sendthr...@783] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-21 06:58:28,638 - INFO
[main-SendThread:clientcnxn$sendthr...@698] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161
remote=/127.0.0.1:33221]
[junit] 2009-01-21 06:58:28,638 - INFO
[main-SendThread:clientcnxn$sendthr...@851] - Server connection successful
[junit] 2009-01-21 06:58:28,638 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:44161
lastZxid 5
[junit] 2009-01-21 06:58:28,639 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11ef7fb0b700000 valid:true
[junit] 2009-01-21 06:58:28,639 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11ef7fb0b700000
[junit] 2009-01-21 06:58:28,651 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-21 06:58:28,652 - INFO [main:nioserverc...@732] - closing
session:0x11ef7fb0b700000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44161]
[junit] 2009-01-21 06:58:28,653 - WARN
[main-SendThread:clientcnxn$sendthr...@881] - Exception closing session
0x11ef7fb0b700000 to sun.nio.ch.selectionkeyi...@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:614)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:859)
[junit] 2009-01-21 06:58:28,653 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-21 06:58:28,653 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-21 06:58:28,653 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-21 06:58:28,655 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-21 06:58:28,753 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-21 06:58:28,754 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-21 06:58:28,755 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test9192105909817864477.junit.dir/version-2/snapshot.5
[junit] 2009-01-21 06:58:28,757 - INFO [main:filetxnsnap...@197] -
Snapshotting: 6
[junit] 2009-01-21 06:58:28,759 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:44163
[junit] 2009-01-21 06:58:28,759 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-21 06:58:28,759 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@732] - closing session:0x0
NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44163]
[junit] 2009-01-21 06:58:30,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-21 06:58:30,316 - INFO
[main-SendThread:clientcnxn$sendthr...@783] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-21 06:58:30,316 - INFO
[main-SendThread:clientcnxn$sendthr...@698] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:44164
remote=/127.0.0.1:33221]
[junit] 2009-01-21 06:58:30,317 - INFO
[main-SendThread:clientcnxn$sendthr...@851] - Server connection successful
[junit] 2009-01-21 06:58:30,317 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:44164
lastZxid 6
[junit] 2009-01-21 06:58:30,318 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11ef7fb0b700000 valid:true
[junit] 2009-01-21 06:58:30,318 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11ef7fb0b700000
[junit] 2009-01-21 06:58:41,332 - INFO [main:zookee...@418] - Closing
session: 0x11ef7fb0b700000
[junit] 2009-01-21 06:58:41,332 - INFO [main:clientc...@982] - Closing
ClientCnxn for session: 0x11ef7fb0b700000
[junit] 2009-01-21 06:58:41,333 - INFO
[ProcessThread:0:preprequestproces...@344] - Processed session termination
request for id: 0x11ef7fb0b700000
[junit] 2009-01-21 06:58:41,334 - INFO [SyncThread:0:nioserverc...@732] -
closing session:0x11ef7fb0b700000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44164]
[junit] 2009-01-21 06:58:41,334 - INFO
[main-SendThread:clientcnxn$sendthr...@875] - Exception while closing send
thread for session 0x11ef7fb0b700000 : Read error rc = -1
java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-01-21 06:58:41,434 - INFO [main:clientc...@968] -
Disconnecting ClientCnxn for session: 0x11ef7fb0b700000
[junit] 2009-01-21 06:58:41,435 - INFO [main:zookee...@426] - Session:
0x11ef7fb0b700000 closed
[junit] 2009-01-21 06:58:41,435 - INFO
[main-EventThread:clientcnxn$eventthr...@435] - EventThread shut down
[junit] 2009-01-21 06:58:41,435 - INFO [main:clientb...@312] - tearDown
starting
[junit] 2009-01-21 06:58:41,436 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-21 06:58:41,436 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-21 06:58:41,436 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-21 06:58:41,436 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-21 06:58:41,438 - INFO [main:clientb...@322] - FINISHED
testWatcherAutoResetDisabledWithGlobal
[junit] 2009-01-21 06:58:41,439 - INFO [main:clientb...@288] - STARTING
testWatcherAutoResetDisabledWithLocal
[junit] 2009-01-21 06:58:41,439 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-21 06:58:41,440 - INFO [main:filetxnsnap...@197] -
Snapshotting: 0
[junit] 2009-01-21 06:58:41,442 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:44166
[junit] 2009-01-21 06:58:41,442 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-21 06:58:41,442 - INFO [main:clientb...@296] - Client test
setup finished
[junit] 2009-01-21 06:58:41,443 - INFO [main:zookee...@324] - Initiating
client connection, host=127.0.0.1:33221 sessionTimeout=9000
watcher=org.apache.zookeeper.test.watchertest$mywatc...@93df2c
[junit] 2009-01-21 06:58:41,442 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@732] - closing session:0x0
NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44166]
[junit] 2009-01-21 06:58:41,443 - INFO
[main-SendThread:clientcnxn$sendthr...@783] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-21 06:58:41,444 - INFO
[main-SendThread:clientcnxn$sendthr...@698] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:44167
remote=/127.0.0.1:33221]
[junit] 2009-01-21 06:58:41,444 - INFO
[main-SendThread:clientcnxn$sendthr...@851] - Server connection successful
[junit] 2009-01-21 06:58:41,445 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:44167
lastZxid 0
[junit] 2009-01-21 06:58:41,445 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@519] - Creating new session
0x11ef7fbcea00000
[junit] 2009-01-21 06:58:41,451 - INFO [SyncThread:0:nioserverc...@860] -
Finished init of 0x11ef7fbcea00000 valid:true
[junit] 2009-01-21 06:58:41,456 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-21 06:58:41,457 - INFO [main:nioserverc...@732] - closing
session:0x11ef7fbcea00000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44167]
[junit] 2009-01-21 06:58:41,458 - WARN
[main-SendThread:clientcnxn$sendthr...@881] - Exception closing session
0x11ef7fbcea00000 to sun.nio.ch.selectionkeyi...@3a1834
[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:614)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:859)
[junit] 2009-01-21 06:58:41,458 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-21 06:58:41,459 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-21 06:58:41,459 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-21 06:58:41,459 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-21 06:58:41,558 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-21 06:58:41,559 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-21 06:58:41,560 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test4796976992591777933.junit.dir/version-2/snapshot.0
[junit] 2009-01-21 06:58:41,561 - INFO [main:filetxnsnap...@197] -
Snapshotting: 3
[junit] 2009-01-21 06:58:41,563 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:44169
[junit] 2009-01-21 06:58:41,563 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-21 06:58:41,564 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@732] - closing session:0x0
NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44169]
[junit] 2009-01-21 06:58:42,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-21 06:58:42,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-21 06:58:42,764 - INFO
[main-SendThread:clientcnxn$sendthr...@783] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-21 06:58:42,764 - INFO
[main-SendThread:clientcnxn$sendthr...@698] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:44170
remote=/127.0.0.1:33221]
[junit] 2009-01-21 06:58:42,764 - INFO
[main-SendThread:clientcnxn$sendthr...@851] - Server connection successful
[junit] 2009-01-21 06:58:42,765 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:44170
lastZxid 3
[junit] 2009-01-21 06:58:42,765 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11ef7fbcea00000 valid:true
[junit] 2009-01-21 06:58:42,765 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11ef7fbcea00000
[junit] 2009-01-21 06:59:16,773 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-21 06:59:16,774 - INFO [main:nioserverc...@732] - closing
session:0x11ef7fbcea00000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44170]
[junit] 2009-01-21 06:59:16,774 - WARN
[main-SendThread:clientcnxn$sendthr...@881] - Exception closing session
0x11ef7fbcea00000 to sun.nio.ch.selectionkeyi...@1f31652
[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:614)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:859)
[junit] 2009-01-21 06:59:16,808 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-21 06:59:16,810 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-21 06:59:16,810 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-21 06:59:16,810 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-21 06:59:16,910 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-21 06:59:16,910 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-21 06:59:16,923 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test4796976992591777933.junit.dir/version-2/snapshot.3
[junit] 2009-01-21 06:59:16,927 - INFO [main:filetxnsnap...@197] -
Snapshotting: 5
[junit] 2009-01-21 06:59:16,929 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:44172
[junit] 2009-01-21 06:59:16,929 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-21 06:59:16,930 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@732] - closing session:0x0
NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44172]
[junit] 2009-01-21 06:59:17,911 - INFO
[main-SendThread:clientcnxn$sendthr...@783] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-21 06:59:17,911 - INFO
[main-SendThread:clientcnxn$sendthr...@698] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:44173
remote=/127.0.0.1:33221]
[junit] 2009-01-21 06:59:17,911 - INFO
[main-SendThread:clientcnxn$sendthr...@851] - Server connection successful
[junit] 2009-01-21 06:59:17,911 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:44173
lastZxid 5
[junit] 2009-01-21 06:59:17,912 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11ef7fbcea00000 valid:true
[junit] 2009-01-21 06:59:17,912 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11ef7fbcea00000
[junit] 2009-01-21 06:59:17,932 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-21 06:59:17,933 - INFO [main:nioserverc...@732] - closing
session:0x11ef7fbcea00000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44173]
[junit] 2009-01-21 06:59:17,933 - WARN
[main-SendThread:clientcnxn$sendthr...@881] - Exception closing session
0x11ef7fbcea00000 to sun.nio.ch.selectionkeyi...@1a5db4b
[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:614)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:859)
[junit] 2009-01-21 06:59:17,933 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-21 06:59:17,934 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-21 06:59:17,934 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-21 06:59:17,934 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-21 06:59:18,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-21 06:59:18,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-21 06:59:18,034 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-21 06:59:18,034 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-21 06:59:18,035 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test4796976992591777933.junit.dir/version-2/snapshot.5
[junit] 2009-01-21 06:59:18,037 - INFO [main:filetxnsnap...@197] -
Snapshotting: 6
[junit] 2009-01-21 06:59:18,039 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:44175
[junit] 2009-01-21 06:59:18,039 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-21 06:59:18,040 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@732] - closing session:0x0
NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44175]
[junit] 2009-01-21 06:59:19,924 - INFO
[main-SendThread:clientcnxn$sendthr...@783] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-21 06:59:19,924 - INFO
[main-SendThread:clientcnxn$sendthr...@698] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:44176
remote=/127.0.0.1:33221]
[junit] 2009-01-21 06:59:19,924 - INFO
[main-SendThread:clientcnxn$sendthr...@851] - Server connection successful
[junit] 2009-01-21 06:59:19,924 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:44176
lastZxid 6
[junit] 2009-01-21 06:59:19,925 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11ef7fbcea00000 valid:true
[junit] 2009-01-21 06:59:19,925 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11ef7fbcea00000
[junit] 2009-01-21 06:59:30,934 - INFO [main:zookee...@418] - Closing
session: 0x11ef7fbcea00000
[junit] 2009-01-21 06:59:30,934 - INFO [main:clientc...@982] - Closing
ClientCnxn for session: 0x11ef7fbcea00000
[junit] 2009-01-21 06:59:30,934 - INFO
[ProcessThread:0:preprequestproces...@344] - Processed session termination
request for id: 0x11ef7fbcea00000
[junit] 2009-01-21 06:59:30,935 - INFO [SyncThread:0:nioserverc...@732] -
closing session:0x11ef7fbcea00000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:44176]
[junit] 2009-01-21 06:59:30,935 - INFO
[main-SendThread:clientcnxn$sendthr...@875] - Exception while closing send
thread for session 0x11ef7fbcea00000 : Read error rc = -1
java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-01-21 06:59:31,036 - INFO [main:clientc...@968] -
Disconnecting ClientCnxn for session: 0x11ef7fbcea00000
[junit] 2009-01-21 06:59:31,036 - INFO [main:zookee...@426] - Session:
0x11ef7fbcea00000 closed
[junit] 2009-01-21 06:59:31,036 - INFO
[main-EventThread:clientcnxn$eventthr...@435] - EventThread shut down
[junit] 2009-01-21 06:59:31,036 - INFO [main:clientb...@312] - tearDown
starting
[junit] 2009-01-21 06:59:31,037 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-21 06:59:31,037 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-21 06:59:31,037 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-21 06:59:31,039 - INFO [main:clientb...@322] - FINISHED
testWatcherAutoResetDisabledWithLocal
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 124.482 sec
[junit] 2009-01-21 06:59:31,037 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
BUILD FAILED
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml
:547: Tests failed!
Total time: 7 minutes 44 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
