See https://builds.apache.org/job/ZooKeeper-trunk-solaris/592/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE
###########################
[...truncated 1653 lines...]
[junit] 2013-06-25 08:33:52,190 [myid:] - INFO [main:FileSnap@83] -
Reading snapshot
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/trunk/build/test/tmp/test314520695754733313.junit.dir/version-2/snapshot.74b
[junit] 2013-06-25 08:33:52,252 [myid:] - INFO [main:FileTxnSnapLog@270] -
Snapshotting: 0x7d2 to
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/trunk/build/test/tmp/test314520695754733313.junit.dir/version-2/snapshot.7d2
[junit] 2013-06-25 08:33:52,260 [myid:] - INFO
[main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2013-06-25 08:33:52,260 [myid:] - INFO
[NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296]
- Accepted socket connection from /127.0.0.1:58043
[junit] 2013-06-25 08:33:52,261 [myid:] - INFO
[NIOWorkerThread-1:NIOServerCnxn@829] - Processing stat command from
/127.0.0.1:58043
[junit] 2013-06-25 08:33:52,261 [myid:] - INFO
[NIOWorkerThread-1:NIOServerCnxn$StatCommand@678] - Stat command output
[junit] 2013-06-25 08:33:52,262 [myid:] - INFO
[NIOWorkerThread-1:NIOServerCnxn@1000] - Closed socket connection for client
/127.0.0.1:58043 (no session established for client)
[junit] 2013-06-25 08:33:52,262 [myid:] - INFO [main:JMXEnv@133] -
ensureOnly:[InMemoryDataTree, StandaloneServer_port]
[junit] 2013-06-25 08:33:52,263 [myid:] - INFO [main:JMXEnv@105] -
expect:InMemoryDataTree
[junit] 2013-06-25 08:33:52,264 [myid:] - INFO [main:JMXEnv@108] -
found:InMemoryDataTree
org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree
[junit] 2013-06-25 08:33:52,264 [myid:] - INFO [main:JMXEnv@105] -
expect:StandaloneServer_port
[junit] 2013-06-25 08:33:52,264 [myid:] - INFO [main:JMXEnv@108] -
found:StandaloneServer_port
org.apache.ZooKeeperService:name0=StandaloneServer_port-1
[junit] 2013-06-25 08:33:52,264 [myid:] - INFO [main:ZooKeeper@530] -
Initiating client connection, connectString=127.0.0.1:11221
sessionTimeout=30000
watcher=org.apache.zookeeper.test.ClientBase$CountdownWatcher@578dfb
[junit] 2013-06-25 08:33:52,265 [myid:] - INFO
[main-SendThread(localhost:11221):ClientCnxn$SendThread@1006] - Opening socket
connection to server localhost/127.0.0.1:11221. Will not attempt to
authenticate using SASL (Unable to locate a login configuration)
[junit] 2013-06-25 08:33:52,265 [myid:] - INFO
[main-SendThread(localhost:11221):ClientCnxn$SendThread@882] - Socket
connection established to null, initiating session
[junit] 2013-06-25 08:33:52,265 [myid:] - INFO
[NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@296]
- Accepted socket connection from /127.0.0.1:58044
[junit] 2013-06-25 08:33:52,266 [myid:] - INFO
[NIOWorkerThread-2:ZooKeeperServer@834] - Client attempting to establish new
session at /127.0.0.1:58044
[junit] 2013-06-25 08:33:52,267 [myid:] - INFO
[SyncThread:0:FileTxnLog@199] - Creating new log file: log.7d3
[junit] 2013-06-25 08:33:52,268 [myid:] - INFO
[SyncThread:0:ZooKeeperServer@590] - Established session 0x13f7a77b2830000 with
negotiated timeout 30000 for client /127.0.0.1:58044
[junit] 2013-06-25 08:33:52,269 [myid:] - INFO
[main-SendThread(localhost:11221):ClientCnxn$SendThread@1240] - Session
establishment complete on server null, sessionid = 0x13f7a77b2830000,
negotiated timeout = 30000
[junit] 2013-06-25 08:33:52,270 [myid:] - INFO [main:JMXEnv@105] -
expect:0x13f7a77b2830000
[junit] 2013-06-25 08:33:52,270 [myid:] - INFO [main:JMXEnv@108] -
found:0x13f7a77b2830000
org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=Connections,name2=127.0.0.1,name3=0x13f7a77b2830000
[junit] 2013-06-25 08:33:52,404 [myid:] - INFO [ProcessThread(sid:0
cport:-1)::PrepRequestProcessor@653] - Processed session termination for
sessionid: 0x13f7a77b2830000
[junit] 2013-06-25 08:33:52,418 [myid:] - INFO
[NIOWorkerThread-7:NIOServerCnxn@1000] - Closed socket connection for client
/127.0.0.1:58044 which had sessionid 0x13f7a77b2830000
[junit] 2013-06-25 08:33:52,418 [myid:] - INFO
[main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down
[junit] 2013-06-25 08:33:52,418 [myid:] - INFO [main:ZooKeeper@777] -
Session: 0x13f7a77b2830000 closed
[junit] 2013-06-25 08:33:52,419 [myid:] - INFO
[main:JUnit4ZKTestRunner$LoggedInvokeMethod@57] - FINISHED TEST METHOD
testInvalidSnapshot
[junit] 2013-06-25 08:33:52,419 [myid:] - INFO [main:ClientBase@451] -
tearDown starting
[junit] 2013-06-25 08:33:52,419 [myid:] - INFO [main:ClientBase@421] -
STOPPING server
[junit] 2013-06-25 08:33:52,420 [myid:] - INFO
[NIOServerCxnFactory.AcceptThread:0.0.0.0/0.0.0.0:11221:NIOServerCnxnFactory$AcceptThread@219]
- accept thread exitted run method
[junit] 2013-06-25 08:33:52,420 [myid:] - INFO
[NIOServerCxnFactory.SelectorThread-0:NIOServerCnxnFactory$SelectorThread@420]
- selector thread exitted run method
[junit] 2013-06-25 08:33:52,421 [myid:] - INFO
[NIOServerCxnFactory.SelectorThread-1:NIOServerCnxnFactory$SelectorThread@420]
- selector thread exitted run method
[junit] 2013-06-25 08:33:52,421 [myid:] - INFO [main:ZooKeeperServer@422]
- shutting down
[junit] 2013-06-25 08:33:52,422 [myid:] - INFO
[main:SessionTrackerImpl@180] - Shutting down
[junit] 2013-06-25 08:33:52,422 [myid:] - INFO
[main:PrepRequestProcessor@929] - Shutting down
[junit] 2013-06-25 08:33:52,422 [myid:] - INFO
[main:SyncRequestProcessor@175] - Shutting down
[junit] 2013-06-25 08:33:52,422 [myid:] - INFO [ProcessThread(sid:0
cport:-1)::PrepRequestProcessor@156] - PrepRequestProcessor exited loop!
[junit] 2013-06-25 08:33:52,422 [myid:] - INFO
[SyncThread:0:SyncRequestProcessor@155] - SyncRequestProcessor exited!
[junit] 2013-06-25 08:33:52,422 [myid:] - INFO
[main:FinalRequestProcessor@427] - shutdown of request processor complete
[junit] 2013-06-25 08:33:52,423 [myid:] - INFO
[main:FourLetterWordMain@43] - connecting to 127.0.0.1 11221
[junit] 2013-06-25 08:33:52,423 [myid:] - INFO [main:JMXEnv@133] -
ensureOnly:[]
[junit] 2013-06-25 08:33:52,611 [myid:] - INFO [main:ClientBase@476] -
fdcount after test is: 41 at start it was 31
[junit] 2013-06-25 08:33:52,611 [myid:] - INFO [main:ClientBase@478] -
sleeping for 20 secs
[junit] 2013-06-25 08:33:52,677 [myid:] - INFO [main:ZKTestCase$1@61] -
SUCCEEDED testInvalidSnapshot
[junit] 2013-06-25 08:33:52,677 [myid:] - INFO [main:ZKTestCase$1@56] -
FINISHED testInvalidSnapshot
[junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 10.64 sec
[junit] Running org.apache.zookeeper.server.PrepRequestProcessorTest
[junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec
BUILD FAILED
/zonestorage/hudson_solaris/home/hudson/hudson-slave/workspace/ZooKeeper-trunk-solaris/trunk/build.xml:1233:
Process fork failed.
Total time: 2 minutes 16 seconds
Build step 'Invoke Ant' marked build as failure
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
###################################################################################
############################## FAILED TESTS (if any)
##############################
1 tests failed.
FAILED: org.apache.zookeeper.server.PrepRequestProcessorTest.unknown
Error Message:
Forked Java VM exited abnormally. Please note the time in the report does not
reflect the time until the VM exit.
Stack Trace:
junit.framework.AssertionFailedError: Forked Java VM exited abnormally. Please
note the time in the report does not reflect the time until the VM exit.