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/20 12:43:55 UTC
Build failed in Hudson: ZooKeeper-trunk #235
See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/235/changes
Changes:
[mahadev] ZOOKEEPER-308. improve the atomic broadcast performance 3x. (breed via mahadev)
------------------------------------------
[...truncated 49201 lines...]
[junit] 2009-02-20 11:50:29,720 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-02-20 11:50:29,722 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-02-20 11:50:29,722 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-02-20 11:50:29,722 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-20 11:50:29,821 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-20 11:50:29,821 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-02-20 11:50:29,822 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8406486238643598014.junit.dir/version-2/snapshot.0
[junit] 2009-02-20 11:50:29,823 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 3
[junit] 2009-02-20 11:50:29,825 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@635] - Processing stat command from /127.0.0.1:40341
[junit] 2009-02-20 11:50:29,825 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-20 11:50:29,826 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40341]
[junit] 2009-02-20 11:50:30,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-20 11:50:30,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-20 11:50:31,182 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-20 11:50:31,182 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:40342 remote=/127.0.0.1:33221]
[junit] 2009-02-20 11:50:31,182 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-20 11:50:31,182 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:40342 lastZxid 3
[junit] 2009-02-20 11:50:31,183 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@895] - Finished init of 0x11f9385be440000 valid:true
[junit] 2009-02-20 11:50:31,183 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@545] - Renewing session 0x11f9385be440000
[junit] 2009-02-20 11:51:05,194 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-02-20 11:51:05,195 - INFO [main:NIOServerCnxn@766] - closing session:0x11f9385be440000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40342]
[junit] 2009-02-20 11:51:05,196 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f9385be440000 to sun.nio.ch.SelectionKeyImpl@ee1ede
[junit] java.io.IOException: Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:632)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:876)
[junit] 2009-02-20 11:51:05,196 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-02-20 11:51:05,197 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-02-20 11:51:05,197 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-02-20 11:51:05,197 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-20 11:51:05,296 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-20 11:51:05,296 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-02-20 11:51:05,298 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8406486238643598014.junit.dir/version-2/snapshot.3
[junit] 2009-02-20 11:51:05,299 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 5
[junit] 2009-02-20 11:51:05,302 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@635] - Processing stat command from /127.0.0.1:40344
[junit] 2009-02-20 11:51:05,302 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-20 11:51:05,302 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40344]
[junit] 2009-02-20 11:51:06,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-20 11:51:07,068 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-20 11:51:07,068 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:40345 remote=/127.0.0.1:33221]
[junit] 2009-02-20 11:51:07,068 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-20 11:51:07,069 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:40345 lastZxid 5
[junit] 2009-02-20 11:51:07,069 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@895] - Finished init of 0x11f9385be440000 valid:true
[junit] 2009-02-20 11:51:07,070 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@545] - Renewing session 0x11f9385be440000
[junit] 2009-02-20 11:51:07,081 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-02-20 11:51:07,082 - INFO [main:NIOServerCnxn@766] - closing session:0x11f9385be440000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40345]
[junit] 2009-02-20 11:51:07,082 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f9385be440000 to sun.nio.ch.SelectionKeyImpl@d7b7d9
[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-20 11:51:07,082 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-02-20 11:51:07,083 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-02-20 11:51:07,083 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-20 11:51:07,083 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-02-20 11:51:07,183 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-20 11:51:07,183 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-02-20 11:51:07,184 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8406486238643598014.junit.dir/version-2/snapshot.5
[junit] 2009-02-20 11:51:07,186 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 6
[junit] 2009-02-20 11:51:07,188 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@635] - Processing stat command from /127.0.0.1:40347
[junit] 2009-02-20 11:51:07,189 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-20 11:51:07,190 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40347]
[junit] 2009-02-20 11:51:08,216 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-20 11:51:08,216 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:40348 remote=/127.0.0.1:33221]
[junit] 2009-02-20 11:51:08,216 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-20 11:51:08,216 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:40348 lastZxid 6
[junit] 2009-02-20 11:51:08,217 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@895] - Finished init of 0x11f9385be440000 valid:true
[junit] 2009-02-20 11:51:08,217 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@545] - Renewing session 0x11f9385be440000
[junit] 2009-02-20 11:51:09,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-20 11:51:19,234 - INFO [main:ZooKeeper@434] - Closing session: 0x11f9385be440000
[junit] 2009-02-20 11:51:19,234 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x11f9385be440000
[junit] 2009-02-20 11:51:19,235 - INFO [ProcessThread:-1:PrepRequestProcessor@364] - Processed session termination request for id: 0x11f9385be440000
[junit] 2009-02-20 11:51:19,237 - INFO [SyncThread:0:NIOServerCnxn@766] - closing session:0x11f9385be440000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40348]
[junit] 2009-02-20 11:51:19,237 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x11f9385be440000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-02-20 11:51:19,337 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x11f9385be440000
[junit] 2009-02-20 11:51:19,338 - INFO [main:ZooKeeper@442] - Session: 0x11f9385be440000 closed
[junit] 2009-02-20 11:51:19,338 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-02-20 11:51:19,338 - INFO [main:ClientBase@312] - tearDown starting
[junit] 2009-02-20 11:51:19,339 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-02-20 11:51:19,339 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-02-20 11:51:19,339 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-02-20 11:51:19,340 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-20 11:51:19,341 - INFO [main:ClientBase@322] - FINISHED testWatcherAutoResetDisabledWithGlobal
[junit] 2009-02-20 11:51:19,341 - INFO [main:ClientBase@288] - STARTING testWatcherAutoResetDisabledWithLocal
[junit] 2009-02-20 11:51:19,342 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-02-20 11:51:19,343 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 0
[junit] 2009-02-20 11:51:19,345 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@635] - Processing stat command from /127.0.0.1:40350
[junit] 2009-02-20 11:51:19,345 - INFO [main:ClientBase@296] - Client test setup finished
[junit] 2009-02-20 11:51:19,345 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-20 11:51:19,345 - INFO [main:ZooKeeper@341] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=9000 watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@18bd7f1
[junit] 2009-02-20 11:51:19,345 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40350]
[junit] 2009-02-20 11:51:19,346 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-20 11:51:19,347 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:40351 remote=/127.0.0.1:33221]
[junit] 2009-02-20 11:51:19,347 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-20 11:51:19,347 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:40351 lastZxid 0
[junit] 2009-02-20 11:51:19,347 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@548] - Creating new session 0x11f9386802f0000
[junit] 2009-02-20 11:51:19,353 - INFO [SyncThread:0:NIOServerCnxn@895] - Finished init of 0x11f9386802f0000 valid:true
[junit] 2009-02-20 11:51:19,358 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-02-20 11:51:19,358 - INFO [main:NIOServerCnxn@766] - closing session:0x11f9386802f0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40351]
[junit] 2009-02-20 11:51:19,359 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f9386802f0000 to sun.nio.ch.SelectionKeyImpl@11eb199
[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-20 11:51:19,359 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-02-20 11:51:19,360 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-02-20 11:51:19,360 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-02-20 11:51:19,360 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-20 11:51:19,459 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-20 11:51:19,460 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-02-20 11:51:19,461 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8104943821442288362.junit.dir/version-2/snapshot.0
[junit] 2009-02-20 11:51:19,462 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 3
[junit] 2009-02-20 11:51:19,464 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@635] - Processing stat command from /127.0.0.1:40353
[junit] 2009-02-20 11:51:19,464 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-20 11:51:19,464 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40353]
[junit] 2009-02-20 11:51:20,608 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-20 11:51:20,609 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:40354 remote=/127.0.0.1:33221]
[junit] 2009-02-20 11:51:20,609 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-20 11:51:20,609 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:40354 lastZxid 3
[junit] 2009-02-20 11:51:20,610 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@895] - Finished init of 0x11f9386802f0000 valid:true
[junit] 2009-02-20 11:51:20,610 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@545] - Renewing session 0x11f9386802f0000
[junit] 2009-02-20 11:51:21,004 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-20 11:51:21,004 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-20 11:51:54,622 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-02-20 11:51:54,623 - INFO [main:NIOServerCnxn@766] - closing session:0x11f9386802f0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40354]
[junit] 2009-02-20 11:51:54,623 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f9386802f0000 to sun.nio.ch.SelectionKeyImpl@17b4703
[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-20 11:51:54,627 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-02-20 11:51:54,627 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-02-20 11:51:54,628 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-02-20 11:51:54,634 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-20 11:51:54,724 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-20 11:51:54,724 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-02-20 11:51:54,725 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8104943821442288362.junit.dir/version-2/snapshot.3
[junit] 2009-02-20 11:51:54,727 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 5
[junit] 2009-02-20 11:51:54,729 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@635] - Processing stat command from /127.0.0.1:40356
[junit] 2009-02-20 11:51:54,729 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-20 11:51:54,730 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40356]
[junit] 2009-02-20 11:51:56,004 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-20 11:51:56,004 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:40357 remote=/127.0.0.1:33221]
[junit] 2009-02-20 11:51:56,004 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-20 11:51:56,005 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:40357 lastZxid 5
[junit] 2009-02-20 11:51:56,005 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@895] - Finished init of 0x11f9386802f0000 valid:true
[junit] 2009-02-20 11:51:56,005 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@545] - Renewing session 0x11f9386802f0000
[junit] 2009-02-20 11:51:56,021 - INFO [main:ClientBase@300] - STOPPING server
[junit] 2009-02-20 11:51:56,021 - INFO [main:NIOServerCnxn@766] - closing session:0x11f9386802f0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40357]
[junit] 2009-02-20 11:51:56,022 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f9386802f0000 to sun.nio.ch.SelectionKeyImpl@b23d12
[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-20 11:51:56,022 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-02-20 11:51:56,023 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-02-20 11:51:56,023 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-20 11:51:56,023 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-02-20 11:51:56,122 - INFO [main:ClientBase@306] - STARTING server
[junit] 2009-02-20 11:51:56,123 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-02-20 11:51:56,124 - INFO [main:FileSnap@71] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8104943821442288362.junit.dir/version-2/snapshot.5
[junit] 2009-02-20 11:51:56,126 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 6
[junit] 2009-02-20 11:51:56,127 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@635] - Processing stat command from /127.0.0.1:40359
[junit] 2009-02-20 11:51:56,128 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-20 11:51:56,128 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40359]
[junit] 2009-02-20 11:51:57,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-20 11:51:57,000 - INFO [SessionTracker:SessionTrackerImpl@142] - SessionTrackerImpl exited loop!
[junit] 2009-02-20 11:51:57,460 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-20 11:51:57,461 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:40360 remote=/127.0.0.1:33221]
[junit] 2009-02-20 11:51:57,461 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-20 11:51:57,462 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:40360 lastZxid 6
[junit] 2009-02-20 11:51:57,462 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@895] - Finished init of 0x11f9386802f0000 valid:true
[junit] 2009-02-20 11:51:57,462 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@545] - Renewing session 0x11f9386802f0000
[junit] 2009-02-20 11:52:08,474 - INFO [main:ZooKeeper@434] - Closing session: 0x11f9386802f0000
[junit] 2009-02-20 11:52:08,474 - INFO [main:ClientCnxn@999] - Closing ClientCnxn for session: 0x11f9386802f0000
[junit] 2009-02-20 11:52:08,474 - INFO [ProcessThread:-1:PrepRequestProcessor@364] - Processed session termination request for id: 0x11f9386802f0000
[junit] 2009-02-20 11:52:08,475 - INFO [SyncThread:0:NIOServerCnxn@766] - closing session:0x11f9386802f0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40360]
[junit] 2009-02-20 11:52:08,475 - INFO [main-SendThread:ClientCnxn$SendThread@892] - Exception while closing send thread for session 0x11f9386802f0000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-02-20 11:52:08,576 - INFO [main:ClientCnxn@985] - Disconnecting ClientCnxn for session: 0x11f9386802f0000
[junit] 2009-02-20 11:52:08,576 - INFO [main:ZooKeeper@442] - Session: 0x11f9386802f0000 closed
[junit] 2009-02-20 11:52:08,576 - INFO [main-EventThread:ClientCnxn$EventThread@452] - EventThread shut down
[junit] 2009-02-20 11:52:08,576 - INFO [main:ClientBase@312] - tearDown starting
[junit] 2009-02-20 11:52:08,576 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-02-20 11:52:08,577 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-02-20 11:52:08,577 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-02-20 11:52:08,577 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-20 11:52:08,578 - INFO [main:ClientBase@322] - FINISHED testWatcherAutoResetDisabledWithLocal
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 125.927 sec
[junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest
[junit] 2009-02-20 11:52:08,856 - INFO [main:ClientBase@288] - STARTING testQuota
[junit] 2009-02-20 11:52:08,869 - INFO [main:Environment@97] - Server environment:zookeeper.version=3.2.0-746211, built on 02/20/2009 11:43 GMT
[junit] 2009-02-20 11:52:08,870 - INFO [main:Environment@97] - Server environment:host.name=vesta.apache.org
[junit] 2009-02-20 11:52:08,870 - INFO [main:Environment@97] - Server environment:java.version=1.6.0_11
[junit] 2009-02-20 11:52:08,871 - INFO [main:Environment@97] - Server environment:java.vendor=Sun Microsystems Inc.
[junit] 2009-02-20 11:52:08,871 - INFO [main:Environment@97] - Server environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre
[junit] 2009-02-20 11:52:08,872 - INFO [main:Environment@97] - Server environment:java.class.path=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/235/artifact/trunk/zookeeper-dev.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-02-20 11:52:08,872 - 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-02-20 11:52:08,873 - INFO [main:Environment@97] - Server environment:java.io.tmpdir=/tmp
[junit] 2009-02-20 11:52:08,873 - INFO [main:Environment@97] - Server environment:java.compiler=<NA>
[junit] 2009-02-20 11:52:08,874 - INFO [main:Environment@97] - Server environment:os.name=Linux
[junit] 2009-02-20 11:52:08,875 - INFO [main:Environment@97] - Server environment:os.arch=i386
[junit] 2009-02-20 11:52:08,875 - INFO [main:Environment@97] - Server environment:os.version=2.6.27-7-server
[junit] 2009-02-20 11:52:08,876 - INFO [main:Environment@97] - Server environment:user.name=hudson
[junit] 2009-02-20 11:52:08,876 - INFO [main:Environment@97] - Server environment:user.home=/home/hudson
[junit] 2009-02-20 11:52:08,877 - INFO [main:Environment@97] - Server environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk
[junit] 2009-02-20 11:52:08,881 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-02-20 11:52:08,897 - INFO [main:FileTxnSnapLog@198] - Snapshotting: 0
[junit] 2009-02-20 11:52:08,954 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@635] - Processing stat command from /127.0.0.1:40363
[junit] 2009-02-20 11:52:08,955 - WARN [NIOServerCxn.Factory:33221:NIOServerCnxn@431] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-02-20 11:52:08,955 - INFO [main:ClientBase@296] - Client test setup finished
[junit] 2009-02-20 11:52:08,956 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@766] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40363]
[junit] 2009-02-20 11:52:08,959 - INFO [main:Environment@97] - Client environment:zookeeper.version=3.2.0-746211, built on 02/20/2009 11:43 GMT
[junit] 2009-02-20 11:52:08,959 - INFO [main:Environment@97] - Client environment:host.name=vesta.apache.org
[junit] 2009-02-20 11:52:08,960 - INFO [main:Environment@97] - Client environment:java.version=1.6.0_11
[junit] 2009-02-20 11:52:08,960 - INFO [main:Environment@97] - Client environment:java.vendor=Sun Microsystems Inc.
[junit] 2009-02-20 11:52:08,960 - INFO [main:Environment@97] - Client environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre
[junit] 2009-02-20 11:52:08,961 - INFO [main:Environment@97] - Client environment:java.class.path=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/235/artifact/trunk/zookeeper-dev.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-02-20 11:52:08,968 - 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-02-20 11:52:08,969 - INFO [main:Environment@97] - Client environment:java.io.tmpdir=/tmp
[junit] 2009-02-20 11:52:08,969 - INFO [main:Environment@97] - Client environment:java.compiler=<NA>
[junit] 2009-02-20 11:52:08,970 - INFO [main:Environment@97] - Client environment:os.name=Linux
[junit] 2009-02-20 11:52:08,970 - INFO [main:Environment@97] - Client environment:os.arch=i386
[junit] 2009-02-20 11:52:08,970 - INFO [main:Environment@97] - Client environment:os.version=2.6.27-7-server
[junit] 2009-02-20 11:52:08,971 - INFO [main:Environment@97] - Client environment:user.name=hudson
[junit] 2009-02-20 11:52:08,971 - INFO [main:Environment@97] - Client environment:user.home=/home/hudson
[junit] 2009-02-20 11:52:08,972 - INFO [main:Environment@97] - Client environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk
[junit] 2009-02-20 11:52:08,973 - INFO [main:ZooKeeper@341] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=9000 watcher=org.apache.zookeeper.test.ClientBase$CountdownWatcher@1060478
[junit] 2009-02-20 11:52:08,974 - INFO [main:ClientCnxn@91] - zookeeper.disableAutoWatchReset is false
[junit] 2009-02-20 11:52:08,978 - INFO [main-SendThread:ClientCnxn$SendThread@800] - Attempting connection to server /127.0.0.1:33221
[junit] 2009-02-20 11:52:08,979 - INFO [main-SendThread:ClientCnxn$SendThread@716] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:40364 remote=/127.0.0.1:33221]
[junit] 2009-02-20 11:52:08,982 - INFO [main-SendThread:ClientCnxn$SendThread@868] - Server connection successful
[junit] 2009-02-20 11:52:08,983 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@517] - Connected to /127.0.0.1:40364 lastZxid 0
[junit] 2009-02-20 11:52:08,988 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn@548] - Creating new session 0x11f938741c50000
[junit] 2009-02-20 11:52:09,008 - INFO [SyncThread:0:NIOServerCnxn@895] - Finished init of 0x11f938741c50000 valid:true
[junit] 2009-02-20 11:52:09,033 - INFO [main:ClientBase@312] - tearDown starting
[junit] 2009-02-20 11:52:09,034 - INFO [main:NIOServerCnxn@766] - closing session:0x11f938741c50000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:40364]
[junit] 2009-02-20 11:52:09,035 - WARN [main-SendThread:ClientCnxn$SendThread@898] - Exception closing session 0x11f938741c50000 to sun.nio.ch.SelectionKeyImpl@1878144
[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-20 11:52:09,036 - INFO [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@177] - NIOServerCnxn factory exited run method
[junit] 2009-02-20 11:52:09,036 - INFO [main:FinalRequestProcessor@268] - shutdown of request processor complete
[junit] 2009-02-20 11:52:09,036 - INFO [SyncThread:0:SyncRequestProcessor@119] - SyncRequestProcessor exited!
[junit] 2009-02-20 11:52:09,036 - INFO [ProcessThread:-1:PrepRequestProcessor@111] - PrepRequestProcessor exited loop!
[junit] 2009-02-20 11:52:09,038 - INFO [main:ClientBase@322] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.229 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 #236
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/236/changes