You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@zookeeper.apache.org by Apache Hudson Server <hu...@hudson.zones.apache.org> on 2009/05/21 21:01:15 UTC

Build failed in Hudson: ZooKeeper-trunk #320

See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/320/

------------------------------------------
[...truncated 125963 lines...]
    [junit] 	at org.apache.zookeeper.ClientCnxn$SendThread.doIO(ClientCnxn.java:653)
    [junit] 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:897)
    [junit] 2009-05-21 19:18:58,212 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@190] - NIOServerCnxn factory exited run method
    [junit] 2009-05-21 19:18:58,213 - INFO  [main:FinalRequestProcessor@268] - shutdown of request processor complete
    [junit] 2009-05-21 19:18:58,213 - INFO  [SyncThread:0:SyncRequestProcessor@118] - SyncRequestProcessor exited!
    [junit] ensureOnly:[]
    [junit] 2009-05-21 19:18:58,213 - INFO  [ProcessThread:-1:PrepRequestProcessor@109] - PrepRequestProcessor exited loop!
    [junit] 2009-05-21 19:18:58,312 - INFO  [main:ClientBase@316] - STARTING server
    [junit] 2009-05-21 19:18:58,313 - INFO  [main:ZooKeeperServer@160] - Created server
    [junit] 2009-05-21 19:18:58,314 - INFO  [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test5747648790557940842.junit.dir/version-2/snapshot.5 
    [junit] 2009-05-21 19:18:58,316 - INFO  [main:FileTxnSnapLog@198] - Snapshotting: 6
    [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2009-05-21 19:18:58,318 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@646] - Processing stat command from /127.0.0.1:60901
    [junit] 2009-05-21 19:18:58,318 - WARN  [NIOServerCxn.Factory:33221:NIOServerCnxn@444] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
    [junit] 2009-05-21 19:18:58,319 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@777] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60901]
    [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-05-21 19:18:59,874 - INFO  [main-SendThread:ClientCnxn$SendThread@821] - Attempting connection to server /127.0.0.1:33221
    [junit] 2009-05-21 19:18:59,874 - INFO  [main-SendThread:ClientCnxn$SendThread@737] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:60902 remote=/127.0.0.1:33221]
    [junit] 2009-05-21 19:18:59,875 - INFO  [main-SendThread:ClientCnxn$SendThread@889] - Server connection successful
    [junit] 2009-05-21 19:18:59,875 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@532] - Connected to /127.0.0.1:60902 lastZxid 6
    [junit] 2009-05-21 19:18:59,875 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@906] - Finished init of 0x121649c1c690000 valid:true
    [junit] 2009-05-21 19:18:59,876 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@560] - Renewing session 0x121649c1c690000
    [junit] 2009-05-21 19:19:00,000 - INFO  [SessionTracker:SessionTrackerImpl@141] - SessionTrackerImpl exited loop!
    [junit] 2009-05-21 19:19:10,962 - INFO  [main:ZooKeeper@437] - Closing session: 0x121649c1c690000
    [junit] 2009-05-21 19:19:10,962 - INFO  [main:ClientCnxn@1020] - Closing ClientCnxn for session: 0x121649c1c690000
    [junit] 2009-05-21 19:19:10,963 - INFO  [ProcessThread:-1:PrepRequestProcessor@363] - Processed session termination request for id: 0x121649c1c690000
    [junit] 2009-05-21 19:19:10,973 - INFO  [SyncThread:0:NIOServerCnxn@777] - closing session:0x121649c1c690000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60902]
    [junit] 2009-05-21 19:19:10,974 - INFO  [main-SendThread:ClientCnxn$SendThread@913] - Exception while closing send thread for session 0x121649c1c690000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
    [junit] 2009-05-21 19:19:11,074 - INFO  [main:ClientCnxn@1006] - Disconnecting ClientCnxn for session: 0x121649c1c690000
    [junit] 2009-05-21 19:19:11,075 - INFO  [main:ZooKeeper@445] - Session: 0x121649c1c690000 closed
    [junit] 2009-05-21 19:19:11,075 - INFO  [main-EventThread:ClientCnxn$EventThread@473] - EventThread shut down
    [junit] 2009-05-21 19:19:11,075 - INFO  [main:ClientBase@332] - tearDown starting
    [junit] 2009-05-21 19:19:11,075 - INFO  [main:ClientBase@323] - STOPPING server
    [junit] 2009-05-21 19:19:11,076 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@190] - NIOServerCnxn factory exited run method
    [junit] 2009-05-21 19:19:11,076 - INFO  [main:FinalRequestProcessor@268] - shutdown of request processor complete
    [junit] 2009-05-21 19:19:11,076 - INFO  [ProcessThread:-1:PrepRequestProcessor@109] - PrepRequestProcessor exited loop!
    [junit] 2009-05-21 19:19:11,076 - INFO  [SyncThread:0:SyncRequestProcessor@118] - SyncRequestProcessor exited!
    [junit] ensureOnly:[]
    [junit] 2009-05-21 19:19:11,079 - INFO  [main:ClientBase@344] - FINISHED testWatcherAutoResetDisabledWithGlobal
    [junit] 2009-05-21 19:19:11,080 - INFO  [main:ClientBase@302] - STARTING testWatcherAutoResetDisabledWithLocal
    [junit] 2009-05-21 19:19:11,084 - INFO  [main:ClientBase@316] - STARTING server
    [junit] 2009-05-21 19:19:11,085 - INFO  [main:ZooKeeperServer@160] - Created server
    [junit] 2009-05-21 19:19:11,086 - INFO  [main:FileTxnSnapLog@198] - Snapshotting: 0
    [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2009-05-21 19:19:11,087 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@646] - Processing stat command from /127.0.0.1:60904
    [junit] 2009-05-21 19:19:11,088 - WARN  [NIOServerCxn.Factory:33221:NIOServerCnxn@444] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
    [junit] 2009-05-21 19:19:11,088 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@777] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60904]
    [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-05-21 19:19:11,089 - INFO  [main:ClientBase@312] - Client test setup finished
    [junit] 2009-05-21 19:19:11,089 - INFO  [main:ZooKeeper@342] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=30000 watcher=org.apache.zookeeper.test.WatcherTest$MyWatcher@adf5be
    [junit] 2009-05-21 19:19:11,089 - INFO  [main-SendThread:ClientCnxn$SendThread@821] - Attempting connection to server /127.0.0.1:33221
    [junit] 2009-05-21 19:19:11,090 - INFO  [main-SendThread:ClientCnxn$SendThread@737] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:60905 remote=/127.0.0.1:33221]
    [junit] 2009-05-21 19:19:11,090 - INFO  [main-SendThread:ClientCnxn$SendThread@889] - Server connection successful
    [junit] 2009-05-21 19:19:11,090 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@532] - Connected to /127.0.0.1:60905 lastZxid 0
    [junit] 2009-05-21 19:19:11,091 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@563] - Creating new session 0x121649cdfee0000
    [junit] 2009-05-21 19:19:11,175 - INFO  [SyncThread:0:NIOServerCnxn@906] - Finished init of 0x121649cdfee0000 valid:true
    [junit] expect:0x121649cdfee0000
    [junit] found:0x121649cdfee0000 org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x121649cdfee0000
    [junit] 2009-05-21 19:19:11,192 - INFO  [main:ClientBase@323] - STOPPING server
    [junit] 2009-05-21 19:19:11,193 - INFO  [main:NIOServerCnxn@777] - closing session:0x121649cdfee0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60905]
    [junit] 2009-05-21 19:19:11,193 - WARN  [main-SendThread:ClientCnxn$SendThread@919] - Exception closing session 0x121649cdfee0000 to sun.nio.ch.SelectionKeyImpl@9fdee
    [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:653)
    [junit] 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:897)
    [junit] 2009-05-21 19:19:11,193 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@190] - NIOServerCnxn factory exited run method
    [junit] 2009-05-21 19:19:11,194 - INFO  [main:FinalRequestProcessor@268] - shutdown of request processor complete
    [junit] 2009-05-21 19:19:11,194 - INFO  [SyncThread:0:SyncRequestProcessor@118] - SyncRequestProcessor exited!
    [junit] 2009-05-21 19:19:11,194 - INFO  [ProcessThread:-1:PrepRequestProcessor@109] - PrepRequestProcessor exited loop!
    [junit] ensureOnly:[]
    [junit] 2009-05-21 19:19:11,293 - INFO  [main:ClientBase@316] - STARTING server
    [junit] 2009-05-21 19:19:11,294 - INFO  [main:ZooKeeperServer@160] - Created server
    [junit] 2009-05-21 19:19:11,295 - INFO  [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8897024993216438962.junit.dir/version-2/snapshot.0 
    [junit] 2009-05-21 19:19:11,296 - INFO  [main:FileTxnSnapLog@198] - Snapshotting: 3
    [junit] 2009-05-21 19:19:11,299 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@646] - Processing stat command from /127.0.0.1:60907
    [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2009-05-21 19:19:11,299 - WARN  [NIOServerCxn.Factory:33221:NIOServerCnxn@444] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
    [junit] 2009-05-21 19:19:11,300 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@777] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60907]
    [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-05-21 19:19:12,000 - INFO  [SessionTracker:SessionTrackerImpl@141] - SessionTrackerImpl exited loop!
    [junit] 2009-05-21 19:19:12,000 - INFO  [SessionTracker:SessionTrackerImpl@141] - SessionTrackerImpl exited loop!
    [junit] 2009-05-21 19:19:13,105 - INFO  [main-SendThread:ClientCnxn$SendThread@821] - Attempting connection to server /127.0.0.1:33221
    [junit] 2009-05-21 19:19:13,106 - INFO  [main-SendThread:ClientCnxn$SendThread@737] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:60908 remote=/127.0.0.1:33221]
    [junit] 2009-05-21 19:19:13,106 - INFO  [main-SendThread:ClientCnxn$SendThread@889] - Server connection successful
    [junit] 2009-05-21 19:19:13,106 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@532] - Connected to /127.0.0.1:60908 lastZxid 3
    [junit] 2009-05-21 19:19:13,107 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@906] - Finished init of 0x121649cdfee0000 valid:true
    [junit] 2009-05-21 19:19:13,107 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@560] - Renewing session 0x121649cdfee0000
    [junit] 2009-05-21 19:19:47,184 - INFO  [main:ClientBase@323] - STOPPING server
    [junit] 2009-05-21 19:19:47,184 - INFO  [main:NIOServerCnxn@777] - closing session:0x121649cdfee0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60908]
    [junit] 2009-05-21 19:19:47,185 - WARN  [main-SendThread:ClientCnxn$SendThread@919] - Exception closing session 0x121649cdfee0000 to sun.nio.ch.SelectionKeyImpl@18b1f8f
    [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:653)
    [junit] 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:897)
    [junit] 2009-05-21 19:19:47,185 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@190] - NIOServerCnxn factory exited run method
    [junit] 2009-05-21 19:19:47,186 - INFO  [ProcessThread:-1:PrepRequestProcessor@109] - PrepRequestProcessor exited loop!
    [junit] 2009-05-21 19:19:47,186 - INFO  [main:FinalRequestProcessor@268] - shutdown of request processor complete
    [junit] 2009-05-21 19:19:47,186 - INFO  [SyncThread:0:SyncRequestProcessor@118] - SyncRequestProcessor exited!
    [junit] ensureOnly:[]
    [junit] 2009-05-21 19:19:47,285 - INFO  [main:ClientBase@316] - STARTING server
    [junit] 2009-05-21 19:19:47,285 - INFO  [main:ZooKeeperServer@160] - Created server
    [junit] 2009-05-21 19:19:47,287 - INFO  [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8897024993216438962.junit.dir/version-2/snapshot.3 
    [junit] 2009-05-21 19:19:47,288 - INFO  [main:FileTxnSnapLog@198] - Snapshotting: 5
    [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2009-05-21 19:19:47,290 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@646] - Processing stat command from /127.0.0.1:60911
    [junit] 2009-05-21 19:19:47,291 - WARN  [NIOServerCxn.Factory:33221:NIOServerCnxn@444] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
    [junit] 2009-05-21 19:19:47,291 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@777] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60911]
    [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-05-21 19:19:48,000 - INFO  [SessionTracker:SessionTrackerImpl@141] - SessionTrackerImpl exited loop!
    [junit] 2009-05-21 19:19:49,222 - INFO  [main-SendThread:ClientCnxn$SendThread@821] - Attempting connection to server /127.0.0.1:33221
    [junit] 2009-05-21 19:19:49,222 - INFO  [main-SendThread:ClientCnxn$SendThread@737] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:60912 remote=/127.0.0.1:33221]
    [junit] 2009-05-21 19:19:49,222 - INFO  [main-SendThread:ClientCnxn$SendThread@889] - Server connection successful
    [junit] 2009-05-21 19:19:49,223 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@532] - Connected to /127.0.0.1:60912 lastZxid 5
    [junit] 2009-05-21 19:19:49,223 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@906] - Finished init of 0x121649cdfee0000 valid:true
    [junit] 2009-05-21 19:19:49,223 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@560] - Renewing session 0x121649cdfee0000
    [junit] 2009-05-21 19:19:49,270 - INFO  [main:ClientBase@323] - STOPPING server
    [junit] 2009-05-21 19:19:49,271 - INFO  [main:NIOServerCnxn@777] - closing session:0x121649cdfee0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60912]
    [junit] 2009-05-21 19:19:49,271 - WARN  [main-SendThread:ClientCnxn$SendThread@919] - Exception closing session 0x121649cdfee0000 to sun.nio.ch.SelectionKeyImpl@5ff916
    [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:653)
    [junit] 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:897)
    [junit] 2009-05-21 19:19:49,273 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@190] - NIOServerCnxn factory exited run method
    [junit] 2009-05-21 19:19:49,273 - INFO  [main:FinalRequestProcessor@268] - shutdown of request processor complete
    [junit] 2009-05-21 19:19:49,273 - INFO  [SyncThread:0:SyncRequestProcessor@118] - SyncRequestProcessor exited!
    [junit] ensureOnly:[]
    [junit] 2009-05-21 19:19:49,273 - INFO  [ProcessThread:-1:PrepRequestProcessor@109] - PrepRequestProcessor exited loop!
    [junit] 2009-05-21 19:19:49,372 - INFO  [main:ClientBase@316] - STARTING server
    [junit] 2009-05-21 19:19:49,372 - INFO  [main:ZooKeeperServer@160] - Created server
    [junit] 2009-05-21 19:19:49,373 - INFO  [main:FileSnap@81] - Reading snapshot http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/test/tmp/test8897024993216438962.junit.dir/version-2/snapshot.5 
    [junit] 2009-05-21 19:19:49,375 - INFO  [main:FileTxnSnapLog@198] - Snapshotting: 6
    [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2009-05-21 19:19:49,377 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@646] - Processing stat command from /127.0.0.1:60914
    [junit] 2009-05-21 19:19:49,377 - WARN  [NIOServerCxn.Factory:33221:NIOServerCnxn@444] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
    [junit] 2009-05-21 19:19:49,377 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@777] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60914]
    [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-05-21 19:19:50,784 - INFO  [main-SendThread:ClientCnxn$SendThread@821] - Attempting connection to server /127.0.0.1:33221
    [junit] 2009-05-21 19:19:50,784 - INFO  [main-SendThread:ClientCnxn$SendThread@737] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:60915 remote=/127.0.0.1:33221]
    [junit] 2009-05-21 19:19:50,784 - INFO  [main-SendThread:ClientCnxn$SendThread@889] - Server connection successful
    [junit] 2009-05-21 19:19:50,784 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@532] - Connected to /127.0.0.1:60915 lastZxid 6
    [junit] 2009-05-21 19:19:50,785 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@906] - Finished init of 0x121649cdfee0000 valid:true
    [junit] 2009-05-21 19:19:50,785 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@560] - Renewing session 0x121649cdfee0000
    [junit] 2009-05-21 19:19:51,000 - INFO  [SessionTracker:SessionTrackerImpl@141] - SessionTrackerImpl exited loop!
    [junit] 2009-05-21 19:20:01,871 - INFO  [main:ZooKeeper@437] - Closing session: 0x121649cdfee0000
    [junit] 2009-05-21 19:20:01,871 - INFO  [main:ClientCnxn@1020] - Closing ClientCnxn for session: 0x121649cdfee0000
    [junit] 2009-05-21 19:20:01,872 - INFO  [ProcessThread:-1:PrepRequestProcessor@363] - Processed session termination request for id: 0x121649cdfee0000
    [junit] 2009-05-21 19:20:01,881 - INFO  [SyncThread:0:NIOServerCnxn@777] - closing session:0x121649cdfee0000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60915]
    [junit] 2009-05-21 19:20:01,882 - INFO  [main-SendThread:ClientCnxn$SendThread@913] - Exception while closing send thread for session 0x121649cdfee0000 : Read error rc = -1 java.nio.DirectByteBuffer[pos=0 lim=4 cap=4]
    [junit] 2009-05-21 19:20:01,982 - INFO  [main:ClientCnxn@1006] - Disconnecting ClientCnxn for session: 0x121649cdfee0000
    [junit] 2009-05-21 19:20:01,982 - INFO  [main:ZooKeeper@445] - Session: 0x121649cdfee0000 closed
    [junit] 2009-05-21 19:20:01,982 - INFO  [main-EventThread:ClientCnxn$EventThread@473] - EventThread shut down
    [junit] 2009-05-21 19:20:01,982 - INFO  [main:ClientBase@332] - tearDown starting
    [junit] 2009-05-21 19:20:01,983 - INFO  [main:ClientBase@323] - STOPPING server
    [junit] 2009-05-21 19:20:01,983 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@190] - NIOServerCnxn factory exited run method
    [junit] 2009-05-21 19:20:01,984 - INFO  [main:FinalRequestProcessor@268] - shutdown of request processor complete
    [junit] 2009-05-21 19:20:01,984 - INFO  [ProcessThread:-1:PrepRequestProcessor@109] - PrepRequestProcessor exited loop!
    [junit] 2009-05-21 19:20:01,984 - INFO  [SyncThread:0:SyncRequestProcessor@118] - SyncRequestProcessor exited!
    [junit] ensureOnly:[]
    [junit] 2009-05-21 19:20:01,987 - INFO  [main:ClientBase@344] - FINISHED testWatcherAutoResetDisabledWithLocal
    [junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 127.33 sec
    [junit] Running org.apache.zookeeper.test.ZooKeeperQuotaTest
    [junit] 2009-05-21 19:20:02,642 - INFO  [main:ClientBase@302] - STARTING testQuota
    [junit] 2009-05-21 19:20:02,783 - INFO  [main:ClientBase@316] - STARTING server
    [junit] 2009-05-21 19:20:02,788 - INFO  [main:Environment@97] - Server environment:zookeeper.version=3.2.0-777217, built on 05/21/2009 19:06 GMT
    [junit] 2009-05-21 19:20:02,789 - INFO  [main:Environment@97] - Server environment:host.name=vesta.apache.org
    [junit] 2009-05-21 19:20:02,790 - INFO  [main:Environment@97] - Server environment:java.version=1.6.0_11
    [junit] 2009-05-21 19:20:02,790 - INFO  [main:Environment@97] - Server environment:java.vendor=Sun Microsystems Inc.
    [junit] 2009-05-21 19:20:02,792 - INFO  [main:Environment@97] - Server environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre
    [junit] 2009-05-21 19:20:02,793 - 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/jdiff-1.0.9.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/jline-0.9.94.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/junit-4.4.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/log4j-1.2.15.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/xerces-1.4.4.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/testclasses :/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant-launcher.jar:/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant.jar:/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant-junit.jar
    [junit] 2009-05-21 19:20:02,796 - INFO  [main:Environment@97] - Server environment:java.library.path=/home/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386/server:/home/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386:/home/hudson/tools/java/jdk1.6.0_11-32/jre/../lib/i386:/usr/java/packages/lib/i386:/lib:/usr/lib
    [junit] 2009-05-21 19:20:02,796 - INFO  [main:Environment@97] - Server environment:java.io.tmpdir=/tmp
    [junit] 2009-05-21 19:20:02,796 - INFO  [main:Environment@97] - Server environment:java.compiler=<NA>
    [junit] 2009-05-21 19:20:02,802 - INFO  [main:Environment@97] - Server environment:os.name=Linux
    [junit] 2009-05-21 19:20:02,803 - INFO  [main:Environment@97] - Server environment:os.arch=i386
    [junit] 2009-05-21 19:20:02,803 - INFO  [main:Environment@97] - Server environment:os.version=2.6.27-7-server
    [junit] 2009-05-21 19:20:02,803 - INFO  [main:Environment@97] - Server environment:user.name=hudson
    [junit] 2009-05-21 19:20:02,804 - INFO  [main:Environment@97] - Server environment:user.home=/home/hudson
    [junit] 2009-05-21 19:20:02,804 - INFO  [main:Environment@97] - Server environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk 
    [junit] 2009-05-21 19:20:02,808 - INFO  [main:ZooKeeperServer@160] - Created server
    [junit] 2009-05-21 19:20:02,822 - INFO  [main:FileTxnSnapLog@198] - Snapshotting: 0
    [junit] 2009-05-21 19:20:02,840 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@646] - Processing stat command from /127.0.0.1:60919
    [junit] ensureOnly:[InMemoryDataTree, StandaloneServer_port]
    [junit] 2009-05-21 19:20:02,841 - WARN  [NIOServerCxn.Factory:33221:NIOServerCnxn@444] - Exception causing close of session 0x0 due to java.io.IOException: Responded to info probe
    [junit] 2009-05-21 19:20:02,842 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@777] - closing session:0x0 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60919]
    [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-05-21 19:20:02,877 - INFO  [main:ClientBase@312] - Client test setup finished
    [junit] 2009-05-21 19:20:02,880 - INFO  [main:Environment@97] - Client environment:zookeeper.version=3.2.0-777217, built on 05/21/2009 19:06 GMT
    [junit] 2009-05-21 19:20:02,880 - INFO  [main:Environment@97] - Client environment:host.name=vesta.apache.org
    [junit] 2009-05-21 19:20:02,881 - INFO  [main:Environment@97] - Client environment:java.version=1.6.0_11
    [junit] 2009-05-21 19:20:02,899 - INFO  [main:Environment@97] - Client environment:java.vendor=Sun Microsystems Inc.
    [junit] 2009-05-21 19:20:02,899 - INFO  [main:Environment@97] - Client environment:java.home=/home/hudson/tools/java/jdk1.6.0_11-32/jre
    [junit] 2009-05-21 19:20:02,899 - 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/jdiff-1.0.9.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/jline-0.9.94.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/junit-4.4.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/log4j-1.2.15.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/src/java/lib/xerces-1.4.4.jar :http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build/testclasses :/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant-launcher.jar:/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant.jar:/home/hudson/tools/ant/apache-ant-1.7.0/lib/ant-junit.jar
    [junit] 2009-05-21 19:20:02,913 - INFO  [main:Environment@97] - Client environment:java.library.path=/home/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386/server:/home/hudson/tools/java/jdk1.6.0_11-32/jre/lib/i386:/home/hudson/tools/java/jdk1.6.0_11-32/jre/../lib/i386:/usr/java/packages/lib/i386:/lib:/usr/lib
    [junit] 2009-05-21 19:20:02,913 - INFO  [main:Environment@97] - Client environment:java.io.tmpdir=/tmp
    [junit] 2009-05-21 19:20:02,913 - INFO  [main:Environment@97] - Client environment:java.compiler=<NA>
    [junit] 2009-05-21 19:20:02,914 - INFO  [main:Environment@97] - Client environment:os.name=Linux
    [junit] 2009-05-21 19:20:02,914 - INFO  [main:Environment@97] - Client environment:os.arch=i386
    [junit] 2009-05-21 19:20:02,915 - INFO  [main:Environment@97] - Client environment:os.version=2.6.27-7-server
    [junit] 2009-05-21 19:20:02,915 - INFO  [main:Environment@97] - Client environment:user.name=hudson
    [junit] 2009-05-21 19:20:02,915 - INFO  [main:Environment@97] - Client environment:user.home=/home/hudson
    [junit] 2009-05-21 19:20:02,916 - INFO  [main:Environment@97] - Client environment:user.dir=http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk 
    [junit] 2009-05-21 19:20:02,917 - INFO  [main:ZooKeeper@342] - Initiating client connection, host=127.0.0.1:33221 sessionTimeout=30000 watcher=org.apache.zookeeper.test.ClientBase$CountdownWatcher@76e8a7
    [junit] 2009-05-21 19:20:02,918 - INFO  [main:ClientCnxn@91] - zookeeper.disableAutoWatchReset is false
    [junit] 2009-05-21 19:20:02,923 - INFO  [main-SendThread:ClientCnxn$SendThread@821] - Attempting connection to server /127.0.0.1:33221
    [junit] 2009-05-21 19:20:02,924 - INFO  [main-SendThread:ClientCnxn$SendThread@737] - Priming connection to java.nio.channels.SocketChannel[connected local=/127.0.0.1:60920 remote=/127.0.0.1:33221]
    [junit] 2009-05-21 19:20:02,927 - INFO  [main-SendThread:ClientCnxn$SendThread@889] - Server connection successful
    [junit] 2009-05-21 19:20:02,929 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@532] - Connected to /127.0.0.1:60920 lastZxid 0
    [junit] 2009-05-21 19:20:02,930 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn@563] - Creating new session 0x121649daa090000
    [junit] 2009-05-21 19:20:03,011 - INFO  [SyncThread:0:NIOServerCnxn@906] - Finished init of 0x121649daa090000 valid:true
    [junit] expect:0x121649daa090000
    [junit] found:0x121649daa090000 org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x121649daa090000
    [junit] 2009-05-21 19:20:03,105 - INFO  [main:ClientBase@332] - tearDown starting
    [junit] 2009-05-21 19:20:03,106 - INFO  [main:ClientBase@323] - STOPPING server
    [junit] 2009-05-21 19:20:03,107 - INFO  [main:NIOServerCnxn@777] - closing session:0x121649daa090000 NIOServerCnxn: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33221 remote=/127.0.0.1:60920]
    [junit] 2009-05-21 19:20:03,108 - WARN  [main-SendThread:ClientCnxn$SendThread@919] - Exception closing session 0x121649daa090000 to sun.nio.ch.SelectionKeyImpl@983d95
    [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:653)
    [junit] 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:897)
    [junit] 2009-05-21 19:20:03,108 - INFO  [NIOServerCxn.Factory:33221:NIOServerCnxn$Factory@190] - NIOServerCnxn factory exited run method
    [junit] 2009-05-21 19:20:03,109 - INFO  [main:FinalRequestProcessor@268] - shutdown of request processor complete
    [junit] 2009-05-21 19:20:03,109 - INFO  [SyncThread:0:SyncRequestProcessor@118] - SyncRequestProcessor exited!
    [junit] 2009-05-21 19:20:03,109 - INFO  [ProcessThread:-1:PrepRequestProcessor@109] - PrepRequestProcessor exited loop!
    [junit] ensureOnly:[]
    [junit] 2009-05-21 19:20:03,112 - INFO  [main:ClientBase@344] - FINISHED testQuota
    [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.557 sec

BUILD FAILED
http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/ws/trunk/build.xml :732: 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: 12 minutes 5 seconds
Publishing Javadoc
Recording test results
Recording fingerprints


Hudson build is back to normal: ZooKeeper-trunk #321

Posted by Apache Hudson Server <hu...@hudson.zones.apache.org>.
See http://hudson.zones.apache.org/hudson/job/ZooKeeper-trunk/321/changes