java.sql.SQLTransactionRollbackException: A lock could not be obtained within the time requested

[BMN]

Some javascript/style in this post has been disabled (why?)

Hi,

This is regarding an issue while logging of our request in to file.

we are using IEP component in cluster enviornment to get log in our webservices.while testing with small request(1,10 threads )using SOAPUI(testing tool for Webservices) it is working fine but as we increase(20,30,50) the thread size we are getting some fail test results.

Below is the details of Exception in server log we get.

[#|2009-06-30T09:55:22.668+0100|SEVERE|sun-appserver9.1|com.sun.jbi.engine.iep.core.runtime.IEPEngine|_ThreadID=154;_ThreadName=Thread-547;_RequestID=3ab91b92-0083-4997-a1ac-54754d3a069a;|IEPSEaja02029: Fail to retrieve processing-state of event processor: 0

java.sql.SQLTransactionRollbackException: A lock could not be obtained within the time requested

at org.apache.derby.impl.jdbc.SQLExceptionFactory40.getSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.Util.generateCsSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.TransactionResourceImpl.wrapInSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.TransactionResourceImpl.handleException(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedConnection.handleException(Unknown Source)

at org.apache.derby.impl.jdbc.ConnectionChild.handleException(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedResultSet.closeOnTransactionError(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedResultSet.movePosition(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedResultSet.next(Unknown Source)

at com.sun.jbi.engine.iep.core.runtime.util.Util.getPrevTimestampToCheck(Util.java:2009)

at com.sun.jbi.engine.iep.IEPSEOutOnlyThread.run(IEPSEOutOnlyThread.java:228)

Caused by: java.sql.SQLException: A lock could not be obtained within the time requested

at org.apache.derby.impl.jdbc.SQLExceptionFactory.getSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.SQLExceptionFactory40.wrapArgsForTransportAcrossDRDA(Unknown Source)

... 11 more

|#]

[#|2009-06-30T09:56:22.681+0100|SEVERE|sun-appserver9.1|com.sun.jbi.engine.iep.core.runtime.IEPEngine|_ThreadID=154;_ThreadName=Thread-547;_RequestID=3ab91b92-0083-4997-a1ac-54754d3a069a;|IEPSEaja02029: Fail to retrieve processing-state of event processor: 1

java.sql.SQLTransactionRollbackException: A lock could not be obtained within the time requested

at org.apache.derby.impl.jdbc.SQLExceptionFactory40.getSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.Util.generateCsSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.TransactionResourceImpl.wrapInSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.TransactionResourceImpl.handleException(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedConnection.handleException(Unknown Source)

at org.apache.derby.impl.jdbc.ConnectionChild.handleException(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedResultSet.closeOnTransactionError(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedResultSet.movePosition(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedResultSet.next(Unknown Source)

at com.sun.jbi.engine.iep.core.runtime.util.Util.getPrevTimestampToCheck(Util.java:2009)

at com.sun.jbi.engine.iep.IEPSEOutOnlyThread.run(IEPSEOutOnlyThread.java:228)

Caused by: java.sql.SQLException: A lock could not be obtained within the time requested

at org.apache.derby.impl.jdbc.SQLExceptionFactory.getSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.SQLExceptionFactory40.wrapArgsForTransportAcrossDRDA(Unknown Source)

... 11 more

|#]

can anybody help me out this?

Thanks

-Brij

[Michael.Czapski]

Some javascript/style in this post has been disabled (why?)

Hello, Brij.

I am afraid I can not help you with this issue. You will be steerer served by submitting this to the [hidden email] (I am sending this to that mailing list).

Regards

Michael

Brij Mohan Negi (India) wrote:

Hi,

This is regarding an issue while logging of our request in to file.

we are using IEP component in cluster enviornment to get log in our webservices.while testing with small request(1,10 threads )using SOAPUI(testing tool for Webservices) it is working fine but as we increase(20,30,50) the thread size we are getting some fail test results.

Below is the details of Exception in server log we get.

[#|2009-06-30T09:55:22.668+0100|SEVERE|sun-appserver9.1|com.sun.jbi.engine.iep.core.runtime.IEPEngine|_ThreadID=154;_ThreadName=Thread-547;_RequestID=3ab91b92-0083-4997-a1ac-54754d3a069a;|IEPSEaja02029: Fail to retrieve processing-state of event processor: 0

java.sql.SQLTransactionRollbackException: A lock could not be obtained within the time requested

at org.apache.derby.impl.jdbc.SQLExceptionFactory40.getSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.Util.generateCsSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.TransactionResourceImpl.wrapInSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.TransactionResourceImpl.handleException(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedConnection.handleException(Unknown Source)

at org.apache.derby.impl.jdbc.ConnectionChild.handleException(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedResultSet.closeOnTransactionError(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedResultSet.movePosition(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedResultSet.next(Unknown Source)

at com.sun.jbi.engine.iep.core.runtime.util.Util.getPrevTimestampToCheck(Util.java:2009)

at com.sun.jbi.engine.iep.IEPSEOutOnlyThread.run(IEPSEOutOnlyThread.java:228)

Caused by: java.sql.SQLException: A lock could not be obtained within the time requested

at org.apache.derby.impl.jdbc.SQLExceptionFactory.getSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.SQLExceptionFactory40.wrapArgsForTransportAcrossDRDA(Unknown Source)

... 11 more

|#]

[#|2009-06-30T09:56:22.681+0100|SEVERE|sun-appserver9.1|com.sun.jbi.engine.iep.core.runtime.IEPEngine|_ThreadID=154;_ThreadName=Thread-547;_RequestID=3ab91b92-0083-4997-a1ac-54754d3a069a;|IEPSEaja02029: Fail to retrieve processing-state of event processor: 1

java.sql.SQLTransactionRollbackException: A lock could not be obtained within the time requested

at org.apache.derby.impl.jdbc.SQLExceptionFactory40.getSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.Util.generateCsSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.TransactionResourceImpl.wrapInSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.TransactionResourceImpl.handleException(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedConnection.handleException(Unknown Source)

at org.apache.derby.impl.jdbc.ConnectionChild.handleException(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedResultSet.closeOnTransactionError(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedResultSet.movePosition(Unknown Source)

at org.apache.derby.impl.jdbc.EmbedResultSet.next(Unknown Source)

at com.sun.jbi.engine.iep.core.runtime.util.Util.getPrevTimestampToCheck(Util.java:2009)

at com.sun.jbi.engine.iep.IEPSEOutOnlyThread.run(IEPSEOutOnlyThread.java:228)

Caused by: java.sql.SQLException: A lock could not be obtained within the time requested

at org.apache.derby.impl.jdbc.SQLExceptionFactory.getSQLException(Unknown Source)

at org.apache.derby.impl.jdbc.SQLExceptionFactory40.wrapArgsForTransportAcrossDRDA(Unknown Source)

... 11 more

|#]

can you help me out for the same?

Thanks

-Brij

 

---

From: [hidden email] [[hidden email]]
Sent: Wednesday, June 24, 2009 12:44 PM
To: [hidden email]
Subject: Database BC, BPEL SE and MySQL don't play nicely together - "Too many connections" from MySQL

I have a multi-operation web service implemented following the instructions in "GlassFish ESB v 2.1 - Creating a Healthcare Facility Web Service Provider", at http://blogs.sun.com/javacapsfieldtech/entry/glassfish_esb_v_2_1. As part of the solution there is a Soap UI testing project. When I execute the opGetFacList, or opGetFacDetails, or both 15 times I get an exception in server.log that says "Too many open connections". It seems to me that the BPEL SE or the Database BC of the JBI container do not release connections between service invocations. The pool gets exhausted and the service comes to a grinding halt.

The Soap UI response looks like:
<SOAP-ENV:Envelope xmlns:SOAP-ENV="http://schemas.xmlsoap.org/soap/envelope/">
   <SOAP-ENV:Body>
      <SOAP-ENV:Fault>
         <faultcode>SOAP-ENV:Server</faultcode>
         <faultstring><![CDATA[BPCOR-6135: A fault was not handled in the process scope; Fault Name is {http://www.sun.com/wsbpel/2.0/process/executable/SUNExtension/ErrorHandling}systemFault; Fault Data is &lt;?xml version=&quot;1.0&quot; encoding=&quot;UTF-8&quot;?&gt;&lt;jbi:message xmlns:sxeh=&quot;http://www.sun.com/wsbpel/2.0/process/executable/SUNExtension/ErrorHandling&quot; type=&quot;sxeh:faultMessage&quot; version=&quot;1.0&quot; xmlns:jbi=&quot;http://java.sun.com/xml/ns/jbi/wsdl-11-wrapper&quot;&gt;&lt;jbi:part&gt;Error occured while looking up jndi resource with jndi name.&lt;/jbi:part&gt;&lt;/jbi:message&gt;. Sending errors for the pending requests in the process scope before terminating the process instance]]></faultstring>
         <faultactor>sun-bpel-engine</faultactor>
         <detail>
            <detailText><![CDATA[BPCOR-6135: A fault was not handled in the process scope; Fault Name is {http://www.sun.com/wsbpel/2.0/process/executable/SUNExtension/ErrorHandling}systemFault; Fault Data is &lt;?xml version=&quot;1.0&quot; encoding=&quot;UTF-8&quot;?&gt;&lt;jbi:message xmlns:sxeh=&quot;http://www.sun.com/wsbpel/2.0/process/executable/SUNExtension/ErrorHandling&quot; type=&quot;sxeh:faultMessage&quot; version=&quot;1.0&quot; xmlns:jbi=&quot;http://java.sun.com/xml/ns/jbi/wsdl-11-wrapper&quot;&gt;&lt;jbi:part&gt;Error occured while looking up jndi resource with jndi name.&lt;/jbi:part&gt;&lt;/jbi:message&gt;. Sending errors for the pending requests in the process scope before terminating the process instance
   Caused by: BPCOR-6131: An Error status was received while doing an invoke (partnerLink=DBList, portType={http://j2ee.netbeans.org/wsdl/FacListDB}jdbcPortType, operation=opGetFacList)
BPCOR-6129: Line Number is 44
BPCOR-6130: Activity Name is Invoke1
   Caused by: Error occured while looking up jndi resource with jndi name.
   Caused by: Error in allocating a connection. Cause: Connection could not be allocated because: Data source rejected establishment of connection,  message from server: &quot;Too many connections&quot;]]></detailText>
         </detail>
      </SOAP-ENV:Fault>
   </SOAP-ENV:Body>
</SOAP-ENV:Envelope>

The server.log extract is at the end of this message.

I did not have this issue doing the equivalent in Java CAPS 6 Repository with eInsight BPEL 1.0 and teh JDBC eWay.
I am using GlassFish ESB v2.1, RC2 distribution, from about a week before GA with JDK 1.6.0_10.

Please advise.

Regards

Michael