DEBUG [PoolingDataSource] OurJob building XA pool for ourresource with 0 connection(s) DEBUG [XAPool] OurJob setting vendor property 'user' to 'bob' DEBUG [XAPool] OurJob setting vendor property 'url' to 'jdbc:oracle:thin:@blah/blah' DEBUG [XAPool] OurJob setting vendor property 'password' to 'somesecret' DEBUG [XAPool] OurJob setting vendor property 'driverClassName' to 'oracle.jdbc.OracleDriver' DEBUG [TaskScheduler] OurJob task scheduler backed by ConcurrentSkipListSet DEBUG [TaskScheduler] OurJob scheduling pool shrinking task on an XAPool of resource ourresource with 0 connection(s) (0 still available) for Mon Jan 26 20:09:01 CST 1970 DEBUG [TaskScheduler] OurJob removing task by an XAPool of resource ourresource with 0 connection(s) (0 still available) DEBUG [TaskScheduler] OurJob scheduled a PoolShrinkingTask scheduled for Mon Jan 26 20:09:01 CST 1970 on an XAPool of resource ourresource with 0 connection(s) (0 still available), total task(s) queued: 1 DEBUG [XAPool] OurJob trying to recycle a NOT_ACCESSIBLE connection of an XAPool of resource ourresource with 0 connection(s) (0 still available) DEBUG [XAPool] OurJob no current transaction, no connection can be in state NOT_ACCESSIBLE when there is no global transaction context DEBUG [XAPool] OurJob getting a IN_POOL connection from an XAPool of resource ourresource with 0 connection(s) (0 still available) DEBUG [XAPool] OurJob no more free connection in an XAPool of resource ourresource with 0 connection(s) (0 still available), trying to grow it DEBUG [XAPool] OurJob incrementing ourresource pool size by 1 unit(s) to reach 1 connection(s) DEBUG [JdbcPooledConnection] OurJob dataSource is JDBC4 or newer and supports isValid(), but enableJdbc4ConnectionTest is not set or is false DEBUG [JdbcPooledConnection] OurJob detected JDBC connection class 'class com.sun.proxy.$Proxy3' is version 4 type DEBUG [JdbcPooledConnection] OurJob emulating XA for resource ourresource - changing twoPcOrderingPosition to ALWAYS_LAST_POSITION DEBUG [JdbcPooledConnection] OurJob emulating XA for resource ourresource - changing deferConnectionRelease to true DEBUG [JdbcPooledConnection] OurJob emulating XA for resource ourresource - changing useTmJoin to true DEBUG [XAPool] OurJob waiting for IN_POOL connections count to be > 0, currently is 1 DEBUG [XAPool] OurJob found IN_POOL connection a JdbcPooledConnection from datasource ourresource in state IN_POOL with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d from an XAPool of resource ourresource with 1 connection(s) (1 still available) DEBUG [JdbcPooledConnection] OurJob getting connection handle from a JdbcPooledConnection from datasource ourresource in state IN_POOL with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [AbstractXAStatefulHolder] OurJob notifying 2 stateChangeEventListener(s) about state changing from IN_POOL to ACCESSIBLE in a JdbcPooledConnection from datasource ourresource in state IN_POOL with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [AbstractXAStatefulHolder] OurJob state changing from IN_POOL to ACCESSIBLE in a JdbcPooledConnection from datasource ourresource in state IN_POOL with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [AbstractXAStatefulHolder] OurJob notifying 2 stateChangeEventListener(s) about state changed from IN_POOL to ACCESSIBLE in a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [JdbcPooledConnection] OurJob connection a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d was in state IN_POOL, testing it DEBUG [JdbcPooledConnection] OurJob testing with query 'SELECT 1 FROM DUAL' connection of a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [JdbcPooledConnection] OurJob testQuery successfully tested connection of a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [JdbcPooledConnection] OurJob got connection handle from a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [PoolingDataSource] OurJob acquired connection from a PoolingDataSource containing an XAPool of resource ourresource with 1 connection(s) (0 still available) DEBUG [TransactionContextHelper] OurJob enlisting a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d into null DEBUG [TransactionContextHelper] OurJob in local transaction context, skipping enlistment DEBUG [LruStatementCache] OurJob adding to cache statement in null DEBUG [LruStatementCache] OurJob returning to cache statement with usage count 0 in a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [JdbcConnectionHandle] OurJob closing a JdbcConnectionHandle of a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d on a JDBC LrcConnectionHandle on a JDBC LrcXAResource in state NO_TX DEBUG [JdbcPooledConnection] OurJob releasing to pool a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [TransactionContextHelper] OurJob delisting a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d from null DEBUG [TransactionContextHelper] OurJob resource is not in enlisting global transaction context: a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [TransactionContextHelper] OurJob requeuing a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d from null DEBUG [TransactionContextHelper] OurJob resource is not in enlisting global transaction context: a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [TransactionContextHelper] OurJob looking in in-flight transactions for XAResourceHolderState of a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [TransactionContextHelper] OurJob transaction manager not running, there is no in-flight transaction DEBUG [TransactionContextHelper] OurJob resource not in enlisting global transaction context, immediately releasing to pool a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [AbstractXAStatefulHolder] OurJob notifying 2 stateChangeEventListener(s) about state changing from ACCESSIBLE to IN_POOL in a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [JdbcPooledConnection] OurJob closing 0 dangling uncached statement(s) DEBUG [JdbcPooledConnection] OurJob clearing warnings of a JDBC LrcConnectionHandle on a JDBC LrcXAResource in state NO_TX DEBUG [AbstractXAStatefulHolder] OurJob state changing from ACCESSIBLE to IN_POOL in a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [AbstractXAStatefulHolder] OurJob notifying 2 stateChangeEventListener(s) about state changed from ACCESSIBLE to IN_POOL in a JdbcPooledConnection from datasource ourresource in state IN_POOL with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [JdbcPooledConnection] OurJob requeued JDBC connection of a PoolingDataSource containing an XAPool of resource ourresource with 1 connection(s) (1 still available) DEBUG [XAPool] OurJob a connection's state changed to IN_POOL, notifying a thread eventually waiting for a connection DEBUG [JdbcPooledConnection] OurJob released to pool a JdbcPooledConnection from datasource ourresource in state IN_POOL with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [PoolingDataSource] OurJob acquiring connection from a PoolingDataSource containing an XAPool of resource ourresource with 1 connection(s) (1 still available) DEBUG [XAPool] OurJob trying to recycle a NOT_ACCESSIBLE connection of an XAPool of resource ourresource with 1 connection(s) (1 still available) DEBUG [XAPool] OurJob no current transaction, no connection can be in state NOT_ACCESSIBLE when there is no global transaction context DEBUG [XAPool] OurJob getting a IN_POOL connection from an XAPool of resource ourresource with 1 connection(s) (1 still available) DEBUG [XAPool] OurJob waiting for IN_POOL connections count to be > 0, currently is 1 DEBUG [XAPool] OurJob found IN_POOL connection a JdbcPooledConnection from datasource ourresource in state IN_POOL with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d from an XAPool of resource ourresource with 1 connection(s) (1 still available) DEBUG [JdbcPooledConnection] OurJob getting connection handle from a JdbcPooledConnection from datasource ourresource in state IN_POOL with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [AbstractXAStatefulHolder] OurJob notifying 2 stateChangeEventListener(s) about state changing from IN_POOL to ACCESSIBLE in a JdbcPooledConnection from datasource ourresource in state IN_POOL with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [AbstractXAStatefulHolder] OurJob state changing from IN_POOL to ACCESSIBLE in a JdbcPooledConnection from datasource ourresource in state IN_POOL with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [AbstractXAStatefulHolder] OurJob notifying 2 stateChangeEventListener(s) about state changed from IN_POOL to ACCESSIBLE in a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [JdbcPooledConnection] OurJob connection a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d was in state IN_POOL, testing it DEBUG [JdbcPooledConnection] OurJob testing with query 'SELECT 1 FROM DUAL' connection of a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [JdbcPooledConnection] OurJob testQuery successfully tested connection of a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [JdbcPooledConnection] OurJob got connection handle from a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [PoolingDataSource] OurJob acquired connection from a PoolingDataSource containing an XAPool of resource ourresource with 1 connection(s) (0 still available) DEBUG [TransactionContextHelper] OurJob enlisting a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d into null DEBUG [TransactionContextHelper] OurJob in local transaction context, skipping enlistment DEBUG [TransactionContextHelper] OurJob enlisting a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d into null DEBUG [TransactionContextHelper] OurJob in local transaction context, skipping enlistment DEBUG [TransactionContextHelper] OurJob enlisting a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d into null DEBUG [TransactionContextHelper] OurJob in local transaction context, skipping enlistment DEBUG [TransactionContextHelper] OurJob enlisting a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d into null DEBUG [TransactionContextHelper] OurJob in local transaction context, skipping enlistment DEBUG [JdbcConnectionHandle] OurJob closing a JdbcConnectionHandle of a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d on a JDBC LrcConnectionHandle on a JDBC LrcXAResource in state NO_TX DEBUG [JdbcPooledConnection] OurJob releasing to pool a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 1 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [TransactionContextHelper] OurJob delisting a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d from null DEBUG [TransactionContextHelper] OurJob resource is not in enlisting global transaction context: a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [TransactionContextHelper] OurJob requeuing a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d from null DEBUG [TransactionContextHelper] OurJob resource is not in enlisting global transaction context: a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [TransactionContextHelper] OurJob looking in in-flight transactions for XAResourceHolderState of a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [TransactionContextHelper] OurJob transaction manager not running, there is no in-flight transaction DEBUG [TransactionContextHelper] OurJob resource not in enlisting global transaction context, immediately releasing to pool a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [AbstractXAStatefulHolder] OurJob notifying 2 stateChangeEventListener(s) about state changing from ACCESSIBLE to IN_POOL in a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [JdbcPooledConnection] OurJob closing 0 dangling uncached statement(s) DEBUG [JdbcPooledConnection] OurJob clearing warnings of a JDBC LrcConnectionHandle on a JDBC LrcXAResource in state NO_TX DEBUG [AbstractXAStatefulHolder] OurJob state changing from ACCESSIBLE to IN_POOL in a JdbcPooledConnection from datasource ourresource in state ACCESSIBLE with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [AbstractXAStatefulHolder] OurJob notifying 2 stateChangeEventListener(s) about state changed from ACCESSIBLE to IN_POOL in a JdbcPooledConnection from datasource ourresource in state IN_POOL with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d DEBUG [JdbcPooledConnection] OurJob requeued JDBC connection of a PoolingDataSource containing an XAPool of resource ourresource with 1 connection(s) (1 still available) DEBUG [XAPool] OurJob a connection's state changed to IN_POOL, notifying a thread eventually waiting for a connection DEBUG [JdbcPooledConnection] OurJob released to pool a JdbcPooledConnection from datasource ourresource in state IN_POOL with usage count 0 wrapping a JDBC LrcXAConnection on oracle.jdbc.driver.T4CConnection@2577579d INFO [OurJob] OurJob Business Process OurJob has successfully completed.