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/05/14 15:50:07 UTC
Build failed in Hudson: ZooKeeper-trunk #309
See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/309/changes
Changes:
[fpj] ZOOKEEPER-400. Issues with procedure to close ledger. (flavio)
[mahadev] ZOOKEEPER-395. Python bindings. (henry robinson via mahadev)
------------------------------------------
[...truncated 122494 lines...]
[junit] 2009-05-14 14:06:23,020 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-05-14 14:06:23,020 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-05-14 14:06:23,020 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-05-14 14:06:23,119 - INFO [main:ClientBase@307] - STARTING server
[junit] 2009-05-14 14:06:23,120 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-05-14 14:06:23,121 - INFO [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test1052532416715671574.junit.dir/version-2/snapshot.0
[junit] 2009-05-14 14:06:23,122 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 3
[junit] 2009-05-14 14:06:23,124 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@631] - Processing stat command from /127.0.0.1:52111
[junit] 2009-05-14 14:06:23,124 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-05-14 14:06:23,125 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@762] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:52111]
[junit] 2009-05-14 14:06:24,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-05-14 14:06:24,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-05-14 14:06:24,795 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-05-14 14:06:24,796 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:52112 remote=/127.0.0.1:33221]
[junit] 2009-05-14 14:06:24,796 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-05-14 14:06:24,797 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:52112 lastZxid 3
[junit] 2009-05-14 14:06:24,797 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@891] - Finished init of 0x1213f71fb0f0000 valid:true
[junit] 2009-05-14 14:06:24,798 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@545] - Renewing session 0x1213f71fb0f0000
[junit] 2009-05-14 14:06:58,813 - INFO [main:ClientBase@301] - STOPPING server
[junit] 2009-05-14 14:06:58,813 - INFO [main:NIOServerCnxn@762] - closing session:0x1213f71fb0f0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:52112]
[junit] 2009-05-14 14:06:58,814 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x1213f71fb0f0000 to sun.nio.ch.SelectionKeyImpl@23f1bb
[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-05-14 14:06:58,814 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-05-14 14:06:58,814 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-05-14 14:06:58,814 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-05-14 14:06:58,814 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-05-14 14:06:58,914 - INFO [main:ClientBase@307] - STARTING server
[junit] 2009-05-14 14:06:58,914 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-05-14 14:06:58,916 - INFO [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test1052532416715671574.junit.dir/version-2/snapshot.3
[junit] 2009-05-14 14:06:58,917 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 5
[junit] 2009-05-14 14:06:58,919 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@631] - Processing stat command from /127.0.0.1:52114
[junit] 2009-05-14 14:06:58,920 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-05-14 14:06:58,920 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@762] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:52114]
[junit] 2009-05-14 14:07:00,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-05-14 14:07:00,541 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-05-14 14:07:00,541 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:52115 remote=/127.0.0.1:33221]
[junit] 2009-05-14 14:07:00,541 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-05-14 14:07:00,551 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:52115 lastZxid 5
[junit] 2009-05-14 14:07:00,552 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@891] - Finished init of 0x1213f71fb0f0000 valid:true
[junit] 2009-05-14 14:07:00,552 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@545] - Renewing session 0x1213f71fb0f0000
[junit] 2009-05-14 14:07:00,561 - INFO [main:ClientBase@301] - STOPPING server
[junit] 2009-05-14 14:07:00,562 - INFO [main:NIOServerCnxn@762] - closing session:0x1213f71fb0f0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:52115]
[junit] 2009-05-14 14:07:00,562 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x1213f71fb0f0000 to sun.nio.ch.SelectionKeyImpl@14e113b
[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-05-14 14:07:00,563 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-05-14 14:07:00,563 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-05-14 14:07:00,563 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-05-14 14:07:00,563 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-05-14 14:07:00,663 - INFO [main:ClientBase@307] - STARTING server
[junit] 2009-05-14 14:07:00,663 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-05-14 14:07:00,665 - INFO [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test1052532416715671574.junit.dir/version-2/snapshot.5
[junit] 2009-05-14 14:07:00,667 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 6
[junit] 2009-05-14 14:07:00,668 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@631] - Processing stat command from /127.0.0.1:52117
[junit] 2009-05-14 14:07:00,669 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-05-14 14:07:00,669 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@762] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:52117]
[junit] 2009-05-14 14:07:01,746 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-05-14 14:07:01,746 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:52118 remote=/127.0.0.1:33221]
[junit] 2009-05-14 14:07:01,746 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-05-14 14:07:01,747 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:52118 lastZxid 6
[junit] 2009-05-14 14:07:01,747 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@891] - Finished init of 0x1213f71fb0f0000 valid:true
[junit] 2009-05-14 14:07:01,747 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@545] - Renewing session 0x1213f71fb0f0000
[junit] 2009-05-14 14:07:03,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-05-14 14:07:12,762 - INFO [main:ZooKeeper@435] - Closing session: 0x1213f71fb0f0000
[junit] 2009-05-14 14:07:12,763 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x1213f71fb0f0000
[junit] 2009-05-14 14:07:12,763 - INFO [ProcessThread:-1:PrepRequestProcessor@365] - Processed session termination request for id: 0x1213f71fb0f0000
[junit] 2009-05-14 14:07:12,764 - INFO [SyncThread:0:NIOServerCnxn@762] - closing session:0x1213f71fb0f0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:52118]
[junit] 2009-05-14 14:07:12,764 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x1213f71fb0f0000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-05-14 14:07:12,865 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x1213f71fb0f0000
[junit] 2009-05-14 14:07:12,865 - INFO [main:ZooKeeper@443] - Session: 0x1213f71fb0f0000 closed
[junit] 2009-05-14 14:07:12,865 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-05-14 14:07:12,865 - INFO [main:ClientBase@313] - tearDown starting
[junit] 2009-05-14 14:07:12,866 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-05-14 14:07:12,866 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-05-14 14:07:12,866 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-05-14 14:07:12,866 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-05-14 14:07:12,868 - INFO [main:ClientBase@323] - FINISHED testWatcherAutoResetDisabledWithGlobal
[junit] 2009-05-14 14:07:12,868 - INFO [main:ClientBase@289] - STARTING testWatcherAutoResetDisabledWithLocal
[junit] 2009-05-14 14:07:12,869 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-05-14 14:07:12,869 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 0
[junit] 2009-05-14 14:07:12,872 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@631] - Processing stat command from /127.0.0.1:52120
[junit] 2009-05-14 14:07:12,873 - INFO [main:ClientBase@297] - Client test setup finished
[junit] 2009-05-14 14:07:12,873 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-05-14 14:07:12,873 - INFO [main:ZooKeeper@342] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=30000 watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@1f6f27b
[junit] 2009-05-14 14:07:12,874 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-05-14 14:07:12,874 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:52121 remote=/127.0.0.1:33221]
[junit] 2009-05-14 14:07:12,875 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-05-14 14:07:12,875 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@762] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:52120]
[junit] 2009-05-14 14:07:12,877 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:52121 lastZxid 0
[junit] 2009-05-14 14:07:12,877 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@548] - Creating new session 0x1213f72bde60000
[junit] 2009-05-14 14:07:12,891 - INFO [SyncThread:0:NIOServerCnxn@891] - Finished init of 0x1213f72bde60000 valid:true
[junit] 2009-05-14 14:07:12,896 - INFO [main:ClientBase@301] - STOPPING server
[junit] 2009-05-14 14:07:12,897 - INFO [main:NIOServerCnxn@762] - closing session:0x1213f72bde60000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:52121]
[junit] 2009-05-14 14:07:12,897 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x1213f72bde60000 to sun.nio.ch.SelectionKeyImpl@11a01dd
[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-05-14 14:07:12,898 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-05-14 14:07:12,899 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-05-14 14:07:12,899 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-05-14 14:07:12,899 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-05-14 14:07:12,998 - INFO [main:ClientBase@307] - STARTING server
[junit] 2009-05-14 14:07:12,998 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-05-14 14:07:12,999 - INFO [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test4693638624287650627.junit.dir/version-2/snapshot.0
[junit] 2009-05-14 14:07:13,000 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 3
[junit] 2009-05-14 14:07:13,002 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@631] - Processing stat command from /127.0.0.1:52123
[junit] 2009-05-14 14:07:13,002 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-05-14 14:07:13,004 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@762] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:52123]
[junit] 2009-05-14 14:07:14,774 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-05-14 14:07:14,774 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:54325 remote=/127.0.0.1:33221]
[junit] 2009-05-14 14:07:14,774 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-05-14 14:07:14,775 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:54325 lastZxid 3
[junit] 2009-05-14 14:07:14,775 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@891] - Finished init of 0x1213f72bde60000 valid:true
[junit] 2009-05-14 14:07:14,775 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@545] - Renewing session 0x1213f72bde60000
[junit] 2009-05-14 14:07:15,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-05-14 14:07:15,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-05-14 14:07:48,782 - INFO [main:ClientBase@301] - STOPPING server
[junit] 2009-05-14 14:07:48,783 - INFO [main:NIOServerCnxn@762] - closing session:0x1213f72bde60000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:54325]
[junit] 2009-05-14 14:07:48,783 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x1213f72bde60000 to sun.nio.ch.SelectionKeyImpl@827968
[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-05-14 14:07:48,818 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-05-14 14:07:48,819 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-05-14 14:07:48,819 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-05-14 14:07:48,819 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-05-14 14:07:48,919 - INFO [main:ClientBase@307] - STARTING server
[junit] 2009-05-14 14:07:48,919 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-05-14 14:07:48,920 - INFO [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test4693638624287650627.junit.dir/version-2/snapshot.3
[junit] 2009-05-14 14:07:48,922 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 5
[junit] 2009-05-14 14:07:48,924 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@631] - Processing stat command from /127.0.0.1:54327
[junit] 2009-05-14 14:07:48,924 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-05-14 14:07:48,925 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@762] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:54327]
[junit] 2009-05-14 14:07:50,489 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-05-14 14:07:50,495 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:54328 remote=/127.0.0.1:33221]
[junit] 2009-05-14 14:07:50,495 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-05-14 14:07:50,495 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:54328 lastZxid 5
[junit] 2009-05-14 14:07:50,497 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@891] - Finished init of 0x1213f72bde60000 valid:true
[junit] 2009-05-14 14:07:50,498 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@545] - Renewing session 0x1213f72bde60000
[junit] 2009-05-14 14:07:50,512 - INFO [main:ClientBase@301] - STOPPING server
[junit] 2009-05-14 14:07:50,512 - INFO [main:NIOServerCnxn@762] - closing session:0x1213f72bde60000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:54328]
[junit] 2009-05-14 14:07:50,512 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x1213f72bde60000 to sun.nio.ch.SelectionKeyImpl@6c1a82
[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-05-14 14:07:50,513 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-05-14 14:07:50,513 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-05-14 14:07:50,513 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-05-14 14:07:50,514 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-05-14 14:07:50,613 - INFO [main:ClientBase@307] - STARTING server
[junit] 2009-05-14 14:07:50,613 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-05-14 14:07:50,614 - INFO [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test4693638624287650627.junit.dir/version-2/snapshot.5
[junit] 2009-05-14 14:07:50,616 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 6
[junit] 2009-05-14 14:07:50,618 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@631] - Processing stat command from /127.0.0.1:54330
[junit] 2009-05-14 14:07:50,618 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-05-14 14:07:50,619 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@762] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:54330]
[junit] 2009-05-14 14:07:51,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-05-14 14:07:51,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-05-14 14:07:51,723 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-05-14 14:07:51,723 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:54331 remote=/127.0.0.1:33221]
[junit] 2009-05-14 14:07:51,723 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-05-14 14:07:51,723 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:54331 lastZxid 6
[junit] 2009-05-14 14:07:51,724 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@891] - Finished init of 0x1213f72bde60000 valid:true
[junit] 2009-05-14 14:07:51,724 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@545] - Renewing session 0x1213f72bde60000
[junit] 2009-05-14 14:08:02,732 - INFO [main:ZooKeeper@435] - Closing session: 0x1213f72bde60000
[junit] 2009-05-14 14:08:02,732 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x1213f72bde60000
[junit] 2009-05-14 14:08:02,733 - INFO [ProcessThread:-1:PrepRequestProcessor@365] - Processed session termination request for id: 0x1213f72bde60000
[junit] 2009-05-14 14:08:02,734 - INFO [SyncThread:0:NIOServerCnxn@762] - closing session:0x1213f72bde60000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:54331]
[junit] 2009-05-14 14:08:02,734 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x1213f72bde60000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-05-14 14:08:02,834 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x1213f72bde60000
[junit] 2009-05-14 14:08:02,835 - INFO [main:ZooKeeper@443] - Session: 0x1213f72bde60000 closed
[junit] 2009-05-14 14:08:02,835 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-05-14 14:08:02,835 - INFO [main:ClientBase@313] - tearDown starting
[junit] 2009-05-14 14:08:02,835 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-05-14 14:08:02,836 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-05-14 14:08:02,836 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-05-14 14:08:02,836 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-05-14 14:08:02,837 - INFO [main:ClientBase@323] - FINISHED testWatcherAutoResetDisabledWithLocal
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 127.282 sec
[junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest
[junit] 2009-05-14 14:08:03,102 - INFO [main:ClientBase@289] - STARTING testQuota
[junit] 2009-05-14 14:08:03,115 - INFO [main:Environment@97] - Server environment:zookeeper.version=3.2.0-774763, built on 05/14/2009 13:59 GMT
[junit] 2009-05-14 14:08:03,116 - INFO [main:Environment@97] - Server environment:host.name=vesta.apache.org
[junit] 2009-05-14 14:08:03,116 - INFO [main:Environment@97] - Server environment:java.version=1.6.0_11
[junit] 2009-05-14 14:08:03,117 - INFO [main:Environment@97] - Server environment:java.vendor=Sun Microsystems Inc.
[junit] 2009-05-14 14:08:03,117 - INFO [main:Environment@97] - Server environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre
[junit] 2009-05-14 14:08:03,118 - INFO [main:Environment@97] - Server environment:java.class.path=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/309/artifact/trunk/zookeeper-dev.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/jline-0.9.94.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/junit-4.4.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/log4j-1.2.15.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/testclasses :/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant-launcher.jar:/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant.jar:/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant-junit.jar
[junit] 2009-05-14 14:08:03,119 - INFO [main:Environment@97] - Server environment:java.library.path=/home/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386/server:/home/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386:/home/hudson/tools/java/jdk1.6.0_11-32/jre/../lib/i386:/usr/java/packages/lib/i386:/lib:/usr/lib
[junit] 2009-05-14 14:08:03,119 - INFO [main:Environment@97] - Server environment:java.io.tmpdir=/tmp
[junit] 2009-05-14 14:08:03,120 - INFO [main:Environment@97] - Server environment:java.compiler=<NA>
[junit] 2009-05-14 14:08:03,120 - INFO [main:Environment@97] - Server environment:os.name=Linux
[junit] 2009-05-14 14:08:03,121 - INFO [main:Environment@97] - Server environment:os.arch=i386
[junit] 2009-05-14 14:08:03,121 - INFO [main:Environment@97] - Server environment:os.version=2.6.27-7-server
[junit] 2009-05-14 14:08:03,122 - INFO [main:Environment@97] - Server environment:user.name=hudson
[junit] 2009-05-14 14:08:03,122 - INFO [main:Environment@97] - Server environment:user.home=/home/hudson
[junit] 2009-05-14 14:08:03,123 - INFO [main:Environment@97] - Server environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk
[junit] 2009-05-14 14:08:03,127 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-05-14 14:08:03,144 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 0
[junit] 2009-05-14 14:08:03,200 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@631] - Processing stat command from /127.0.0.1:54334
[junit] 2009-05-14 14:08:03,200 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-05-14 14:08:03,200 - INFO [main:ClientBase@297] - Client test setup finished
[junit] 2009-05-14 14:08:03,201 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@762] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:54334]
[junit] 2009-05-14 14:08:03,204 - INFO [main:Environment@97] - Client environment:zookeeper.version=3.2.0-774763, built on 05/14/2009 13:59 GMT
[junit] 2009-05-14 14:08:03,204 - INFO [main:Environment@97] - Client environment:host.name=vesta.apache.org
[junit] 2009-05-14 14:08:03,205 - INFO [main:Environment@97] - Client environment:java.version=1.6.0_11
[junit] 2009-05-14 14:08:03,205 - INFO [main:Environment@97] - Client environment:java.vendor=Sun Microsystems Inc.
[junit] 2009-05-14 14:08:03,205 - INFO [main:Environment@97] - Client environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre
[junit] 2009-05-14 14:08:03,214 - INFO [main:Environment@97] - Client environment:java.class.path=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/309/artifact/trunk/zookeeper-dev.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/jline-0.9.94.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/junit-4.4.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/log4j-1.2.15.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/testclasses :/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant-launcher.jar:/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant.jar:/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant-junit.jar
[junit] 2009-05-14 14:08:03,214 - INFO [main:Environment@97] - Client environment:java.library.path=/home/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386/server:/home/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386:/home/hudson/tools/java/jdk1.6.0_11-32/jre/../lib/i386:/usr/java/packages/lib/i386:/lib:/usr/lib
[junit] 2009-05-14 14:08:03,215 - INFO [main:Environment@97] - Client environment:java.io.tmpdir=/tmp
[junit] 2009-05-14 14:08:03,215 - INFO [main:Environment@97] - Client environment:java.compiler=<NA>
[junit] 2009-05-14 14:08:03,216 - INFO [main:Environment@97] - Client environment:os.name=Linux
[junit] 2009-05-14 14:08:03,216 - INFO [main:Environment@97] - Client environment:os.arch=i386
[junit] 2009-05-14 14:08:03,216 - INFO [main:Environment@97] - Client environment:os.version=2.6.27-7-server
[junit] 2009-05-14 14:08:03,217 - INFO [main:Environment@97] - Client environment:user.name=hudson
[junit] 2009-05-14 14:08:03,217 - INFO [main:Environment@97] - Client environment:user.home=/home/hudson
[junit] 2009-05-14 14:08:03,218 - INFO [main:Environment@97] - Client environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk
[junit] 2009-05-14 14:08:03,219 - INFO [main:ZooKeeper@342] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=30000 watcher=org.apache.zookeeper.test.ClientBase$CountdownWatcher@cf66b
[junit] 2009-05-14 14:08:03,220 - INFO [main:ClientCnxn@91] - zookeeper.disableAutoWatchReset is false
[junit] 2009-05-14 14:08:03,224 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-05-14 14:08:03,225 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:54335 remote=/127.0.0.1:33221]
[junit] 2009-05-14 14:08:03,228 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-05-14 14:08:03,229 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:54335 lastZxid 0
[junit] 2009-05-14 14:08:03,230 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@548] - Creating new session 0x1213f73824b0000
[junit] 2009-05-14 14:08:03,245 - INFO [SyncThread:0:NIOServerCnxn@891] - Finished init of 0x1213f73824b0000 valid:true
[junit] 2009-05-14 14:08:03,272 - INFO [main:ClientBase@313] - tearDown starting
[junit] 2009-05-14 14:08:03,273 - INFO [main:NIOServerCnxn@762] - closing session:0x1213f73824b0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:54335]
[junit] 2009-05-14 14:08:03,274 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x1213f73824b0000 to sun.nio.ch.SelectionKeyImpl@1976011
[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-05-14 14:08:03,275 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-05-14 14:08:03,275 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-05-14 14:08:03,275 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-05-14 14:08:03,275 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-05-14 14:08:03,277 - INFO [main:ClientBase@323] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.216 sec
BUILD FAILED
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :702: The following error occurred while executing this line:
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :613: Tests failed!
Total time: 8 minutes 40 seconds
Recording fingerprints
Publishing Javadoc
Recording test results