See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/213/changes
------------------------------------------
[...truncated 62500 lines...]
[junit] 2009-01-29 11:43:48,322 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-29 11:43:48,322 - INFO [main:nioserverc...@732] - closing
session:0x11f223397400000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:46688]
[junit] 2009-01-29 11:43:48,323 - WARN
[main-SendThread:clientcnxn$sendthr...@895] - Exception closing session
0x11f223397400000 to sun.nio.ch.selectionkeyi...@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:628)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:873)
[junit] 2009-01-29 11:43:48,323 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-29 11:43:48,323 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-29 11:43:48,323 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-29 11:43:48,323 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-29 11:43:48,423 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-29 11:43:48,424 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-29 11:43:48,425 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test4650600035400512335.junit.dir/version-2/snapshot.5
[junit] 2009-01-29 11:43:48,427 - INFO [main:filetxnsnap...@197] -
Snapshotting: 6
[junit] 2009-01-29 11:43:48,429 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:46690
[junit] 2009-01-29 11:43:48,430 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-29 11:43:48,430 - 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:46690]
[junit] 2009-01-29 11:43:50,123 - INFO
[main-SendThread:clientcnxn$sendthr...@797] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-29 11:43:50,124 - INFO
[main-SendThread:clientcnxn$sendthr...@712] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:46691
remote=/127.0.0.1:33221]
[junit] 2009-01-29 11:43:50,124 - INFO
[main-SendThread:clientcnxn$sendthr...@865] - Server connection successful
[junit] 2009-01-29 11:43:50,124 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:46691
lastZxid 6
[junit] 2009-01-29 11:43:50,125 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11f223397400000 valid:true
[junit] 2009-01-29 11:43:50,125 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11f223397400000
[junit] 2009-01-29 11:43:51,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-29 11:43:51,132 - INFO [main:zookee...@434] - Closing
session: 0x11f223397400000
[junit] 2009-01-29 11:43:51,132 - INFO [main:clientc...@996] - Closing
ClientCnxn for session: 0x11f223397400000
[junit] 2009-01-29 11:43:51,133 - INFO
[ProcessThread:0:preprequestproces...@344] - Processed session termination
request for id: 0x11f223397400000
[junit] 2009-01-29 11:43:51,134 - INFO [SyncThread:0:nioserverc...@732] -
closing session:0x11f223397400000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:46691]
[junit] 2009-01-29 11:43:51,134 - INFO
[main-SendThread:clientcnxn$sendthr...@889] - Exception while closing send
thread for session 0x11f223397400000 : Read error rc = -1
java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-01-29 11:43:51,234 - INFO [main:clientc...@982] -
Disconnecting ClientCnxn for session: 0x11f223397400000
[junit] 2009-01-29 11:43:51,234 - INFO [main:zookee...@442] - Session:
0x11f223397400000 closed
[junit] 2009-01-29 11:43:51,234 - INFO
[main-EventThread:clientcnxn$eventthr...@449] - EventThread shut down
[junit] 2009-01-29 11:43:51,235 - INFO [main:clientb...@312] - tearDown
starting
[junit] 2009-01-29 11:43:51,235 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-29 11:43:51,235 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-29 11:43:51,235 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-29 11:43:51,236 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-29 11:43:51,237 - INFO [main:clientb...@322] - FINISHED
testWatcherAutoResetWithLocal
[junit] 2009-01-29 11:43:51,238 - INFO [main:clientb...@288] - STARTING
testWatcherAutoResetDisabledWithGlobal
[junit] 2009-01-29 11:43:51,238 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-29 11:43:51,239 - INFO [main:filetxnsnap...@197] -
Snapshotting: 0
[junit] 2009-01-29 11:43:51,241 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:46693
[junit] 2009-01-29 11:43:51,241 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-29 11:43:51,241 - INFO [main:clientb...@296] - Client test
setup finished
[junit] 2009-01-29 11:43:51,242 - INFO [main:zookee...@341] - Initiating
client connection, host=127.0.0.1:33221 sessionTimeout=9000
watcher=org.apache.zookeeper.test.watchertest$mywatc...@27982
[junit] 2009-01-29 11:43:51,241 - 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:46693]
[junit] 2009-01-29 11:43:51,242 - INFO
[main-SendThread:clientcnxn$sendthr...@797] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-29 11:43:51,243 - INFO
[main-SendThread:clientcnxn$sendthr...@712] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:46694
remote=/127.0.0.1:33221]
[junit] 2009-01-29 11:43:51,243 - INFO
[main-SendThread:clientcnxn$sendthr...@865] - Server connection successful
[junit] 2009-01-29 11:43:51,243 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:46694
lastZxid 0
[junit] 2009-01-29 11:43:51,243 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@519] - Creating new session
0x11f2233c1c70000
[junit] 2009-01-29 11:43:51,251 - INFO [SyncThread:0:nioserverc...@860] -
Finished init of 0x11f2233c1c70000 valid:true
[junit] 2009-01-29 11:43:51,257 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-29 11:43:51,258 - INFO [main:nioserverc...@732] - closing
session:0x11f2233c1c70000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:46694]
[junit] 2009-01-29 11:43:51,258 - WARN
[main-SendThread:clientcnxn$sendthr...@895] - Exception closing session
0x11f2233c1c70000 to sun.nio.ch.selectionkeyi...@d58939
[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:628)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:873)
[junit] 2009-01-29 11:43:51,258 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-29 11:43:51,259 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-29 11:43:51,259 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-29 11:43:51,259 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-29 11:43:51,358 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-29 11:43:51,359 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-29 11:43:51,360 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test2405873259289803074.junit.dir/version-2/snapshot.0
[junit] 2009-01-29 11:43:51,361 - INFO [main:filetxnsnap...@197] -
Snapshotting: 3
[junit] 2009-01-29 11:43:51,362 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:46696
[junit] 2009-01-29 11:43:51,363 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-29 11:43:51,363 - 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:46696]
[junit] 2009-01-29 11:43:53,126 - INFO
[main-SendThread:clientcnxn$sendthr...@797] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-29 11:43:53,127 - INFO
[main-SendThread:clientcnxn$sendthr...@712] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:46697
remote=/127.0.0.1:33221]
[junit] 2009-01-29 11:43:53,127 - INFO
[main-SendThread:clientcnxn$sendthr...@865] - Server connection successful
[junit] 2009-01-29 11:43:53,127 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:46697
lastZxid 3
[junit] 2009-01-29 11:43:53,128 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11f2233c1c70000 valid:true
[junit] 2009-01-29 11:43:53,128 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11f2233c1c70000
[junit] 2009-01-29 11:43:54,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-29 11:43:54,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-29 11:44:27,143 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-29 11:44:27,144 - INFO [main:nioserverc...@732] - closing
session:0x11f2233c1c70000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:46697]
[junit] 2009-01-29 11:44:27,144 - WARN
[main-SendThread:clientcnxn$sendthr...@895] - Exception closing session
0x11f2233c1c70000 to sun.nio.ch.selectionkeyi...@1264eab
[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:628)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:873)
[junit] 2009-01-29 11:44:27,145 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-29 11:44:27,145 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-29 11:44:27,145 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-29 11:44:27,145 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-29 11:44:27,245 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-29 11:44:27,245 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-29 11:44:27,246 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test2405873259289803074.junit.dir/version-2/snapshot.3
[junit] 2009-01-29 11:44:27,248 - INFO [main:filetxnsnap...@197] -
Snapshotting: 5
[junit] 2009-01-29 11:44:27,250 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:46699
[junit] 2009-01-29 11:44:27,260 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-29 11:44:27,260 - 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:46699]
[junit] 2009-01-29 11:44:29,069 - INFO
[main-SendThread:clientcnxn$sendthr...@797] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-29 11:44:29,069 - INFO
[main-SendThread:clientcnxn$sendthr...@712] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:46700
remote=/127.0.0.1:33221]
[junit] 2009-01-29 11:44:29,069 - INFO
[main-SendThread:clientcnxn$sendthr...@865] - Server connection successful
[junit] 2009-01-29 11:44:29,070 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:46700
lastZxid 5
[junit] 2009-01-29 11:44:29,070 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11f2233c1c70000 valid:true
[junit] 2009-01-29 11:44:29,070 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11f2233c1c70000
[junit] 2009-01-29 11:44:29,081 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-29 11:44:29,081 - INFO [main:nioserverc...@732] - closing
session:0x11f2233c1c70000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:46700]
[junit] 2009-01-29 11:44:29,082 - WARN
[main-SendThread:clientcnxn$sendthr...@895] - Exception closing session
0x11f2233c1c70000 to sun.nio.ch.selectionkeyi...@12f1bf0
[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:628)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:873)
[junit] 2009-01-29 11:44:29,083 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-29 11:44:29,083 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-29 11:44:29,083 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-29 11:44:29,083 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-29 11:44:29,182 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-29 11:44:29,183 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-29 11:44:29,184 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test2405873259289803074.junit.dir/version-2/snapshot.5
[junit] 2009-01-29 11:44:29,186 - INFO [main:filetxnsnap...@197] -
Snapshotting: 6
[junit] 2009-01-29 11:44:29,188 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:46702
[junit] 2009-01-29 11:44:29,188 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-29 11:44:29,189 - 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:46702]
[junit] 2009-01-29 11:44:30,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-29 11:44:30,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-29 11:44:30,211 - INFO
[main-SendThread:clientcnxn$sendthr...@797] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-29 11:44:30,212 - INFO
[main-SendThread:clientcnxn$sendthr...@712] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:46703
remote=/127.0.0.1:33221]
[junit] 2009-01-29 11:44:30,212 - INFO
[main-SendThread:clientcnxn$sendthr...@865] - Server connection successful
[junit] 2009-01-29 11:44:30,212 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:46703
lastZxid 6
[junit] 2009-01-29 11:44:30,213 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11f2233c1c70000 valid:true
[junit] 2009-01-29 11:44:30,213 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11f2233c1c70000
[junit] 2009-01-29 11:44:41,232 - INFO [main:zookee...@434] - Closing
session: 0x11f2233c1c70000
[junit] 2009-01-29 11:44:41,233 - INFO [main:clientc...@996] - Closing
ClientCnxn for session: 0x11f2233c1c70000
[junit] 2009-01-29 11:44:41,233 - INFO
[ProcessThread:0:preprequestproces...@344] - Processed session termination
request for id: 0x11f2233c1c70000
[junit] 2009-01-29 11:44:41,234 - INFO [SyncThread:0:nioserverc...@732] -
closing session:0x11f2233c1c70000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:46703]
[junit] 2009-01-29 11:44:41,235 - INFO
[main-SendThread:clientcnxn$sendthr...@889] - Exception while closing send
thread for session 0x11f2233c1c70000 : Read error rc = -1
java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-01-29 11:44:41,335 - INFO [main:clientc...@982] -
Disconnecting ClientCnxn for session: 0x11f2233c1c70000
[junit] 2009-01-29 11:44:41,335 - INFO [main:zookee...@442] - Session:
0x11f2233c1c70000 closed
[junit] 2009-01-29 11:44:41,335 - INFO
[main-EventThread:clientcnxn$eventthr...@449] - EventThread shut down
[junit] 2009-01-29 11:44:41,335 - INFO [main:clientb...@312] - tearDown
starting
[junit] 2009-01-29 11:44:41,336 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-29 11:44:41,336 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-29 11:44:41,336 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-29 11:44:41,336 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-29 11:44:41,338 - INFO [main:clientb...@322] - FINISHED
testWatcherAutoResetDisabledWithGlobal
[junit] 2009-01-29 11:44:41,339 - INFO [main:clientb...@288] - STARTING
testWatcherAutoResetDisabledWithLocal
[junit] 2009-01-29 11:44:41,339 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-29 11:44:41,340 - INFO [main:filetxnsnap...@197] -
Snapshotting: 0
[junit] 2009-01-29 11:44:41,342 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:46705
[junit] 2009-01-29 11:44:41,342 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-29 11:44:41,342 - INFO [main:clientb...@296] - Client test
setup finished
[junit] 2009-01-29 11:44:41,343 - INFO [main:zookee...@341] - Initiating
client connection, host=127.0.0.1:33221 sessionTimeout=9000
watcher=org.apache.zookeeper.test.watchertest$mywatc...@5c3987
[junit] 2009-01-29 11:44:41,342 - 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:46705]
[junit] 2009-01-29 11:44:41,343 - INFO
[main-SendThread:clientcnxn$sendthr...@797] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-29 11:44:41,344 - INFO
[main-SendThread:clientcnxn$sendthr...@712] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:46706
remote=/127.0.0.1:33221]
[junit] 2009-01-29 11:44:41,344 - INFO
[main-SendThread:clientcnxn$sendthr...@865] - Server connection successful
[junit] 2009-01-29 11:44:41,344 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:46706
lastZxid 0
[junit] 2009-01-29 11:44:41,344 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@519] - Creating new session
0x11f2234857c0000
[junit] 2009-01-29 11:44:41,351 - INFO [SyncThread:0:nioserverc...@860] -
Finished init of 0x11f2234857c0000 valid:true
[junit] 2009-01-29 11:44:41,356 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-29 11:44:41,357 - INFO [main:nioserverc...@732] - closing
session:0x11f2234857c0000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:46706]
[junit] 2009-01-29 11:44:41,358 - WARN
[main-SendThread:clientcnxn$sendthr...@895] - Exception closing session
0x11f2234857c0000 to sun.nio.ch.selectionkeyi...@19fe451
[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:628)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:873)
[junit] 2009-01-29 11:44:41,358 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-29 11:44:41,358 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-29 11:44:41,358 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-29 11:44:41,358 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-29 11:44:41,458 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-29 11:44:41,458 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-29 11:44:41,459 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test9100355569859262399.junit.dir/version-2/snapshot.0
[junit] 2009-01-29 11:44:41,460 - INFO [main:filetxnsnap...@197] -
Snapshotting: 3
[junit] 2009-01-29 11:44:41,462 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:46708
[junit] 2009-01-29 11:44:41,463 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-29 11:44:41,463 - 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:46708]
[junit] 2009-01-29 11:44:42,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-29 11:44:42,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-29 11:44:42,540 - INFO
[main-SendThread:clientcnxn$sendthr...@797] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-29 11:44:42,540 - INFO
[main-SendThread:clientcnxn$sendthr...@712] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:46709
remote=/127.0.0.1:33221]
[junit] 2009-01-29 11:44:42,541 - INFO
[main-SendThread:clientcnxn$sendthr...@865] - Server connection successful
[junit] 2009-01-29 11:44:42,541 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:46709
lastZxid 3
[junit] 2009-01-29 11:44:42,542 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11f2234857c0000 valid:true
[junit] 2009-01-29 11:44:42,542 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11f2234857c0000
[junit] 2009-01-29 11:45:16,562 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-29 11:45:16,563 - INFO [main:nioserverc...@732] - closing
session:0x11f2234857c0000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:46709]
[junit] 2009-01-29 11:45:16,564 - WARN
[main-SendThread:clientcnxn$sendthr...@895] - Exception closing session
0x11f2234857c0000 to sun.nio.ch.selectionkeyi...@1be2893
[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:628)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:873)
[junit] 2009-01-29 11:45:16,572 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-29 11:45:16,572 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-29 11:45:16,572 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-29 11:45:16,572 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-29 11:45:16,664 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-29 11:45:16,665 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-29 11:45:16,666 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test9100355569859262399.junit.dir/version-2/snapshot.3
[junit] 2009-01-29 11:45:16,672 - INFO [main:filetxnsnap...@197] -
Snapshotting: 5
[junit] 2009-01-29 11:45:16,676 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:46711
[junit] 2009-01-29 11:45:16,676 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-29 11:45:16,677 - 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:46711]
[junit] 2009-01-29 11:45:17,922 - INFO
[main-SendThread:clientcnxn$sendthr...@797] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-29 11:45:17,923 - INFO
[main-SendThread:clientcnxn$sendthr...@712] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:46712
remote=/127.0.0.1:33221]
[junit] 2009-01-29 11:45:17,923 - INFO
[main-SendThread:clientcnxn$sendthr...@865] - Server connection successful
[junit] 2009-01-29 11:45:17,923 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:46712
lastZxid 5
[junit] 2009-01-29 11:45:17,924 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11f2234857c0000 valid:true
[junit] 2009-01-29 11:45:17,924 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11f2234857c0000
[junit] 2009-01-29 11:45:17,941 - INFO [main:clientb...@300] - STOPPING
server
[junit] 2009-01-29 11:45:17,942 - INFO [main:nioserverc...@732] - closing
session:0x11f2234857c0000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:46712]
[junit] 2009-01-29 11:45:17,942 - WARN
[main-SendThread:clientcnxn$sendthr...@895] - Exception closing session
0x11f2234857c0000 to sun.nio.ch.selectionkeyi...@b6d6ab
[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:628)
[junit] at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:873)
[junit] 2009-01-29 11:45:17,942 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-29 11:45:17,943 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-29 11:45:17,943 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-29 11:45:17,943 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-29 11:45:18,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-29 11:45:18,000 - INFO
[SessionTracker:sessiontrackeri...@142] - SessionTrackerImpl exited loop!
[junit] 2009-01-29 11:45:18,042 - INFO [main:clientb...@306] - STARTING
server
[junit] 2009-01-29 11:45:18,043 - INFO [main:zookeeperser...@157] -
Created server
[junit] 2009-01-29 11:45:18,044 - INFO [main:files...@70] - Reading
snapshot
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test9100355569859262399.junit.dir/version-2/snapshot.5
[junit] 2009-01-29 11:45:18,046 - INFO [main:filetxnsnap...@197] -
Snapshotting: 6
[junit] 2009-01-29 11:45:18,047 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@604] - Processing stat command from
/127.0.0.1:46714
[junit] 2009-01-29 11:45:18,048 - WARN
[NIOServerCxn.Factory:33221:nioserverc...@402] - Exception causing close of
session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-01-29 11:45:18,048 - 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:46714]
[junit] 2009-01-29 11:45:19,697 - INFO
[main-SendThread:clientcnxn$sendthr...@797] - Attempting connection to server
/127.0.0.1:33221
[junit] 2009-01-29 11:45:19,698 - INFO
[main-SendThread:clientcnxn$sendthr...@712] - Priming connection to
java.nio.channels.SocketChannel[connected local=/127.0.0.1:46715
remote=/127.0.0.1:33221]
[junit] 2009-01-29 11:45:19,698 - INFO
[main-SendThread:clientcnxn$sendthr...@865] - Server connection successful
[junit] 2009-01-29 11:45:19,698 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@488] - Connected to /127.0.0.1:46715
lastZxid 6
[junit] 2009-01-29 11:45:19,698 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@860] - Finished init of
0x11f2234857c0000 valid:true
[junit] 2009-01-29 11:45:19,699 - INFO
[NIOServerCxn.Factory:33221:nioserverc...@516] - Renewing session
0x11f2234857c0000
[junit] 2009-01-29 11:45:30,712 - INFO [main:zookee...@434] - Closing
session: 0x11f2234857c0000
[junit] 2009-01-29 11:45:30,712 - INFO [main:clientc...@996] - Closing
ClientCnxn for session: 0x11f2234857c0000
[junit] 2009-01-29 11:45:30,713 - INFO
[ProcessThread:0:preprequestproces...@344] - Processed session termination
request for id: 0x11f2234857c0000
[junit] 2009-01-29 11:45:30,715 - INFO [SyncThread:0:nioserverc...@732] -
closing session:0x11f2234857c0000 NIOServerCnxn:
java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221
remote=/127.0.0.1:46715]
[junit] 2009-01-29 11:45:30,715 - INFO
[main-SendThread:clientcnxn$sendthr...@889] - Exception while closing send
thread for session 0x11f2234857c0000 : Read error rc = -1
java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-01-29 11:45:30,815 - INFO [main:clientc...@982] -
Disconnecting ClientCnxn for session: 0x11f2234857c0000
[junit] 2009-01-29 11:45:30,815 - INFO [main:zookee...@442] - Session:
0x11f2234857c0000 closed
[junit] 2009-01-29 11:45:30,815 - INFO
[main-EventThread:clientcnxn$eventthr...@449] - EventThread shut down
[junit] 2009-01-29 11:45:30,815 - INFO [main:clientb...@312] - tearDown
starting
[junit] 2009-01-29 11:45:30,816 - INFO
[NIOServerCxn.Factory:33221:nioservercnxn$fact...@171] - NIOServerCnxn factory
exited run method
[junit] 2009-01-29 11:45:30,816 - INFO [main:finalrequestproces...@265] -
shutdown of request processor complete
[junit] 2009-01-29 11:45:30,816 - INFO
[SyncThread:0:syncrequestproces...@117] - SyncRequestProcessor exited!
[junit] 2009-01-29 11:45:30,816 - INFO
[ProcessThread:0:preprequestproces...@104] - PrepRequestProcessor exited loop!
[junit] 2009-01-29 11:45:30,818 - INFO [main:clientb...@322] - FINISHED
testWatcherAutoResetDisabledWithLocal
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 127.273 sec
BUILD FAILED
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml
:547: Tests failed!
Total time: 8 minutes 41 seconds
Recording fingerprints
Publishing Javadoc
Recording test results
