Atomikos Forum |
|
Hi,
We use atomikos (3.7) and Spring (3.3) TransactionTemplate on Tomcat (6.0.32). I have noticed an issue after the transaction is timeout, atomikos still lets the the code connection.prepareStatement(); In such case the connection is first rollback() again (after the timeout has rollback() the connection) and connection is set for autoCommit(false). When the TransactionTemplate commits afterwards, atomikos doesn't rollback the prepared statement and doesn't return the original autoCommit mode. This means that the DB connection is in a transaction which will is waiting for rollback or commit. Can you please help? this issue doesn't let me sleep at night! Atomikos log is attached. 11-07-07 18:02:06,573 [catalina-exec-3] getCompositeTransaction() returning NULL! 11-07-07 18:02:06,573 [catalina-exec-3] getCompositeTransaction() returning NULL! 11-07-07 18:02:06,573 [catalina-exec-3] getCompositeTransaction() returning NULL! 11-07-07 18:02:06,573 [catalina-exec-3] Coordinator 10.0.0.74.tm0000500001 entering state: ACTIVE 11-07-07 18:02:06,573 [catalina-exec-3] (1.5) executing task: com.atomikos.timing.PooledAlarmTimer@198a407 11-07-07 18:02:06,573 [catalina-exec-3] Creating composite transaction: 10.0.0.74.tm0000500001 11-07-07 18:02:06,574 [catalina-exec-3] createCompositeTransaction ( 20000 ): created new ROOT transaction with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,574 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,574 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,574 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,574 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,574 [catalina-exec-3] Coordinator 10.0.0.74.tm0000500001 entering state: ACTIVE 11-07-07 18:02:06,574 [catalina-exec-3] registerSynchronization ( com.atomikos.icatch.jta.Sync2Sync@106e95a ) for transaction 10.0.0.74.tm0000500001 11-07-07 18:02:06,576 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': getConnection ( null )... 11-07-07 18:02:06,576 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': init... 11-07-07 18:02:06,576 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': getConnection ( null )... 11-07-07 18:02:06,576 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': init... 11-07-07 18:02:06,576 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,576 [catalina-exec-3] atomikos connection pool 'jdbc.data_source': current size: 5/5 11-07-07 18:02:06,576 [catalina-exec-3] AtomikosNonXAPooledConnection: updating last time acquired 11-07-07 18:02:06,576 [catalina-exec-3] AtomikosNonXAPooledConnection: testing connection with query [select count(*) from dual] 11-07-07 18:02:06,577 [catalina-exec-3] AtomikosNonXAPooledConnection: connection tested OK 11-07-07 18:02:06,578 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,578 [catalina-exec-3] AtomikosNonXAPooledConnection: creating connection proxy... 11-07-07 18:02:06,578 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling toString on vendor connection... 11-07-07 18:02:06,578 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: toString returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:02:06,578 [catalina-exec-3] AtomikosNonXAPooledConnection: returning proxy oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:02:06,578 [catalina-exec-3] atomikos connection pool 'jdbc.data_source': got connection from pool, new size: 5/5 11-07-07 18:02:06,578 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling toString on vendor connection... 11-07-07 18:02:06,578 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: toString returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:02:06,578 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:02:06,578 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling toString on vendor connection... 11-07-07 18:02:06,578 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: toString returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:02:06,578 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:02:06,578 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,578 [catalina-exec-3] Coordinator 10.0.0.74.tm0000500001 entering state: ACTIVE 11-07-07 18:02:06,578 [catalina-exec-3] addParticipant ( com.atomikos.jdbc.nonxa.AtomikosNonXAParticipant@1dd898 ) for transaction 10.0.0.74.tm0000500001 11-07-07 18:02:06,578 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling prepareStatement on vendor connection... 11-07-07 18:02:06,578 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: prepareStatement returning oracle.jdbc.driver.OraclePreparedStatementWrapper@176f08d 11-07-07 18:02:06,583 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: isClosed()... 11-07-07 18:02:06,584 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: isClosed() returning false 11-07-07 18:02:06,584 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,584 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling clearWarnings on vendor connection... 11-07-07 18:02:06,584 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: clearWarnings returning null 11-07-07 18:02:06,584 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,584 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: close... 11-07-07 18:02:06,584 [catalina-exec-3] ThreadLocalConnection: not reusable yet 11-07-07 18:02:06,584 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: close done. 11-07-07 18:02:06,584 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,584 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,641 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': getConnection ( null )... 11-07-07 18:02:06,641 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': init... 11-07-07 18:02:06,641 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': getConnection ( null )... 11-07-07 18:02:06,641 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': init... 11-07-07 18:02:06,641 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,641 [catalina-exec-3] AtomikosNonXAPooledConnection: updating last time acquired 11-07-07 18:02:06,641 [catalina-exec-3] AtomikosNonXAPooledConnection: testing connection with query [select count(*) from dual] 11-07-07 18:02:06,642 [catalina-exec-3] AtomikosNonXAPooledConnection: connection tested OK 11-07-07 18:02:06,642 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,642 [catalina-exec-3] AtomikosNonXAPooledConnection: reusing existing proxy for thread... 11-07-07 18:02:06,642 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,642 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling toString on vendor connection... 11-07-07 18:02:06,642 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: toString returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:02:06,642 [catalina-exec-3] AtomikosNonXAPooledConnection: returning proxy oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:02:06,642 [catalina-exec-3] atomikos connection pool 'jdbc.data_source': recycling connection from pool... 11-07-07 18:02:06,642 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,642 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling toString on vendor connection... 11-07-07 18:02:06,642 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: toString returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:02:06,642 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:02:06,642 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,642 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling toString on vendor connection... 11-07-07 18:02:06,642 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: toString returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:02:06,642 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:02:06,642 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,642 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling prepareStatement on vendor connection... 11-07-07 18:02:06,642 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: prepareStatement returning oracle.jdbc.driver.OraclePreparedStatementWrapper@1b44916 11-07-07 18:02:06,669 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: isClosed()... 11-07-07 18:02:06,669 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: isClosed() returning false 11-07-07 18:02:06,670 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,670 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling clearWarnings on vendor connection... 11-07-07 18:02:06,670 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: clearWarnings returning null 11-07-07 18:02:06,670 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:02:06,670 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: close... 11-07-07 18:02:06,670 [catalina-exec-3] ThreadLocalConnection: not reusable yet 11-07-07 18:02:06,670 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: close done. 11-07-07 18:02:22,150 [Atomikos:0] atomikos connection pool 'jdbc.data_source': trying to shrink pool 11-07-07 18:02:22,437 [Atomikos:1] atomikos connection pool 'jdbc.parallel_data_source': trying to shrink pool 11-07-07 18:02:26,725 [Atomikos:3] Rollback of timedout ACTIVE coordinator ! 11-07-07 18:02:26,725 [Atomikos:3] Coordinator 10.0.0.74.tm0000500001 entering state: ABORTING 11-07-07 18:02:26,726 [Atomikos:3] Forcing close of pending statement: oracle.jdbc.driver.OraclePreparedStatementWrapper@176f08d 11-07-07 18:02:26,726 [Atomikos:3] Forcing close of pending statement: oracle.jdbc.driver.OraclePreparedStatementWrapper@1b44916 11-07-07 18:02:26,726 [Atomikos:3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: transaction aborting - pessimistically closing all pending statements to avoid autoCommit after timeout 11-07-07 18:02:26,726 [Atomikos:3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: rolling back on connection... 11-07-07 18:02:26,728 [Atomikos:3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: resetting autoCommit to true 11-07-07 18:02:26,728 [Atomikos:3] ThreadLocalConnection: detected reusability 11-07-07 18:02:26,728 [Atomikos:3] AtomikosNonXAPooledConnection: notifying listener: atomikos connection pool 'jdbc.data_source' 11-07-07 18:02:26,728 [Atomikos:3] atomikos connection pool 'jdbc.data_source': connection AtomikosNonXAPooledConnection became available, notifying potentially waiting threads 11-07-07 18:02:26,728 [Atomikos:3] AtomikosNonXAPooledConnection: updating last time released 11-07-07 18:02:26,728 [Atomikos:3] AtomikosNonXAPooledConnection: updating last time released 11-07-07 18:02:26,728 [Atomikos:3] Coordinator 10.0.0.74.tm0000500001 entering state: TERMINATED 11-07-07 18:02:26,728 [Atomikos:3] Coordinator 10.0.0.74.tm0000500001 : stopping timer... 11-07-07 18:02:26,728 [Atomikos:3] Coordinator 10.0.0.74.tm0000500001 : disposing statehandler TERMINATED... 11-07-07 18:02:26,728 [Atomikos:3] Coordinator 10.0.0.74.tm0000500001 : disposed. 11-07-07 18:02:26,730 [Atomikos:3] Error during setRollbackOnly java.lang.IllegalStateException: 10.0.0.74.tm0000500001 is no longer active but in state TERMINATED at com.atomikos.icatch.imp.CoordinatorImp.addParticipant(CoordinatorImp.java:613) at com.atomikos.icatch.imp.TransactionStateHandler.addParticipant(TransactionStateHandler.java:133) at com.atomikos.icatch.imp.TransactionStateHandler.setRollbackOnly(TransactionStateHandler.java:320) at com.atomikos.icatch.imp.CompositeTransactionImp.setRollbackOnly(CompositeTransactionImp.java:356) at com.atomikos.icatch.imp.CompositeTransactionImp.entered(CompositeTransactionImp.java:419) at com.atomikos.finitestates.FSMImp.notifyListeners(FSMImp.java:185) at com.atomikos.finitestates.FSMImp.setState(FSMImp.java:276) at com.atomikos.icatch.imp.CoordinatorImp.setState(CoordinatorImp.java:521) at com.atomikos.icatch.imp.CoordinatorImp.setStateHandler(CoordinatorImp.java:351) at com.atomikos.icatch.imp.CoordinatorStateHandler.rollback(CoordinatorStateHandler.java:816) at com.atomikos.icatch.imp.ActiveStateHandler.onTimeout(ActiveStateHandler.java:97) at com.atomikos.icatch.imp.CoordinatorImp.alarm(CoordinatorImp.java:1105) at com.atomikos.timing.PooledAlarmTimer.notifyListeners(PooledAlarmTimer.java:112) at com.atomikos.timing.PooledAlarmTimer.run(PooledAlarmTimer.java:99) at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908) at java.lang.Thread.run(Thread.java:619) 11-07-07 18:02:26,730 [Atomikos:3] setRollbackOnly() called for transaction 10.0.0.74.tm0000500001 11-07-07 18:02:26,730 [Atomikos:3] afterCompletion ( STATUS_ROLLEDBACK ) called on Synchronization: org.hibernate.transaction.CacheSynchronization 11-07-07 18:03:22,146 [Atomikos:0] atomikos connection pool 'jdbc.data_source': trying to shrink pool 11-07-07 18:03:22,433 [Atomikos:1] atomikos connection pool 'jdbc.parallel_data_source': trying to shrink pool 11-07-07 18:04:07,662 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:04:07,668 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': getConnection ( null )... 11-07-07 18:04:07,668 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': init... 11-07-07 18:04:07,668 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': getConnection ( null )... 11-07-07 18:04:07,668 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': init... 11-07-07 18:04:07,668 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:04:07,668 [catalina-exec-3] atomikos connection pool 'jdbc.data_source': current size: 5/5 11-07-07 18:04:07,668 [catalina-exec-3] AtomikosNonXAPooledConnection: updating last time acquired 11-07-07 18:04:07,668 [catalina-exec-3] AtomikosNonXAPooledConnection: testing connection with query [select count(*) from dual] 11-07-07 18:04:07,669 [catalina-exec-3] AtomikosNonXAPooledConnection: connection tested OK 11-07-07 18:04:07,669 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:04:07,669 [catalina-exec-3] AtomikosNonXAPooledConnection: creating connection proxy... 11-07-07 18:04:07,669 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling toString on vendor connection... 11-07-07 18:04:07,669 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: toString returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:04:07,669 [catalina-exec-3] AtomikosNonXAPooledConnection: returning proxy oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:04:07,669 [catalina-exec-3] atomikos connection pool 'jdbc.data_source': got connection from pool, new size: 5/5 11-07-07 18:04:07,669 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling toString on vendor connection... 11-07-07 18:04:07,669 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: toString returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:04:07,669 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:04:07,669 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling toString on vendor connection... 11-07-07 18:04:07,669 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: toString returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:04:07,670 [catalina-exec-3] AtomikosNonXADataSourceBean 'jdbc.data_source': returning oracle.jdbc.driver.T4CConnection@141cf63 11-07-07 18:04:07,670 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:04:07,670 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: transaction aborting - pessimistically closing all pending statements to avoid autoCommit after timeout 11-07-07 18:04:07,670 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: rolling back on connection... 11-07-07 18:04:07,670 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: resetting autoCommit to false 11-07-07 18:04:07,670 [catalina-exec-3] ThreadLocalConnection: not reusable yet 11-07-07 18:04:07,670 [catalina-exec-3] addParticipant ( com.atomikos.jdbc.nonxa.AtomikosNonXAParticipant@bc2602 ) for transaction 10.0.0.74.tm0000500001 11-07-07 18:04:07,670 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling prepareStatement on vendor connection... 11-07-07 18:04:07,670 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: prepareStatement returning oracle.jdbc.driver.OraclePreparedStatementWrapper@636960 11-07-07 18:04:07,670 [catalina-exec-3] getCompositeTransaction() returning instance with id 10.0.0.74.tm0000500001 11-07-07 18:04:07,693 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: isClosed()... 11-07-07 18:04:07,693 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: isClosed() returning false 11-07-07 18:04:07,693 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: calling clearWarnings on vendor connection... 11-07-07 18:04:07,693 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: clearWarnings returning null 11-07-07 18:04:07,693 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: close... 11-07-07 18:04:07,693 [catalina-exec-3] ThreadLocalConnection: detected reusability 11-07-07 18:04:07,693 [catalina-exec-3] AtomikosNonXAPooledConnection: notifying listener: atomikos connection pool 'jdbc.data_source' 11-07-07 18:04:07,693 [catalina-exec-3] atomikos connection pool 'jdbc.data_source': connection AtomikosNonXAPooledConnection became available, notifying potentially waiting threads 11-07-07 18:04:07,693 [catalina-exec-3] AtomikosNonXAPooledConnection: updating last time released 11-07-07 18:04:07,693 [catalina-exec-3] AtomikosNonXAPooledConnection: updating last time released 11-07-07 18:04:07,693 [catalina-exec-3] atomikos non-xa connection proxy for oracle.jdbc.driver.T4CConnection@141cf63: close done. |