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/02/01 12:40:51 UTC
Build failed in Hudson: ZooKeeper-trunk #216
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
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