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/08/22 15:02:57 UTC
Build failed in Hudson: ZooKeeper-trunk #423
See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/423/
------------------------------------------
[...truncated 164254 lines...]
[junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2009-08-22 13:00:56,379 - INFO [main-SendThread(localhost:11225):ClientCnxn$SendThread@869] - Attempting connection to server localhost/127.0.0.1:11225
[junit] 2009-08-22 13:00:56,379 - INFO [main-SendThread(localhost:11225):ClientCnxn$SendThread@785] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:38761 remote=localhost/127.0.0.1:11225]
[junit] 2009-08-22 13:00:56,379 - INFO [main-SendThread(localhost:11225):ClientCnxn$SendThread@939] - Server connection successful
[junit] 2009-08-22 13:00:56,379 - INFO [NIOServerCxn.Factory:11225:NIOServerCnxn@584] - Connected to /127.0.0.1:38761 lastZxid 6
[junit] 2009-08-22 13:00:56,380 - INFO [NIOServerCxn.Factory:11225:NIOServerCnxn@965] - Finished init of 0x123423167e40000 valid:true
[junit] 2009-08-22 13:00:56,380 - INFO [NIOServerCxn.Factory:11225:NIOServerCnxn@613] - Renewing session 0x123423167e40000
[junit] 2009-08-22 13:00:57,000 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-08-22 13:01:07,469 - INFO [main:ZooKeeper@502] - Closing session: 0x123423167e40000
[junit] 2009-08-22 13:01:07,469 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x123423167e40000
[junit] 2009-08-22 13:01:07,470 - INFO [ProcessThread:-1:PrepRequestProcessor@384] - Processed session termination request for id: 0x123423167e40000
[junit] 2009-08-22 13:01:07,478 - INFO [SyncThread:0:NIOServerCnxn@834] - closing session:0x123423167e40000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11225 remote=/127.0.0.1:38761]
[junit] 2009-08-22 13:01:07,478 - INFO [main-SendThread(localhost:11225):ClientCnxn$SendThread@963] - Exception while closing send thread for session 0x123423167e40000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-08-22 13:01:07,579 - INFO [main:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x123423167e40000
[junit] 2009-08-22 13:01:07,579 - INFO [main:ZooKeeper@510] - Session: 0x123423167e40000 closed
[junit] 2009-08-22 13:01:07,579 - INFO [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
[junit] 2009-08-22 13:01:07,579 - INFO [main:ClientBase@375] - tearDown starting
[junit] 2009-08-22 13:01:07,579 - INFO [main:ZooKeeper@502] - Closing session: 0x123423167e40000
[junit] 2009-08-22 13:01:07,579 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x123423167e40000
[junit] 2009-08-22 13:01:07,580 - INFO [main:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x123423167e40000
[junit] 2009-08-22 13:01:07,580 - INFO [main:ZooKeeper@510] - Session: 0x123423167e40000 closed
[junit] 2009-08-22 13:01:07,580 - INFO [main:ClientBase@352] - STOPPING server
[junit] 2009-08-22 13:01:07,580 - INFO [NIOServerCxn.Factory:11225:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-08-22 13:01:07,580 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-08-22 13:01:07,580 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] 2009-08-22 13:01:07,581 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] ensureOnly:[]
[junit] 2009-08-22 13:01:07,584 - INFO [main:ClientBase@391] - FINISHED testWatcherAutoResetDisabledWithGlobal
[junit] 2009-08-22 13:01:07,584 - INFO [main:ClientBase@330] - STARTING testWatcherAutoResetDisabledWithLocal
[junit] 2009-08-22 13:01:07,589 - INFO [main:ClientBase@345] - STARTING server
[junit] 2009-08-22 13:01:07,589 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-08-22 13:01:07,589 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11226
[junit] 2009-08-22 13:01:07,590 - INFO [main:FileTxnSnapLog@208] - Snapshotting: 0
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-08-22 13:01:07,592 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:49054
[junit] 2009-08-22 13:01:07,592 - WARN [NIOServerCxn.Factory:11226:NIOServerCnxn@495] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-08-22 13:01:07,592 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@834] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:49054]
[junit] expect:InMemoryDataTree
[junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] expect:StandaloneServer_port
[junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2009-08-22 13:01:07,593 - INFO [main:ClientBase@341] - Client test setup finished
[junit] 2009-08-22 13:01:07,594 - INFO [main:ZooKeeper@369] - Initiating client connection, connectString=127.0.0.1:11226 sessionTimeout=30000 watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@1e1ec86
[junit] 2009-08-22 13:01:07,594 - INFO [main-SendThread():ClientCnxn$SendThread@869] - Attempting connection to server /127.0.0.1:11226
[junit] 2009-08-22 13:01:07,595 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@785] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:49055 remote=localhost/127.0.0.1:11226]
[junit] 2009-08-22 13:01:07,595 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@939] - Server connection successful
[junit] 2009-08-22 13:01:07,595 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /127.0.0.1:49055 lastZxid 0
[junit] 2009-08-22 13:01:07,595 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@616] - Creating new session 0x12342322c860000
[junit] 2009-08-22 13:01:07,674 - INFO [SyncThread:0:NIOServerCnxn@965] - Finished init of 0x12342322c860000 valid:true
[junit] expect:0x12342322c860000
[junit] found:0x12342322c860000 org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x12342322c860000
[junit] 2009-08-22 13:01:07,698 - INFO [main:ClientBase@352] - STOPPING server
[junit] 2009-08-22 13:01:07,698 - INFO [main:NIOServerCnxn@834] - closing session:0x12342322c860000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:49055]
[junit] 2009-08-22 13:01:07,699 - WARN [main-SendThread(localhost:11226):ClientCnxn$SendThread@969] - Exception closing session 0x12342322c860000 to sun.nio.ch.SelectionKeyImpl@a1aa85
[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:701)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:947)
[junit] 2009-08-22 13:01:07,699 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-08-22 13:01:07,699 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] 2009-08-22 13:01:07,700 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-08-22 13:01:07,699 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] ensureOnly:[]
[junit] 2009-08-22 13:01:07,799 - INFO [main:ClientBase@345] - STARTING server
[junit] 2009-08-22 13:01:07,799 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-08-22 13:01:07,800 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11226
[junit] 2009-08-22 13:01:07,800 - INFO [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test589857681773823500.junit.dir/version-2/snapshot.0
[junit] 2009-08-22 13:01:07,801 - INFO [main:FileTxnSnapLog@208] - Snapshotting: 3
[junit] 2009-08-22 13:01:07,803 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:49057
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-08-22 13:01:07,804 - WARN [NIOServerCxn.Factory:11226:NIOServerCnxn@495] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-08-22 13:01:07,804 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@834] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:49057]
[junit] expect:InMemoryDataTree
[junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] expect:StandaloneServer_port
[junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2009-08-22 13:01:09,000 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-08-22 13:01:09,000 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-08-22 13:01:09,527 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@869] - Attempting connection to server localhost/127.0.0.1:11226
[junit] 2009-08-22 13:01:09,527 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@785] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:49058 remote=localhost/127.0.0.1:11226]
[junit] 2009-08-22 13:01:09,528 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@939] - Server connection successful
[junit] 2009-08-22 13:01:09,528 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /127.0.0.1:49058 lastZxid 3
[junit] 2009-08-22 13:01:09,529 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of 0x12342322c860000 valid:true
[junit] 2009-08-22 13:01:09,529 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session 0x12342322c860000
[junit] 2009-08-22 13:01:43,608 - INFO [main:ClientBase@352] - STOPPING server
[junit] 2009-08-22 13:01:43,609 - INFO [main:NIOServerCnxn@834] - closing session:0x12342322c860000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:49058]
[junit] 2009-08-22 13:01:43,609 - WARN [main-SendThread(localhost:11226):ClientCnxn$SendThread@969] - Exception closing session 0x12342322c860000 to sun.nio.ch.SelectionKeyImpl@b48b11
[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:701)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:947)
[junit] 2009-08-22 13:01:43,610 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-08-22 13:01:43,610 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-08-22 13:01:43,610 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] 2009-08-22 13:01:43,610 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] ensureOnly:[]
[junit] 2009-08-22 13:01:43,710 - INFO [main:ClientBase@345] - STARTING server
[junit] 2009-08-22 13:01:43,710 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-08-22 13:01:43,710 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11226
[junit] 2009-08-22 13:01:43,722 - INFO [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test589857681773823500.junit.dir/version-2/snapshot.3
[junit] 2009-08-22 13:01:43,724 - INFO [main:FileTxnSnapLog@208] - Snapshotting: 5
[junit] 2009-08-22 13:01:43,726 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:48299
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-08-22 13:01:43,726 - WARN [NIOServerCxn.Factory:11226:NIOServerCnxn@495] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-08-22 13:01:43,726 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@834] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:48299]
[junit] expect:InMemoryDataTree
[junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] expect:StandaloneServer_port
[junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2009-08-22 13:01:45,000 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-08-22 13:01:45,042 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@869] - Attempting connection to server localhost/127.0.0.1:11226
[junit] 2009-08-22 13:01:45,042 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@785] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:48300 remote=localhost/127.0.0.1:11226]
[junit] 2009-08-22 13:01:45,042 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@939] - Server connection successful
[junit] 2009-08-22 13:01:45,043 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /127.0.0.1:48300 lastZxid 5
[junit] 2009-08-22 13:01:45,043 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of 0x12342322c860000 valid:true
[junit] 2009-08-22 13:01:45,044 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session 0x12342322c860000
[junit] 2009-08-22 13:01:45,091 - INFO [main:ClientBase@352] - STOPPING server
[junit] 2009-08-22 13:01:45,092 - INFO [main:NIOServerCnxn@834] - closing session:0x12342322c860000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:48300]
[junit] 2009-08-22 13:01:45,092 - WARN [main-SendThread(localhost:11226):ClientCnxn$SendThread@969] - Exception closing session 0x12342322c860000 to sun.nio.ch.SelectionKeyImpl@140fee
[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:701)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:947)
[junit] 2009-08-22 13:01:45,093 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-08-22 13:01:45,093 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-08-22 13:01:45,093 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] 2009-08-22 13:01:45,093 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] ensureOnly:[]
[junit] 2009-08-22 13:01:45,193 - INFO [main:ClientBase@345] - STARTING server
[junit] 2009-08-22 13:01:45,193 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-08-22 13:01:45,193 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11226
[junit] 2009-08-22 13:01:45,195 - INFO [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test589857681773823500.junit.dir/version-2/snapshot.5
[junit] 2009-08-22 13:01:45,197 - INFO [main:FileTxnSnapLog@208] - Snapshotting: 6
[junit] 2009-08-22 13:01:45,198 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:48302
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-08-22 13:01:45,199 - WARN [NIOServerCxn.Factory:11226:NIOServerCnxn@495] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-08-22 13:01:45,199 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@834] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:48302]
[junit] expect:InMemoryDataTree
[junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] expect:StandaloneServer_port
[junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2009-08-22 13:01:46,614 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@869] - Attempting connection to server localhost/127.0.0.1:11226
[junit] 2009-08-22 13:01:46,614 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@785] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:48303 remote=localhost/127.0.0.1:11226]
[junit] 2009-08-22 13:01:46,614 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@939] - Server connection successful
[junit] 2009-08-22 13:01:46,614 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /127.0.0.1:48303 lastZxid 6
[junit] 2009-08-22 13:01:46,615 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of 0x12342322c860000 valid:true
[junit] 2009-08-22 13:01:46,615 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session 0x12342322c860000
[junit] 2009-08-22 13:01:48,000 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-08-22 13:01:57,697 - INFO [main:ZooKeeper@502] - Closing session: 0x12342322c860000
[junit] 2009-08-22 13:01:57,698 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x12342322c860000
[junit] 2009-08-22 13:01:57,698 - INFO [ProcessThread:-1:PrepRequestProcessor@384] - Processed session termination request for id: 0x12342322c860000
[junit] 2009-08-22 13:01:57,707 - INFO [SyncThread:0:NIOServerCnxn@834] - closing session:0x12342322c860000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:48303]
[junit] 2009-08-22 13:01:57,707 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@963] - Exception while closing send thread for session 0x12342322c860000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-08-22 13:01:57,807 - INFO [main:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x12342322c860000
[junit] 2009-08-22 13:01:57,807 - INFO [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
[junit] 2009-08-22 13:01:57,808 - INFO [main:ZooKeeper@510] - Session: 0x12342322c860000 closed
[junit] 2009-08-22 13:01:57,808 - INFO [main:ClientBase@375] - tearDown starting
[junit] 2009-08-22 13:01:57,808 - INFO [main:ZooKeeper@502] - Closing session: 0x12342322c860000
[junit] 2009-08-22 13:01:57,808 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x12342322c860000
[junit] 2009-08-22 13:01:57,808 - INFO [main:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x12342322c860000
[junit] 2009-08-22 13:01:57,808 - INFO [main:ZooKeeper@510] - Session: 0x12342322c860000 closed
[junit] 2009-08-22 13:01:57,809 - INFO [main:ClientBase@352] - STOPPING server
[junit] 2009-08-22 13:01:57,809 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-08-22 13:01:57,809 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-08-22 13:01:57,809 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] 2009-08-22 13:01:57,809 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] ensureOnly:[]
[junit] 2009-08-22 13:01:57,812 - INFO [main:ClientBase@391] - FINISHED testWatcherAutoResetDisabledWithLocal
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 127.712 sec
[junit] 2009-08-22 13:01:58,365 - INFO [main:PortAssignment@31] - assigning port 11221
[junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest
[junit] 2009-08-22 13:01:58,409 - INFO [main:ClientBase@330] - STARTING testQuota
[junit] 2009-08-22 13:01:58,575 - INFO [main:ClientBase@345] - STARTING server
[junit] 2009-08-22 13:01:58,581 - INFO [main:Environment@97] - Server environment:zookeeper.version=3.3.0-806846, built on 08/22/2009 12:41 GMT
[junit] 2009-08-22 13:01:58,582 - INFO [main:Environment@97] - Server environment:host.name=vesta.apache.org
[junit] 2009-08-22 13:01:58,583 - INFO [main:Environment@97] - Server environment:java.version=1.6.0_11
[junit] 2009-08-22 13:01:58,583 - INFO [main:Environment@97] - Server environment:java.vendor=Sun Microsystems Inc.
[junit] 2009-08-22 13:01:58,587 - INFO [main:Environment@97] - Server environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre
[junit] 2009-08-22 13:01:58,588 - INFO [main:Environment@97] - Server environment:java.class.path=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/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 :/home/hudson/tools/clover/latest/lib/clover.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-08-22 13:01:58,588 - 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-08-22 13:01:58,589 - INFO [main:Environment@97] - Server environment:java.io.tmpdir=/tmp
[junit] 2009-08-22 13:01:58,589 - INFO [main:Environment@97] - Server environment:java.compiler=<NA>
[junit] 2009-08-22 13:01:58,595 - INFO [main:Environment@97] - Server environment:os.name=Linux
[junit] 2009-08-22 13:01:58,595 - INFO [main:Environment@97] - Server environment:os.arch=i386
[junit] 2009-08-22 13:01:58,596 - INFO [main:Environment@97] - Server environment:os.version=2.6.27-7-server
[junit] 2009-08-22 13:01:58,596 - INFO [main:Environment@97] - Server environment:user.name=hudson
[junit] 2009-08-22 13:01:58,596 - INFO [main:Environment@97] - Server environment:user.home=/home/hudson
[junit] 2009-08-22 13:01:58,597 - INFO [main:Environment@97] - Server environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk
[junit] 2009-08-22 13:01:58,603 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-08-22 13:01:58,613 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11221
[junit] 2009-08-22 13:01:58,626 - INFO [main:FileTxnSnapLog@208] - Snapshotting: 0
[junit] 2009-08-22 13:01:58,649 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:40094
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-08-22 13:01:58,650 - WARN [NIOServerCxn.Factory:11221:NIOServerCnxn@495] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-08-22 13:01:58,651 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn@834] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11221 remote=/127.0.0.1:40094]
[junit] expect:InMemoryDataTree
[junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] expect:StandaloneServer_port
[junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2009-08-22 13:01:58,683 - INFO [main:ClientBase@341] - Client test setup finished
[junit] 2009-08-22 13:01:58,687 - INFO [main:Environment@97] - Client environment:zookeeper.version=3.3.0-806846, built on 08/22/2009 12:41 GMT
[junit] 2009-08-22 13:01:58,687 - INFO [main:Environment@97] - Client environment:host.name=vesta.apache.org
[junit] 2009-08-22 13:01:58,687 - INFO [main:Environment@97] - Client environment:java.version=1.6.0_11
[junit] 2009-08-22 13:01:58,688 - INFO [main:Environment@97] - Client environment:java.vendor=Sun Microsystems Inc.
[junit] 2009-08-22 13:01:58,688 - INFO [main:Environment@97] - Client environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre
[junit] 2009-08-22 13:01:58,689 - INFO [main:Environment@97] - Client environment:java.class.path=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/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 :/home/hudson/tools/clover/latest/lib/clover.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-08-22 13:01:58,707 - 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-08-22 13:01:58,707 - INFO [main:Environment@97] - Client environment:java.io.tmpdir=/tmp
[junit] 2009-08-22 13:01:58,712 - INFO [main:Environment@97] - Client environment:java.compiler=<NA>
[junit] 2009-08-22 13:01:58,712 - INFO [main:Environment@97] - Client environment:os.name=Linux
[junit] 2009-08-22 13:01:58,713 - INFO [main:Environment@97] - Client environment:os.arch=i386
[junit] 2009-08-22 13:01:58,713 - INFO [main:Environment@97] - Client environment:os.version=2.6.27-7-server
[junit] 2009-08-22 13:01:58,713 - INFO [main:Environment@97] - Client environment:user.name=hudson
[junit] 2009-08-22 13:01:58,714 - INFO [main:Environment@97] - Client environment:user.home=/home/hudson
[junit] 2009-08-22 13:01:58,714 - INFO [main:Environment@97] - Client environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk
[junit] 2009-08-22 13:01:58,715 - INFO [main:ZooKeeper@369] - Initiating client connection, connectString=127.0.0.1:11221 sessionTimeout=30000 watcher=org.apache.zookeeper.test.ClientBase$CountdownWatcher@1ce669e
[junit] 2009-08-22 13:01:58,718 - INFO [main:ClientCnxn@92] - zookeeper.disableAutoWatchReset is false
[junit] 2009-08-22 13:01:58,724 - INFO [main-SendThread():ClientCnxn$SendThread@869] - Attempting connection to server /127.0.0.1:11221
[junit] 2009-08-22 13:01:58,725 - INFO [main-SendThread(localhost:11221):ClientCnxn$SendThread@785] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:40095 remote=localhost/127.0.0.1:11221]
[junit] 2009-08-22 13:01:58,728 - INFO [main-SendThread(localhost:11221):ClientCnxn$SendThread@939] - Server connection successful
[junit] 2009-08-22 13:01:58,730 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn@584] - Connected to /127.0.0.1:40095 lastZxid 0
[junit] 2009-08-22 13:01:58,731 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn@616] - Creating new session 0x1234232f3e60000
[junit] 2009-08-22 13:01:58,829 - INFO [SyncThread:0:NIOServerCnxn@965] - Finished init of 0x1234232f3e60000 valid:true
[junit] expect:0x1234232f3e60000
[junit] found:0x1234232f3e60000 org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x1234232f3e60000
[junit] 2009-08-22 13:01:58,943 - INFO [main:ClientBase@375] - tearDown starting
[junit] 2009-08-22 13:01:58,943 - INFO [main:ZooKeeper@502] - Closing session: 0x1234232f3e60000
[junit] 2009-08-22 13:01:58,944 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x1234232f3e60000
[junit] 2009-08-22 13:01:58,944 - INFO [ProcessThread:-1:PrepRequestProcessor@384] - Processed session termination request for id: 0x1234232f3e60000
[junit] 2009-08-22 13:01:58,952 - INFO [SyncThread:0:NIOServerCnxn@834] - closing session:0x1234232f3e60000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11221 remote=/127.0.0.1:40095]
[junit] 2009-08-22 13:01:58,952 - INFO [main-SendThread(localhost:11221):ClientCnxn$SendThread@963] - Exception while closing send thread for session 0x1234232f3e60000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-08-22 13:01:59,053 - INFO [main:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x1234232f3e60000
[junit] 2009-08-22 13:01:59,053 - INFO [main:ZooKeeper@510] - Session: 0x1234232f3e60000 closed
[junit] 2009-08-22 13:01:59,053 - INFO [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
[junit] 2009-08-22 13:01:59,054 - INFO [main:ClientBase@352] - STOPPING server
[junit] 2009-08-22 13:01:59,054 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-08-22 13:01:59,055 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] 2009-08-22 13:01:59,055 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-08-22 13:01:59,055 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] ensureOnly:[]
[junit] 2009-08-22 13:01:59,058 - INFO [main:ClientBase@391] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.685 sec
BUILD FAILED
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :733: The following error occurred while executing this line:
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :644: Tests failed!
Total time: 20 minutes 39 seconds
Publishing Javadoc
Recording test results
Recording fingerprints
Publishing Clover coverage report...
Hudson build is back to normal: ZooKeeper-trunk #425
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/425/
Build failed in Hudson: ZooKeeper-trunk #424
Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/424/
------------------------------------------
[...truncated 156679 lines...]
[junit] 2009-08-23 10:47:57,000 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-08-23 10:47:57,001 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-08-23 10:47:57,778 - INFO [main-SendThread(localhost:11225):ClientCnxn$SendThread@869] - Attempting connection to server localhost/127.0.0.1:11225
[junit] 2009-08-23 10:47:57,779 - INFO [main-SendThread(localhost:11225):ClientCnxn$SendThread@785] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51305 remote=localhost/127.0.0.1:11225]
[junit] 2009-08-23 10:47:57,779 - INFO [main-SendThread(localhost:11225):ClientCnxn$SendThread@939] - Server connection successful
[junit] 2009-08-23 10:47:57,779 - INFO [NIOServerCxn.Factory:11225:NIOServerCnxn@584] - Connected to /127.0.0.1:51305 lastZxid 6
[junit] 2009-08-23 10:47:57,780 - INFO [NIOServerCxn.Factory:11225:NIOServerCnxn@965] - Finished init of 0x12346de04f90000 valid:true
[junit] 2009-08-23 10:47:57,780 - INFO [NIOServerCxn.Factory:11225:NIOServerCnxn@613] - Renewing session 0x12346de04f90000
[junit] 2009-08-23 10:48:08,817 - INFO [main:ZooKeeper@502] - Closing session: 0x12346de04f90000
[junit] 2009-08-23 10:48:08,817 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x12346de04f90000
[junit] 2009-08-23 10:48:08,818 - INFO [ProcessThread:-1:PrepRequestProcessor@384] - Processed session termination request for id: 0x12346de04f90000
[junit] 2009-08-23 10:48:08,858 - INFO [SyncThread:0:NIOServerCnxn@834] - closing session:0x12346de04f90000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11225 remote=/127.0.0.1:51305]
[junit] 2009-08-23 10:48:08,858 - INFO [main-SendThread(localhost:11225):ClientCnxn$SendThread@963] - Exception while closing send thread for session 0x12346de04f90000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-08-23 10:48:08,959 - INFO [main:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x12346de04f90000
[junit] 2009-08-23 10:48:08,959 - INFO [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
[junit] 2009-08-23 10:48:08,960 - INFO [main:ZooKeeper@510] - Session: 0x12346de04f90000 closed
[junit] 2009-08-23 10:48:08,960 - INFO [main:ClientBase@375] - tearDown starting
[junit] 2009-08-23 10:48:08,960 - INFO [main:ZooKeeper@502] - Closing session: 0x12346de04f90000
[junit] 2009-08-23 10:48:08,960 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x12346de04f90000
[junit] 2009-08-23 10:48:08,960 - INFO [main:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x12346de04f90000
[junit] 2009-08-23 10:48:08,960 - INFO [main:ZooKeeper@510] - Session: 0x12346de04f90000 closed
[junit] 2009-08-23 10:48:08,960 - INFO [main:ClientBase@352] - STOPPING server
[junit] 2009-08-23 10:48:08,961 - INFO [NIOServerCxn.Factory:11225:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-08-23 10:48:08,961 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-08-23 10:48:08,961 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] 2009-08-23 10:48:08,961 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] ensureOnly:[]
[junit] 2009-08-23 10:48:08,964 - INFO [main:ClientBase@391] - FINISHED testWatcherAutoResetDisabledWithGlobal
[junit] 2009-08-23 10:48:08,965 - INFO [main:ClientBase@330] - STARTING testWatcherAutoResetDisabledWithLocal
[junit] 2009-08-23 10:48:08,970 - INFO [main:ClientBase@345] - STARTING server
[junit] 2009-08-23 10:48:08,970 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-08-23 10:48:08,970 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11226
[junit] 2009-08-23 10:48:08,971 - INFO [main:FileTxnSnapLog@208] - Snapshotting: 0
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-08-23 10:48:08,973 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:42266
[junit] 2009-08-23 10:48:08,973 - WARN [NIOServerCxn.Factory:11226:NIOServerCnxn@495] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-08-23 10:48:08,973 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@834] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:42266]
[junit] expect:InMemoryDataTree
[junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] expect:StandaloneServer_port
[junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2009-08-23 10:48:08,974 - INFO [main:ClientBase@341] - Client test setup finished
[junit] 2009-08-23 10:48:08,974 - INFO [main:ZooKeeper@369] - Initiating client connection, connectString=127.0.0.1:11226 sessionTimeout=30000 watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@234265
[junit] 2009-08-23 10:48:08,975 - INFO [main-SendThread():ClientCnxn$SendThread@869] - Attempting connection to server /127.0.0.1:11226
[junit] 2009-08-23 10:48:08,976 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@785] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:42267 remote=localhost/127.0.0.1:11226]
[junit] 2009-08-23 10:48:08,976 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@939] - Server connection successful
[junit] 2009-08-23 10:48:08,976 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /127.0.0.1:42267 lastZxid 0
[junit] 2009-08-23 10:48:08,976 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@616] - Creating new session 0x12346deca0b0000
[junit] 2009-08-23 10:48:09,000 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-08-23 10:48:09,063 - INFO [SyncThread:0:NIOServerCnxn@965] - Finished init of 0x12346deca0b0000 valid:true
[junit] expect:0x12346deca0b0000
[junit] found:0x12346deca0b0000 org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x12346deca0b0000
[junit] 2009-08-23 10:48:09,082 - INFO [main:ClientBase@352] - STOPPING server
[junit] 2009-08-23 10:48:09,083 - INFO [main:NIOServerCnxn@834] - closing session:0x12346deca0b0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:42267]
[junit] 2009-08-23 10:48:09,083 - WARN [main-SendThread(localhost:11226):ClientCnxn$SendThread@969] - Exception closing session 0x12346deca0b0000 to sun.nio.ch.SelectionKeyImpl@c272bc
[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:701)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:947)
[junit] 2009-08-23 10:48:09,083 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-08-23 10:48:09,084 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-08-23 10:48:09,084 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] 2009-08-23 10:48:09,084 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] ensureOnly:[]
[junit] 2009-08-23 10:48:09,183 - INFO [main:ClientBase@345] - STARTING server
[junit] 2009-08-23 10:48:09,184 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-08-23 10:48:09,184 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11226
[junit] 2009-08-23 10:48:09,185 - INFO [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test3033230594525313648.junit.dir/version-2/snapshot.0
[junit] 2009-08-23 10:48:09,186 - INFO [main:FileTxnSnapLog@208] - Snapshotting: 3
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-08-23 10:48:09,188 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:42269
[junit] 2009-08-23 10:48:09,188 - WARN [NIOServerCxn.Factory:11226:NIOServerCnxn@495] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-08-23 10:48:09,189 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@834] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:42269]
[junit] expect:InMemoryDataTree
[junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] expect:StandaloneServer_port
[junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2009-08-23 10:48:11,044 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@869] - Attempting connection to server localhost/127.0.0.1:11226
[junit] 2009-08-23 10:48:11,045 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@785] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:42270 remote=localhost/127.0.0.1:11226]
[junit] 2009-08-23 10:48:11,045 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@939] - Server connection successful
[junit] 2009-08-23 10:48:11,045 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /127.0.0.1:42270 lastZxid 3
[junit] 2009-08-23 10:48:11,046 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of 0x12346deca0b0000 valid:true
[junit] 2009-08-23 10:48:11,046 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session 0x12346deca0b0000
[junit] 2009-08-23 10:48:12,000 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-08-23 10:48:45,102 - INFO [main:ClientBase@352] - STOPPING server
[junit] 2009-08-23 10:48:45,103 - INFO [main:NIOServerCnxn@834] - closing session:0x12346deca0b0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:42270]
[junit] 2009-08-23 10:48:45,103 - WARN [main-SendThread(localhost:11226):ClientCnxn$SendThread@969] - Exception closing session 0x12346deca0b0000 to sun.nio.ch.SelectionKeyImpl@123a389
[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:701)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:947)
[junit] 2009-08-23 10:48:45,104 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-08-23 10:48:45,105 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-08-23 10:48:45,105 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] 2009-08-23 10:48:45,105 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] ensureOnly:[]
[junit] 2009-08-23 10:48:45,204 - INFO [main:ClientBase@345] - STARTING server
[junit] 2009-08-23 10:48:45,204 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-08-23 10:48:45,205 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11226
[junit] 2009-08-23 10:48:45,206 - INFO [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test3033230594525313648.junit.dir/version-2/snapshot.3
[junit] 2009-08-23 10:48:45,207 - INFO [main:FileTxnSnapLog@208] - Snapshotting: 5
[junit] 2009-08-23 10:48:45,209 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:42273
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-08-23 10:48:45,210 - WARN [NIOServerCxn.Factory:11226:NIOServerCnxn@495] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-08-23 10:48:45,210 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@834] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:42273]
[junit] expect:InMemoryDataTree
[junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] expect:StandaloneServer_port
[junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2009-08-23 10:48:46,793 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@869] - Attempting connection to server localhost/127.0.0.1:11226
[junit] 2009-08-23 10:48:46,793 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@785] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:42274 remote=localhost/127.0.0.1:11226]
[junit] 2009-08-23 10:48:46,793 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@939] - Server connection successful
[junit] 2009-08-23 10:48:46,794 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /127.0.0.1:42274 lastZxid 5
[junit] 2009-08-23 10:48:46,794 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of 0x12346deca0b0000 valid:true
[junit] 2009-08-23 10:48:46,794 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session 0x12346deca0b0000
[junit] 2009-08-23 10:48:46,847 - INFO [main:ClientBase@352] - STOPPING server
[junit] 2009-08-23 10:48:46,848 - INFO [main:NIOServerCnxn@834] - closing session:0x12346deca0b0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:42274]
[junit] 2009-08-23 10:48:46,848 - WARN [main-SendThread(localhost:11226):ClientCnxn$SendThread@969] - Exception closing session 0x12346deca0b0000 to sun.nio.ch.SelectionKeyImpl@194e776
[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:701)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:947)
[junit] 2009-08-23 10:48:46,849 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-08-23 10:48:46,849 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-08-23 10:48:46,849 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] 2009-08-23 10:48:46,849 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] ensureOnly:[]
[junit] 2009-08-23 10:48:46,949 - INFO [main:ClientBase@345] - STARTING server
[junit] 2009-08-23 10:48:46,949 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-08-23 10:48:46,950 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11226
[junit] 2009-08-23 10:48:46,951 - INFO [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test3033230594525313648.junit.dir/version-2/snapshot.5
[junit] 2009-08-23 10:48:46,953 - INFO [main:FileTxnSnapLog@208] - Snapshotting: 6
[junit] 2009-08-23 10:48:46,955 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:42276
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-08-23 10:48:46,955 - WARN [NIOServerCxn.Factory:11226:NIOServerCnxn@495] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-08-23 10:48:46,956 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@834] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:42276]
[junit] expect:InMemoryDataTree
[junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] expect:StandaloneServer_port
[junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2009-08-23 10:48:48,000 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-08-23 10:48:48,000 - INFO [SessionTracker:SessionTrackerImpl@143] - SessionTrackerImpl exited loop!
[junit] 2009-08-23 10:48:48,222 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@869] - Attempting connection to server localhost/127.0.0.1:11226
[junit] 2009-08-23 10:48:48,222 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@785] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:42277 remote=localhost/127.0.0.1:11226]
[junit] 2009-08-23 10:48:48,222 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@939] - Server connection successful
[junit] 2009-08-23 10:48:48,223 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@584] - Connected to /127.0.0.1:42277 lastZxid 6
[junit] 2009-08-23 10:48:48,223 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@965] - Finished init of 0x12346deca0b0000 valid:true
[junit] 2009-08-23 10:48:48,223 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn@613] - Renewing session 0x12346deca0b0000
[junit] 2009-08-23 10:48:59,312 - INFO [main:ZooKeeper@502] - Closing session: 0x12346deca0b0000
[junit] 2009-08-23 10:48:59,312 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x12346deca0b0000
[junit] 2009-08-23 10:48:59,314 - INFO [ProcessThread:-1:PrepRequestProcessor@384] - Processed session termination request for id: 0x12346deca0b0000
[junit] 2009-08-23 10:48:59,322 - INFO [SyncThread:0:NIOServerCnxn@834] - closing session:0x12346deca0b0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11226 remote=/127.0.0.1:42277]
[junit] 2009-08-23 10:48:59,322 - INFO [main-SendThread(localhost:11226):ClientCnxn$SendThread@963] - Exception while closing send thread for session 0x12346deca0b0000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-08-23 10:48:59,422 - INFO [main:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x12346deca0b0000
[junit] 2009-08-23 10:48:59,424 - INFO [main:ZooKeeper@510] - Session: 0x12346deca0b0000 closed
[junit] 2009-08-23 10:48:59,424 - INFO [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
[junit] 2009-08-23 10:48:59,424 - INFO [main:ClientBase@375] - tearDown starting
[junit] 2009-08-23 10:48:59,425 - INFO [main:ZooKeeper@502] - Closing session: 0x12346deca0b0000
[junit] 2009-08-23 10:48:59,425 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x12346deca0b0000
[junit] 2009-08-23 10:48:59,425 - INFO [main:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x12346deca0b0000
[junit] 2009-08-23 10:48:59,425 - INFO [main:ZooKeeper@510] - Session: 0x12346deca0b0000 closed
[junit] 2009-08-23 10:48:59,425 - INFO [main:ClientBase@352] - STOPPING server
[junit] 2009-08-23 10:48:59,425 - INFO [NIOServerCxn.Factory:11226:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-08-23 10:48:59,426 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-08-23 10:48:59,426 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] 2009-08-23 10:48:59,426 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] ensureOnly:[]
[junit] 2009-08-23 10:48:59,429 - INFO [main:ClientBase@391] - FINISHED testWatcherAutoResetDisabledWithLocal
[junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 126.48 sec
[junit] 2009-08-23 10:48:59,978 - INFO [main:PortAssignment@31] - assigning port 11221
[junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest
[junit] 2009-08-23 10:49:00,021 - INFO [main:ClientBase@330] - STARTING testQuota
[junit] 2009-08-23 10:49:00,180 - INFO [main:ClientBase@345] - STARTING server
[junit] 2009-08-23 10:49:00,187 - INFO [main:Environment@97] - Server environment:zookeeper.version=3.3.0-806950, built on 08/23/2009 10:32 GMT
[junit] 2009-08-23 10:49:00,188 - INFO [main:Environment@97] - Server environment:host.name=vesta.apache.org
[junit] 2009-08-23 10:49:00,188 - INFO [main:Environment@97] - Server environment:java.version=1.6.0_11
[junit] 2009-08-23 10:49:00,189 - INFO [main:Environment@97] - Server environment:java.vendor=Sun Microsystems Inc.
[junit] 2009-08-23 10:49:00,193 - INFO [main:Environment@97] - Server environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre
[junit] 2009-08-23 10:49:00,194 - INFO [main:Environment@97] - Server environment:java.class.path=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/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 :/home/hudson/tools/clover/latest/lib/clover.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-08-23 10:49:00,194 - 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-08-23 10:49:00,195 - INFO [main:Environment@97] - Server environment:java.io.tmpdir=/tmp
[junit] 2009-08-23 10:49:00,195 - INFO [main:Environment@97] - Server environment:java.compiler=<NA>
[junit] 2009-08-23 10:49:00,201 - INFO [main:Environment@97] - Server environment:os.name=Linux
[junit] 2009-08-23 10:49:00,201 - INFO [main:Environment@97] - Server environment:os.arch=i386
[junit] 2009-08-23 10:49:00,202 - INFO [main:Environment@97] - Server environment:os.version=2.6.27-7-server
[junit] 2009-08-23 10:49:00,202 - INFO [main:Environment@97] - Server environment:user.name=hudson
[junit] 2009-08-23 10:49:00,202 - INFO [main:Environment@97] - Server environment:user.home=/home/hudson
[junit] 2009-08-23 10:49:00,203 - INFO [main:Environment@97] - Server environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk
[junit] 2009-08-23 10:49:00,207 - INFO [main:ZooKeeperServer@160] - Created server
[junit] 2009-08-23 10:49:00,218 - INFO [main:NIOServerCnxn$Factory@122] - binding to port 11221
[junit] 2009-08-23 10:49:00,230 - INFO [main:FileTxnSnapLog@208] - Snapshotting: 0
[junit] 2009-08-23 10:49:00,256 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn@699] - Processing stat command from /127.0.0.1:51016
[junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2009-08-23 10:49:00,257 - WARN [NIOServerCxn.Factory:11221:NIOServerCnxn@495] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
[junit] 2009-08-23 10:49:00,257 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn@834] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11221 remote=/127.0.0.1:51016]
[junit] expect:InMemoryDataTree
[junit] found:InMemoryDataTree org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] expect:StandaloneServer_port
[junit] found:StandaloneServer_port org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2009-08-23 10:49:00,293 - INFO [main:ClientBase@341] - Client test setup finished
[junit] 2009-08-23 10:49:00,297 - INFO [main:Environment@97] - Client environment:zookeeper.version=3.3.0-806950, built on 08/23/2009 10:32 GMT
[junit] 2009-08-23 10:49:00,297 - INFO [main:Environment@97] - Client environment:host.name=vesta.apache.org
[junit] 2009-08-23 10:49:00,298 - INFO [main:Environment@97] - Client environment:java.version=1.6.0_11
[junit] 2009-08-23 10:49:00,298 - INFO [main:Environment@97] - Client environment:java.vendor=Sun Microsystems Inc.
[junit] 2009-08-23 10:49:00,298 - INFO [main:Environment@97] - Client environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre
[junit] 2009-08-23 10:49:00,299 - INFO [main:Environment@97] - Client environment:java.class.path=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/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 :/home/hudson/tools/clover/latest/lib/clover.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-08-23 10:49:00,317 - 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-08-23 10:49:00,317 - INFO [main:Environment@97] - Client environment:java.io.tmpdir=/tmp
[junit] 2009-08-23 10:49:00,331 - INFO [main:Environment@97] - Client environment:java.compiler=<NA>
[junit] 2009-08-23 10:49:00,331 - INFO [main:Environment@97] - Client environment:os.name=Linux
[junit] 2009-08-23 10:49:00,331 - INFO [main:Environment@97] - Client environment:os.arch=i386
[junit] 2009-08-23 10:49:00,332 - INFO [main:Environment@97] - Client environment:os.version=2.6.27-7-server
[junit] 2009-08-23 10:49:00,332 - INFO [main:Environment@97] - Client environment:user.name=hudson
[junit] 2009-08-23 10:49:00,333 - INFO [main:Environment@97] - Client environment:user.home=/home/hudson
[junit] 2009-08-23 10:49:00,333 - INFO [main:Environment@97] - Client environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk
[junit] 2009-08-23 10:49:00,334 - INFO [main:ZooKeeper@369] - Initiating client connection, connectString=127.0.0.1:11221 sessionTimeout=30000 watcher=org.apache.zookeeper.test.ClientBase$CountdownWatcher@15e2075
[junit] 2009-08-23 10:49:00,336 - INFO [main:ClientCnxn@92] - zookeeper.disableAutoWatchReset is false
[junit] 2009-08-23 10:49:00,343 - INFO [main-SendThread():ClientCnxn$SendThread@869] - Attempting connection to server /127.0.0.1:11221
[junit] 2009-08-23 10:49:00,344 - INFO [main-SendThread(localhost:11221):ClientCnxn$SendThread@785] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:51017 remote=localhost/127.0.0.1:11221]
[junit] 2009-08-23 10:49:00,347 - INFO [main-SendThread(localhost:11221):ClientCnxn$SendThread@939] - Server connection successful
[junit] 2009-08-23 10:49:00,348 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn@584] - Connected to /127.0.0.1:51017 lastZxid 0
[junit] 2009-08-23 10:49:00,349 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn@616] - Creating new session 0x12346df924a0000
[junit] 2009-08-23 10:49:00,449 - INFO [SyncThread:0:NIOServerCnxn@965] - Finished init of 0x12346df924a0000 valid:true
[junit] expect:0x12346df924a0000
[junit] found:0x12346df924a0000 org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x12346df924a0000
[junit] 2009-08-23 10:49:00,552 - INFO [main:ClientBase@375] - tearDown starting
[junit] 2009-08-23 10:49:00,555 - INFO [main:ZooKeeper@502] - Closing session: 0x12346df924a0000
[junit] 2009-08-23 10:49:00,556 - INFO [main:ClientCnxn@1070] - Closing ClientCnxn for session: 0x12346df924a0000
[junit] 2009-08-23 10:49:00,556 - INFO [ProcessThread:-1:PrepRequestProcessor@384] - Processed session termination request for id: 0x12346df924a0000
[junit] 2009-08-23 10:49:00,564 - INFO [SyncThread:0:NIOServerCnxn@834] - closing session:0x12346df924a0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:11221 remote=/127.0.0.1:51017]
[junit] 2009-08-23 10:49:00,565 - INFO [main-SendThread(localhost:11221):ClientCnxn$SendThread@963] - Exception while closing send thread for session 0x12346df924a0000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
[junit] 2009-08-23 10:49:00,665 - INFO [main:ClientCnxn@1056] - Disconnecting ClientCnxn for session: 0x12346df924a0000
[junit] 2009-08-23 10:49:00,666 - INFO [main:ZooKeeper@510] - Session: 0x12346df924a0000 closed
[junit] 2009-08-23 10:49:00,666 - INFO [main-EventThread:ClientCnxn$EventThread@514] - EventThread shut down
[junit] 2009-08-23 10:49:00,666 - INFO [main:ClientBase@352] - STOPPING server
[junit] 2009-08-23 10:49:00,667 - INFO [NIOServerCxn.Factory:11221:NIOServerCnxn$Factory@236] - NIOServerCnxn factory exited run method
[junit] 2009-08-23 10:49:00,670 - INFO [main:FinalRequestProcessor@283] - shutdown of request processor complete
[junit] 2009-08-23 10:49:00,670 - INFO [ProcessThread:-1:PrepRequestProcessor@119] - PrepRequestProcessor exited loop!
[junit] 2009-08-23 10:49:00,670 - INFO [SyncThread:0:SyncRequestProcessor@134] - SyncRequestProcessor exited!
[junit] ensureOnly:[]
[junit] 2009-08-23 10:49:00,673 - INFO [main:ClientBase@391] - FINISHED testQuota
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.69 sec
BUILD FAILED
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :733: The following error occurred while executing this line:
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :644: Tests failed!
Total time: 16 minutes 3 seconds
Publishing Javadoc
Recording test results
Recording fingerprints
Publishing Clover coverage report...