The following two replies will contain the trace files, beginning at the start of the transaction.
When the JSF Managed bean is about to call the Session Bean method, you'll see "In the JSF Managed Bean." in the log.
When the Session Bean is hit, you'll see "Method called in Session Bean" in the log (there are two spaces between 'called' and 'in').
When the exception is caught in the Session Bean, you'll see " About to re-throw the exception back" in the log.
Without JTA
[stdout] (http--0.0.0.0-3809-6) In the JSF Managed bean. About to call Session Bean method.... 13:33:08,622 DEBUG [org.jboss.as.jpa] (http--0.0.0.0-3809-6) created new TransactionScopedEntityManager for unit name=Aims.ear/myBusinessLogic.jar#myEjb30
13:33:08,623 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.begin
13:33:08,623 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) StateManager::StateManager( 2, 0 )
13:33:08,623 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::BasicAction()
13:33:08,624 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::Begin() for action-id 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b
13:33:08,624 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::actionInitialise() for action-id 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b
13:33:08,625 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) ActionHierarchy::ActionHierarchy(5)
13:33:08,625 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) ActionHierarchy::add(0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b, 1)
13:33:08,625 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::addChildThread () action 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b adding Thread[http--0.0.0.0-3809-6,5,main]
13:33:08,626 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::addChildThread () action 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b adding Thread[http--0.0.0.0-3809-6,5,main] result = true
13:33:08,627 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) TransactionReaper::insert ( BasicAction: 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b status: ActionStatus.RUNNING, 300 )
13:33:08,627 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) ReaperElement::ReaperElement ( BasicAction: 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b status: ActionStatus.RUNNING, 300 )
13:33:08,628 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:33:08,628 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:33:08,629 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionStatus
13:33:08,629 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:08,630 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,630 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.registerInterposedSynchronization
13:33:08,630 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,631 INFO [stdout] (http--0.0.0.0-3809-6) Method called in Session Bean. 13:33:08,632 TRACE [org.jboss.jca.core.connectionmanager.NoTxConnectionManager] (http--0.0.0.0-3809-6) Subject: Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
13:33:08,633 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) ManagedConnectionPool: 18aaf26
Method: getConnection(Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
, null)
ManagedConnectionFactory:
Class: org.jboss.jca.adapters.jdbc.local.LocalManagedConnectionFactory
Object: beff97
ConnectionListenerFactory:
Class: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl
Object: 17e36ca
Pool:
Name: jdbc/myDB
PoolConfiguration:
MinSize: 0
MaxSize: 20
BlockingTimeout: 30000
IdleTimeoutMinutes: 30
BackgroundValidation: false
BackgroundValidationMillis: 0
StrictMin: false
UseFastFail: false
Available:
1f112a3 (NORMAL)
InUse:
Statistics:
ActiveCount: 1
AvailableCount: 20
AverageBlockingTime: 0
AverageCreationTime: 135
CreatedCount: 1
DestroyedCount: 0
MaxCreationTime: 135
MaxUsedCount: 1
MaxWaitCount: 0
MaxWaitTime: 0
TimedOut: 0
TotalBlockingTime: 0
TotalCreationTime: 135
13:33:08,640 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) supplying ManagedConnection from pool: org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener@1f112a3[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@1fea6ff connection handles=0 lastUse=1371749588609 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@1ad4fbf pool internal context=SemaphoreArrayListManagedConnectionPool@18aaf26[pool=jdbc/myDB]]
13:33:08,642 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Got connection from pool: org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener@1f112a3[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@1fea6ff connection handles=0 lastUse=1371749588609 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@1ad4fbf pool internal context=SemaphoreArrayListManagedConnectionPool@18aaf26[pool=jdbc/myDB]]
13:33:08,644 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) registering connection from connection manager: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl@17e36ca, connection : org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@e04c79, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,667 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) unregistering connection from connection manager: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl@17e36ca, connection: org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@e04c79, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,669 TRACE [org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener] (http--0.0.0.0-3809-6) unregisterConnection: 0 handles left
13:33:08,669 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) ManagedConnectionPool: 18aaf26
Method: returnConnection(1f112a3, false)
ManagedConnectionFactory:
Class: org.jboss.jca.adapters.jdbc.local.LocalManagedConnectionFactory
Object: beff97
ConnectionListenerFactory:
Class: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl
Object: 17e36ca
Pool:
Name: jdbc/myDB
PoolConfiguration:
MinSize: 0
MaxSize: 20
BlockingTimeout: 30000
IdleTimeoutMinutes: 30
BackgroundValidation: false
BackgroundValidationMillis: 0
StrictMin: false
UseFastFail: false
Available:
InUse:
1f112a3 (NORMAL)
Statistics:
ActiveCount: 1
AvailableCount: 19
AverageBlockingTime: 0
AverageCreationTime: 135
CreatedCount: 1
DestroyedCount: 0
MaxCreationTime: 135
MaxUsedCount: 1
MaxWaitCount: 0
MaxWaitTime: 0
TimedOut: 0
TotalBlockingTime: 0
TotalCreationTime: 135
13:33:08,673 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Returning connection to pool org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener@1f112a3[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@1fea6ff connection handles=0 lastUse=1371749588673 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@1ad4fbf pool internal context=SemaphoreArrayListManagedConnectionPool@18aaf26[pool=jdbc/myDB]]
13:33:08,675 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,676 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:33:08,676 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,677 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionStatus
13:33:08,677 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:08,677 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,678 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getRollbackOnly
13:33:08,678 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,678 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,679 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:08,679 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,679 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.registerInterposedSynchronization
13:33:08,680 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,680 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:08,680 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,681 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:08,681 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,681 DEBUG [org.jboss.as.jpa] (http--0.0.0.0-3809-6) http--0.0.0.0-3809-6:[transaction scoped EntityManager]: created entity manager session TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b status: ActionStatus.RUNNING >
13:33:08,682 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.registerInterposedSynchronization
13:33:08,683 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,683 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.putResource
13:33:08,683 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,684 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,684 TRACE [org.jboss.as.jpa] (http--0.0.0.0-3809-6) createNamedQuery name 'TableABean.checkWidgetForAUnit' took 9ms
13:33:08,685 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:08,685 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,686 TRACE [org.jboss.jca.core.connectionmanager.NoTxConnectionManager] (http--0.0.0.0-3809-6) Subject: Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
13:33:08,687 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) ManagedConnectionPool: 18aaf26
Method: getConnection(Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
, null)
ManagedConnectionFactory:
Class: org.jboss.jca.adapters.jdbc.local.LocalManagedConnectionFactory
Object: beff97
ConnectionListenerFactory:
Class: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl
Object: 17e36ca
Pool:
Name: jdbc/myDB
PoolConfiguration:
MinSize: 0
MaxSize: 20
BlockingTimeout: 30000
IdleTimeoutMinutes: 30
BackgroundValidation: false
BackgroundValidationMillis: 0
StrictMin: false
UseFastFail: false
Available:
1f112a3 (NORMAL)
InUse:
Statistics:
ActiveCount: 1
AvailableCount: 20
AverageBlockingTime: 0
AverageCreationTime: 135
CreatedCount: 1
DestroyedCount: 0
MaxCreationTime: 135
MaxUsedCount: 1
MaxWaitCount: 0
MaxWaitTime: 0
TimedOut: 0
TotalBlockingTime: 0
TotalCreationTime: 135
13:33:08,696 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) supplying ManagedConnection from pool: org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener@1f112a3[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@1fea6ff connection handles=0 lastUse=1371749588673 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@1ad4fbf pool internal context=SemaphoreArrayListManagedConnectionPool@18aaf26[pool=jdbc/myDB]]
13:33:08,698 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Got connection from pool: org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener@1f112a3[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@1fea6ff connection handles=0 lastUse=1371749588673 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@1ad4fbf pool internal context=SemaphoreArrayListManagedConnectionPool@18aaf26[pool=jdbc/myDB]]
13:33:08,700 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) registering connection from connection manager: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl@17e36ca, connection : org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@851bd3, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,702 DEBUG [org.hibernate.SQL] (http--0.0.0.0-3809-6)
select
top 2 tableA0_.keyColumn1 as KeyCol1_35_,
tableA0_.column2 as column2_35_,
tableA0_.column3 as column3_35_,
tableA0_.column4 as column4_35_,
tableA0_.column5 as column5_35_,
tableA0_.column6 as column6_35_,
tableA0_.column7 as column7_35_,
tableA0_.column8 as column8_35_,
tableA0_.column9 as column9_35_,
tableA0_.column10 as column10_35_,
tableA0_.column11 as column11_35_,
tableA0_.column12 as column12_35_,
tableA0_.column13 as column13_35_,
tableA0_.column14 as column14_35_,
tableA0_.column15 as column15_35_,
tableA0_.column16 as column16_35_,
tableA0_.column17 as column17_35_,
tableA0_.column18 as column18_35_,
tableA0_.column19 as column19_35_,
tableA0_.column20 as column20_35_,
tableA0_.column21 as column21_35_,
tableA0_.column22 as column22_35_,
tableA0_.column23 as column23_35_,
tableA0_.column24 as column24_35_,
tableA0_.column25 as column25_35_,
tableA0_.column26 as column26_35_,
tableA0_.column27 as column27_35_,
tableA0_.column28 as column28_35_,
tableA0_.column29 as column29_35_,
tableA0_.column30 as column30_35_,
tableA0_.column31 as column31_35_,
tableA0_.column32 as column32_35_,
tableA0_.column33 as column33_35_
from
table_A tableA0_
where
tableA0_.key_column1=?
13:33:08,714 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) unregistering connection from connection manager: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl@17e36ca, connection: org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@851bd3, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,716 TRACE [org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener] (http--0.0.0.0-3809-6) unregisterConnection: 0 handles left
13:33:08,717 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) ManagedConnectionPool: 18aaf26
Method: returnConnection(1f112a3, false)
ManagedConnectionFactory:
Class: org.jboss.jca.adapters.jdbc.local.LocalManagedConnectionFactory
Object: beff97
ConnectionListenerFactory:
Class: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl
Object: 17e36ca
Pool:
Name: jdbc/myDB
PoolConfiguration:
MinSize: 0
MaxSize: 20
BlockingTimeout: 30000
IdleTimeoutMinutes: 30
BackgroundValidation: false
BackgroundValidationMillis: 0
StrictMin: false
UseFastFail: false
Available:
InUse:
1f112a3 (NORMAL)
Statistics:
ActiveCount: 1
AvailableCount: 19
AverageBlockingTime: 0
AverageCreationTime: 135
CreatedCount: 1
DestroyedCount: 0
MaxCreationTime: 135
MaxUsedCount: 1
MaxWaitCount: 0
MaxWaitTime: 0
TimedOut: 0
TotalBlockingTime: 0
TotalCreationTime: 135
13:33:08,721 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Returning connection to pool org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener@1f112a3[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@1fea6ff connection handles=0 lastUse=1371749588721 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@1ad4fbf pool internal context=SemaphoreArrayListManagedConnectionPool@18aaf26[pool=jdbc/myDB]]
13:33:08,723 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:08,723 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,724 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,724 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,724 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:33:08,725 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,725 DEBUG [org.jboss.as.jpa] (http--0.0.0.0-3809-6) http--0.0.0.0-3809-6:[transaction scoped EntityManager]: reuse entity manager session already in tx TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b status: ActionStatus.RUNNING >
13:33:08,729 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:08,729 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,734 TRACE [org.jboss.jca.core.connectionmanager.NoTxConnectionManager] (http--0.0.0.0-3809-6) Subject: Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
13:33:08,735 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) ManagedConnectionPool: 18aaf26
Method: getConnection(Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
, null)
ManagedConnectionFactory:
Class: org.jboss.jca.adapters.jdbc.local.LocalManagedConnectionFactory
Object: beff97
ConnectionListenerFactory:
Class: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl
Object: 17e36ca
Pool:
Name: jdbc/myDB
PoolConfiguration:
MinSize: 0
MaxSize: 20
BlockingTimeout: 30000
IdleTimeoutMinutes: 30
BackgroundValidation: false
BackgroundValidationMillis: 0
StrictMin: false
UseFastFail: false
Available:
1f112a3 (NORMAL)
InUse:
Statistics:
ActiveCount: 1
AvailableCount: 20
AverageBlockingTime: 0
AverageCreationTime: 135
CreatedCount: 1
DestroyedCount: 0
MaxCreationTime: 135
MaxUsedCount: 1
MaxWaitCount: 0
MaxWaitTime: 0
TimedOut: 0
TotalBlockingTime: 0
TotalCreationTime: 135
13:33:08,740 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) supplying ManagedConnection from pool: org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener@1f112a3[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@1fea6ff connection handles=0 lastUse=1371749588721 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@1ad4fbf pool internal context=SemaphoreArrayListManagedConnectionPool@18aaf26[pool=jdbc/myDB]]
13:33:08,742 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Got connection from pool: org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener@1f112a3[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@1fea6ff connection handles=0 lastUse=1371749588721 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@1ad4fbf pool internal context=SemaphoreArrayListManagedConnectionPool@18aaf26[pool=jdbc/myDB]]
13:33:08,744 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) registering connection from connection manager: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl@17e36ca, connection : org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@110b9be, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,746 DEBUG [org.hibernate.SQL] (http--0.0.0.0-3809-6)
insert
into
table_A
(KeyColumn1, column2,column3, column4, column5, column6,column7, column8, column9, column10, column11, column12, column13, column14, column15, column16, column17, column18, column19, column20, column21, column22, column23, column24, column25, column26, column27, column28, column29, column30, column31, column32)
values
(?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
13:33:08,755 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) unregistering connection from connection manager: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl@17e36ca, connection: org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@110b9be, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,756 TRACE [org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener] (http--0.0.0.0-3809-6) unregisterConnection: 0 handles left
13:33:08,757 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) ManagedConnectionPool: 18aaf26
Method: returnConnection(1f112a3, false)
ManagedConnectionFactory:
Class: org.jboss.jca.adapters.jdbc.local.LocalManagedConnectionFactory
Object: beff97
ConnectionListenerFactory:
Class: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl
Object: 17e36ca
Pool:
Name: jdbc/myDB
PoolConfiguration:
MinSize: 0
MaxSize: 20
BlockingTimeout: 30000
IdleTimeoutMinutes: 30
BackgroundValidation: false
BackgroundValidationMillis: 0
StrictMin: false
UseFastFail: false
Available:
InUse:
1f112a3 (NORMAL)
Statistics:
ActiveCount: 1
AvailableCount: 19
AverageBlockingTime: 0
AverageCreationTime: 135
CreatedCount: 1
DestroyedCount: 0
MaxCreationTime: 135
MaxUsedCount: 1
MaxWaitCount: 0
MaxWaitTime: 0
TimedOut: 0
TotalBlockingTime: 0
TotalCreationTime: 135
13:33:08,761 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Returning connection to pool org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener@1f112a3[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@1fea6ff connection handles=0 lastUse=1371749588761 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@1ad4fbf pool internal context=SemaphoreArrayListManagedConnectionPool@18aaf26[pool=jdbc/myDB]]
13:33:08,764 TRACE [org.jboss.as.jpa] (http--0.0.0.0-3809-6) persist entityClass 'mil.tis.Widget.TableABean' took 40ms
13:33:08,765 ERROR [mil.tis.Widget.WidgetManagerImpl] (http--0.0.0.0-3809-6) java.lang.RuntimeException: EXCEPTION!
13:33:08,765 INFO [stdout] (http--0.0.0.0-3809-6) The try-catch block in the Session bean method was hit. 13:33:08,766 INFO [stdout] (http--0.0.0.0-3809-6) About to re-throw the exception back to the JSF Managed bean in the Web Tier. 13:33:08,766 INFO [stdout] (http--0.0.0.0-3809-6) ----------------------------------------------------- 13:33:08,767 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,767 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,767 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,767 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,767 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,768 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,768 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,768 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,768 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,768 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,769 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,769 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,769 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,769 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,770 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,770 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,770 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,770 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,771 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,771 INFO [stdout] (http--0.0.0.0-3809-6) 13:33:08,772 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.setRollbackOnly
13:33:08,772 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::preventCommit( BasicAction: 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b status: ActionStatus.RUNNING)
13:33:08,773 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,773 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.rollback
13:33:08,773 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.rollbackAndDisassociate
13:33:08,774 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::Abort() for action-id 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b
13:33:08,774 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.afterCompletion
13:33:08,775 DEBUG [org.jboss.as.jpa] (http--0.0.0.0-3809-6) http--0.0.0.0-3809-6:[transaction scoped EntityManager]: closing entity managersession
13:33:08,775 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:08,776 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,776 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.afterCompletion
13:33:08,776 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.afterCompletion
13:33:08,777 INFO [org.jboss.as.ejb3] (http--0.0.0.0-3809-6) JBAS014101: Failed to find SFSB instance with session ID {[85, 49, 27, -41, -47, 51, 77, -106, -73, -3, 47, -31, -94, 119, -62, 57]} in cache
13:33:08,778 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::removeChildThread () action 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b removing TSThread:2
13:33:08,778 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::removeChildThread () action 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b removing TSThread:2 result = true
13:33:08,779 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) TransactionReaper::remove ( BasicAction: 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3b status: ActionStatus.ABORTED )
13:33:08,780 ERROR [org.jboss.ejb3.invocation] (http--0.0.0.0-3809-6) JBAS014134: EJB Invocation failed on component WidgetManager30Bean for method public abstract mil.tis.Widget.TableABean mil.tis.Widget.WidgetManager30.createData(java.lang.String,mil.tis.Widget.TableABean,java.util.Collection) throws java.lang.Exception: javax.ejb.EJBException: java.lang.RuntimeException: EXCEPTION!
at org.jboss.as.ejb3.tx.CMTTxInterceptor.handleExceptionInOurTx(CMTTxInterceptor.java:166) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:230) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.required(CMTTxInterceptor.java:304) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:190) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.remote.EJBRemoteTransactionPropagatingInterceptor.processInvocation(EJBRemoteTransactionPropagatingInterceptor.java:80) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.interceptors.AdditionalSetupInterceptor.processInvocation(AdditionalSetupInterceptor.java:32) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.as.ejb3.remote.LocalEjbReceiver.processInvocation(LocalEjbReceiver.java:179) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.ejb.client.EJBClientInvocationContext.sendRequest(EJBClientInvocationContext.java:179) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.TransactionInterceptor.handleInvocation(TransactionInterceptor.java:43) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.EJBClientInvocationContext.sendRequest(EJBClientInvocationContext.java:181) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.ReceiverInterceptor.handleInvocation(ReceiverInterceptor.java:128) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.EJBClientInvocationContext.sendRequest(EJBClientInvocationContext.java:181) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.EJBInvocationHandler.doInvoke(EJBInvocationHandler.java:136) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.EJBInvocationHandler.doInvoke(EJBInvocationHandler.java:121) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.EJBInvocationHandler.invoke(EJBInvocationHandler.java:104) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at $Proxy69.createData(Unknown Source) at mil.tis.jsp.pages.movementWidgetning.WidgetManager.PageTOSourceSearch.createData(PageTOSourceSearch.java:576)
at mil.tis.jsp.pages.movementWidgetning.WidgetManager.PageTOSourceSearch.createNewWidget(PageTOSourceSearch.java:367)
at mil.tis.jsp.pages.movementWidgetning.WidgetManager.PageRTTATOImport.createWidgetWithRTTAUnits(PageRTTATOImport.java:178)
at mil.tis.jsp.pages.movementWidgetning.WidgetManager.PageRTTATOImport.importRTTAFile(PageRTTATOImport.java:137)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_07]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_07]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_07]
at java.lang.reflect.Method.invoke(Method.java:601) [rt.jar:1.7.0_07]
at org.apache.el.parser.AstValue.invoke(AstValue.java:262)
at org.apache.el.MethodExpressionImpl.invoke(MethodExpressionImpl.java:278)
at com.sun.faces.facelets.el.TagMethodExpression.invoke(TagMethodExpression.java:105)
at javax.faces.component.MethodBindingMethodExpressionAdapter.invoke(MethodBindingMethodExpressionAdapter.java:88)
at com.sun.faces.application.ActionListenerImpl.processAction(ActionListenerImpl.java:102)
at javax.faces.component.UICommand.broadcast(UICommand.java:315)
at javax.faces.component.UIViewRoot.broadcastEvents(UIViewRoot.java:794)
at javax.faces.component.UIViewRoot.processApplication(UIViewRoot.java:1259)
at com.sun.faces.lifecycle.InvokeApplicationPhase.execute(InvokeApplicationPhase.java:81)
at com.sun.faces.lifecycle.Phase.doPhase(Phase.java:101)
at com.sun.faces.lifecycle.LifecycleImpl.execute(LifecycleImpl.java:118)
at javax.faces.webapp.FacesServlet.service(FacesServlet.java:593)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:329)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:248)
at org.primefaces.webapp.filter.FileUploadFilter.doFilter(FileUploadFilter.java:77)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:280)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:248)
at mil.tis.authentication.AssetManagementAuthenticationFilter.doFilter(AssetManagementAuthenticationFilter.java:139)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:280)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:248)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:275)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:161)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:397)
at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:153)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:155)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:368)
at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:877)
at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:671)
at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:930)
at java.lang.Thread.run(Thread.java:722) [rt.jar:1.7.0_07]
Caused by: java.lang.RuntimeException: EXCEPTION!
at mil.tis.nonprofitOrg.nonprofitOrgManagerImpl.createnonprofitOrgBasedOnRTTA(nonprofitOrgManagerImpl.java:372) [myBusinessLogic.jar:]
at mil.tis.Widget.WidgetManagerImpl.createData(WidgetManagerImpl.java:395) [myBusinessLogic.jar:]
at mil.tis.Widget.WidgetManager30Bean.createData(WidgetManager30Bean.java:535) [myBusinessLogic.jar:]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_07]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_07]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_07]
at java.lang.reflect.Method.invoke(Method.java:601) [rt.jar:1.7.0_07]
at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.jpa.interceptor.SBInvocationInterceptor.processInvocation(SBInvocationInterceptor.java:47) [jboss-as-jpa-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.jpa.interceptor.SFSBInvocationInterceptor.processInvocation(SFSBInvocationInterceptor.java:58) [jboss-as-jpa-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.stateful.StatefulSessionSynchronizationInterceptor.processInvocation(StatefulSessionSynchronizationInterceptor.java:156) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.stateful.StatefulComponentInstanceInterceptor.processInvocation(StatefulComponentInstanceInterceptor.java:66) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:228) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
... 67 more
13:33:08,857 DEBUG [org.jboss.as.jpa] (http--0.0.0.0-3809-6) created new TransactionScopedEntityManager for unit name=Aims.ear/myBusinessLogic.jar#myEjb30
13:33:08,857 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.begin
13:33:08,858 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) StateManager::StateManager( 2, 0 )
13:33:08,858 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::BasicAction()
13:33:08,858 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::Begin() for action-id 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3f
13:33:08,859 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::actionInitialise() for action-id 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3f
13:33:08,860 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) ActionHierarchy::ActionHierarchy(5)
13:33:08,860 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) ActionHierarchy::add(0:ffffc0a82a4b:6d8c5a11:51c33c8e:3f, 1)
13:33:08,860 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::addChildThread () action 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3f adding Thread[http--0.0.0.0-3809-6,5,main]
13:33:08,861 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::addChildThread () action 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3f adding Thread[http--0.0.0.0-3809-6,5,main] result = true
13:33:08,862 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) TransactionReaper::insert ( BasicAction: 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3f status: ActionStatus.RUNNING, 300 )
13:33:08,862 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) ReaperElement::ReaperElement ( BasicAction: 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3f status: ActionStatus.RUNNING, 300 )
13:33:08,863 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:33:08,864 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:33:08,864 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionStatus
13:33:08,865 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:08,865 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,865 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.registerInterposedSynchronization
13:33:08,866 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,866 TRACE [org.jboss.jca.core.connectionmanager.NoTxConnectionManager] (http--0.0.0.0-3809-6) Subject: Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
13:33:08,868 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) ManagedConnectionPool: 18aaf26
Method: getConnection(Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
, null)
ManagedConnectionFactory:
Class: org.jboss.jca.adapters.jdbc.local.LocalManagedConnectionFactory
Object: beff97
ConnectionListenerFactory:
Class: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl
Object: 17e36ca
Pool:
Name: jdbc/myDB
PoolConfiguration:
MinSize: 0
MaxSize: 20
BlockingTimeout: 30000
IdleTimeoutMinutes: 30
BackgroundValidation: false
BackgroundValidationMillis: 0
StrictMin: false
UseFastFail: false
Available:
1f112a3 (NORMAL)
InUse:
Statistics:
ActiveCount: 1
AvailableCount: 20
AverageBlockingTime: 0
AverageCreationTime: 135
CreatedCount: 1
DestroyedCount: 0
MaxCreationTime: 135
MaxUsedCount: 1
MaxWaitCount: 0
MaxWaitTime: 0
TimedOut: 0
TotalBlockingTime: 0
TotalCreationTime: 135
13:33:08,873 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) supplying ManagedConnection from pool: org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener@1f112a3[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@1fea6ff connection handles=0 lastUse=1371749588761 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@1ad4fbf pool internal context=SemaphoreArrayListManagedConnectionPool@18aaf26[pool=jdbc/myDB]]
13:33:08,875 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Got connection from pool: org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener@1f112a3[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@1fea6ff connection handles=0 lastUse=1371749588761 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@1ad4fbf pool internal context=SemaphoreArrayListManagedConnectionPool@18aaf26[pool=jdbc/myDB]]
13:33:08,877 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) registering connection from connection manager: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl@17e36ca, connection : org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@705324, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,879 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) unregistering connection from connection manager: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl@17e36ca, connection: org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@705324, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,881 TRACE [org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener] (http--0.0.0.0-3809-6) unregisterConnection: 0 handles left
13:33:08,882 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) ManagedConnectionPool: 18aaf26
Method: returnConnection(1f112a3, false)
ManagedConnectionFactory:
Class: org.jboss.jca.adapters.jdbc.local.LocalManagedConnectionFactory
Object: beff97
ConnectionListenerFactory:
Class: org.jboss.jca.core.connectionmanager.notx.NoTxConnectionManagerImpl
Object: 17e36ca
Pool:
Name: jdbc/myDB
PoolConfiguration:
MinSize: 0
MaxSize: 20
BlockingTimeout: 30000
IdleTimeoutMinutes: 30
BackgroundValidation: false
BackgroundValidationMillis: 0
StrictMin: false
UseFastFail: false
Available:
InUse:
1f112a3 (NORMAL)
Statistics:
ActiveCount: 1
AvailableCount: 19
AverageBlockingTime: 0
AverageCreationTime: 135
CreatedCount: 1
DestroyedCount: 0
MaxCreationTime: 135
MaxUsedCount: 1
MaxWaitCount: 0
MaxWaitTime: 0
TimedOut: 0
TotalBlockingTime: 0
TotalCreationTime: 135
13:33:08,886 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Returning connection to pool org.jboss.jca.core.connectionmanager.listener.NoTxConnectionListener@1f112a3[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@1fea6ff connection handles=0 lastUse=1371749588886 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@1ad4fbf pool internal context=SemaphoreArrayListManagedConnectionPool@18aaf26[pool=jdbc/myDB]]
13:33:08,888 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:33:08,889 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.commit
13:33:08,889 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.commitAndDisassociate
13:33:08,889 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.beforeCompletion
13:33:08,890 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::End() for action-id 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3f
13:33:08,890 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.afterCompletion
13:33:08,891 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::removeChildThread () action 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3f removing TSThread:2
13:33:08,891 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::removeChildThread () action 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3f removing TSThread:2 result = true
13:33:08,892 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) TransactionReaper::remove ( BasicAction: 0:ffffc0a82a4b:6d8c5a11:51c33c8e:3f status: ActionStatus.COMMITTED )
13:33:08,907 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,908 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:08,932 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,933 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,932 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-4) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,933 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-2) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,933 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-5) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,933 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,938 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-2) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,936 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,937 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-4) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,935 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,941 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-4) BaseTransaction.getStatus
13:33:08,940 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:08,939 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,940 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-2) BaseTransaction.getStatus
13:33:08,939 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-5) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,943 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-1) BaseTransaction.getStatus
13:33:08,942 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-4) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,942 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-3) BaseTransaction.getStatus
13:33:08,944 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-5) BaseTransaction.getStatus
13:33:08,946 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-4) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,947 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-4) BaseTransaction.getStatus
13:33:08,947 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,950 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:08,951 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:09,056 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1d1030c
13:33:09,058 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1d1030c
13:33:09,059 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:33:09,060 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:09,062 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@6c042d
13:33:09,063 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
With JTA
[stdout] (http--0.0.0.0-3809-6) In the JSF Managed bean. About to call Session Bean method.... 13:35:10,427 DEBUG [org.jboss.as.jpa] (http--0.0.0.0-3809-6) created new TransactionScopedEntityManager for unit name=Aims.ear/myBusinessLogic.jar#myEjb30
13:35:10,428 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.begin
13:35:10,429 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) StateManager::StateManager( 2, 0 )
13:35:10,429 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::BasicAction()
13:35:10,429 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::Begin() for action-id 0:ffffc0a82a4b:3475f402:51c33d15:57
13:35:10,430 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::actionInitialise() for action-id 0:ffffc0a82a4b:3475f402:51c33d15:57
13:35:10,430 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) ActionHierarchy::ActionHierarchy(5)
13:35:10,431 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) ActionHierarchy::add(0:ffffc0a82a4b:3475f402:51c33d15:57, 1)
13:35:10,431 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::addChildThread () action 0:ffffc0a82a4b:3475f402:51c33d15:57 adding Thread[http--0.0.0.0-3809-6,5,main]
13:35:10,432 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::addChildThread () action 0:ffffc0a82a4b:3475f402:51c33d15:57 adding Thread[http--0.0.0.0-3809-6,5,main] result = true
13:35:10,433 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) TransactionReaper::insert ( BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING, 300 )
13:35:10,433 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) ReaperElement::ReaperElement ( BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING, 300 )
13:35:10,434 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,434 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,435 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionStatus
13:35:10,435 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,435 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,436 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.registerInterposedSynchronization
13:35:10,436 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,437 INFO [stdout] (http--0.0.0.0-3809-6) Method called in Session Bean. 13:35:10,438 TRACE [org.jboss.jca.core.connectionmanager.TxConnectionManager] (http--0.0.0.0-3809-6) Subject: Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
13:35:10,439 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,439 TRACE [org.jboss.jca.core.connectionmanager.TxConnectionManager] (http--0.0.0.0-3809-6) getManagedConnection interleaving=false , tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,440 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,440 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,441 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,441 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,441 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,442 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,442 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,443 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.putResource
13:35:10,443 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,443 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,444 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,444 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) ManagedConnectionPool: 71bd0d
Method: getConnection(Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
, null)
ManagedConnectionFactory:
Class: org.jboss.jca.adapters.jdbc.local.LocalManagedConnectionFactory
Object: 1bc552c
ConnectionListenerFactory:
Class: org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl
Object: 17bd63d
Pool:
Name: jdbc/myDB
PoolConfiguration:
MinSize: 0
MaxSize: 20
BlockingTimeout: 30000
IdleTimeoutMinutes: 30
BackgroundValidation: false
BackgroundValidationMillis: 0
StrictMin: false
UseFastFail: false
Available:
132df48 (NORMAL)
InUse:
Statistics:
ActiveCount: 1
AvailableCount: 20
AverageBlockingTime: 0
AverageCreationTime: 14
CreatedCount: 1
DestroyedCount: 0
MaxCreationTime: 14
MaxUsedCount: 1
MaxWaitCount: 0
MaxWaitTime: 0
TimedOut: 0
TotalBlockingTime: 0
TotalCreationTime: 14
13:35:10,450 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) supplying ManagedConnection from pool: org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null]
13:35:10,452 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Got connection from pool tracked by transaction=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null] tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,455 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,456 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,456 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,456 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,457 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,457 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.putResource
13:35:10,457 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,458 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Using connection from pool tracked by transaction=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null] tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,460 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,461 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,461 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Pre-enlist: org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null] threadTx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,464 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Get synchronizer org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null] threadTx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,466 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.registerInterposedSynchronization
13:35:10,467 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,467 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Enlisting resource org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=TxSync20187306{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=false}]
13:35:10,470 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.enlistResource ( LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] )
13:35:10,470 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,471 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) StateManager::StateManager( 0:0:0:0:1 )
13:35:10,471 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) AbstractRecord::AbstractRecord (0:0:0:0:1)
13:35:10,471 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) LastResourceRecord()
13:35:10,472 TRACE [org.jboss.jca.core.tx.jbossts.LocalXAResourceImpl] (http--0.0.0.0-3809-6) start(< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:57, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:5a, subordinatenodename=null, eis_name=unknown eis name >, 0)
13:35:10,473 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) RecordList::insert(RecordList: empty) : appending /StateManager/AbstractRecord/LastResourceRecord for 0:0:0:0:1
13:35:10,474 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Enlisted resource org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:57, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:5a, subordinatenodename=null, eis_name=unknown eis name >] txSync=TxSync20187306{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=false}]
13:35:10,477 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Check enlisted org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:57, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:5a, subordinatenodename=null, eis_name=unknown eis name >] txSync=TxSync20187306{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=true}] threadTx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,481 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) registering connection from connection manager: org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl@17bd63d, connection : org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@124d183, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,483 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) connectionClosed called mc=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168
13:35:10,484 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) unregistering connection from connection manager: org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl@17bd63d, connection: org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@124d183, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,486 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) unregisterConnection: 0 handles left
13:35:10,486 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) isManagedConnectionFree=false mc=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168
13:35:10,487 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,487 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,488 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,488 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionStatus
13:35:10,489 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,489 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,489 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getRollbackOnly
13:35:10,490 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,490 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,490 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,491 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,491 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.registerInterposedSynchronization
13:35:10,491 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,492 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,492 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,492 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,493 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,493 DEBUG [org.jboss.as.jpa] (http--0.0.0.0-3809-6) http--0.0.0.0-3809-6:[transaction scoped EntityManager]: created entity manager session TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,494 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.registerInterposedSynchronization
13:35:10,495 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,495 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.putResource
13:35:10,495 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,496 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,496 TRACE [org.jboss.as.jpa] (http--0.0.0.0-3809-6) createNamedQuery name 'TableABean.checkWidgetForAUnit' took 9ms
13:35:10,497 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,497 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,498 TRACE [org.jboss.jca.core.connectionmanager.TxConnectionManager] (http--0.0.0.0-3809-6) Subject: Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
13:35:10,499 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,499 TRACE [org.jboss.jca.core.connectionmanager.TxConnectionManager] (http--0.0.0.0-3809-6) getManagedConnection interleaving=false , tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,500 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,500 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,501 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,501 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,502 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,502 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,502 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Previous connection tracked by transaction=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:57, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:5a, subordinatenodename=null, eis_name=unknown eis name >] txSync=TxSync20187306{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=true}] tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,506 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,506 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,507 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Pre-enlist: org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:57, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:5a, subordinatenodename=null, eis_name=unknown eis name >] txSync=TxSync20187306{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=true}] threadTx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,511 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.equals
13:35:10,511 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Get synchronizer org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:57, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:5a, subordinatenodename=null, eis_name=unknown eis name >] txSync=TxSync20187306{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=true}] threadTx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,515 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Check enlisted org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:57, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:5a, subordinatenodename=null, eis_name=unknown eis name >] txSync=TxSync20187306{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=true}] threadTx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,518 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) registering connection from connection manager: org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl@17bd63d, connection : org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@d1afad, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,520 DEBUG [org.hibernate.SQL] (http--0.0.0.0-3809-6)
select
top 2 tableA0_.keyColumn1 as KeyCol1_35_,
tableA0_.column2 as column2_35_,
tableA0_.column3 as column3_35_,
tableA0_.column4 as column4_35_,
tableA0_.column5 as column5_35_,
tableA0_.column6 as column6_35_,
tableA0_.column7 as column7_35_,
tableA0_.column8 as column8_35_,
tableA0_.column9 as column9_35_,
tableA0_.column10 as column10_35_,
tableA0_.column11 as column11_35_,
tableA0_.column12 as column12_35_,
tableA0_.column13 as column13_35_,
tableA0_.column14 as column14_35_,
tableA0_.column15 as column15_35_,
tableA0_.column16 as column16_35_,
tableA0_.column17 as column17_35_,
tableA0_.column18 as column18_35_,
tableA0_.column19 as column19_35_,
tableA0_.column20 as column20_35_,
tableA0_.column21 as column21_35_,
tableA0_.column22 as column22_35_,
tableA0_.column23 as column23_35_,
tableA0_.column24 as column24_35_,
tableA0_.column25 as column25_35_,
tableA0_.column26 as column26_35_,
tableA0_.column27 as column27_35_,
tableA0_.column28 as column28_35_,
tableA0_.column29 as column29_35_,
tableA0_.column30 as column30_35_,
tableA0_.column31 as column31_35_,
tableA0_.column32 as column32_35_,
tableA0_.column33 as column33_35_
from
table_A tableA0_
where
tableA0_.key_column1=?
13:35:10,530 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) connectionClosed called mc=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168
13:35:10,531 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) unregistering connection from connection manager: org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl@17bd63d, connection: org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@d1afad, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,532 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) unregisterConnection: 0 handles left
13:35:10,533 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) isManagedConnectionFree=false mc=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168
13:35:10,534 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,534 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,534 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,535 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,535 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,536 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,536 DEBUG [org.jboss.as.jpa] (http--0.0.0.0-3809-6) http--0.0.0.0-3809-6:[transaction scoped EntityManager]: reuse entity manager session already in tx TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,539 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,539 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,543 TRACE [org.jboss.jca.core.connectionmanager.TxConnectionManager] (http--0.0.0.0-3809-6) Subject: Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
13:35:10,544 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,544 TRACE [org.jboss.jca.core.connectionmanager.TxConnectionManager] (http--0.0.0.0-3809-6) getManagedConnection interleaving=false , tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,545 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,545 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,546 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,546 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,547 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,547 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,547 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Previous connection tracked by transaction=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:57, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:5a, subordinatenodename=null, eis_name=unknown eis name >] txSync=TxSync20187306{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=true}] tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,551 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,551 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,552 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Pre-enlist: org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:57, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:5a, subordinatenodename=null, eis_name=unknown eis name >] txSync=TxSync20187306{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=true}] threadTx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,556 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.equals
13:35:10,556 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Get synchronizer org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:57, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:5a, subordinatenodename=null, eis_name=unknown eis name >] txSync=TxSync20187306{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=true}] threadTx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,560 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Check enlisted org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:57, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:5a, subordinatenodename=null, eis_name=unknown eis name >] txSync=TxSync20187306{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=true}] threadTx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING >
13:35:10,563 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) registering connection from connection manager: org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl@17bd63d, connection : org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@1262a10, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,565 DEBUG [org.hibernate.SQL] (http--0.0.0.0-3809-6)
insert
into
table_A
(KeyColumn1, column2,column3, column4, column5, column6,column7, column8, column9, column10, column11, column12, column13, column14, column15, column16, column17, column18, column19, column20, column21, column22, column23, column24, column25, column26, column27, column28, column29, column30, column31, column32)
values
(?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
13:35:10,573 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) connectionClosed called mc=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168
13:35:10,574 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) unregistering connection from connection manager: org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl@17bd63d, connection: org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@1262a10, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,576 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) unregisterConnection: 0 handles left
13:35:10,576 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) isManagedConnectionFree=false mc=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168
13:35:10,577 TRACE [org.jboss.as.jpa] (http--0.0.0.0-3809-6) persist entityClass 'mil.tis.Widget.TableABean' took 43ms
13:35:10,578 ERROR [mil.tis.Widget.WidgetManagerImpl] (http--0.0.0.0-3809-6) java.lang.RuntimeException: EXCEPTION!
13:35:10,578 INFO [stdout] (http--0.0.0.0-3809-6) The try-catch block in the Session bean method was hit. 13:35:10,579 INFO [stdout] (http--0.0.0.0-3809-6) About to re-throw the exception back to the JSF Managed bean in the Web Tier. 13:35:10,579 INFO [stdout] (http--0.0.0.0-3809-6) ----------------------------------------------------- 13:35:10,580 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,580 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,580 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,580 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,581 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,581 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,581 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,581 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,581 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,582 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,582 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,582 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,582 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,583 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,583 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,583 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,583 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,584 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,584 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,584 INFO [stdout] (http--0.0.0.0-3809-6) 13:35:10,585 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.setRollbackOnly
13:35:10,585 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::preventCommit( BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.RUNNING)
13:35:10,586 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,586 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.rollback
13:35:10,586 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.rollbackAndDisassociate
13:35:10,587 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::Abort() for action-id 0:ffffc0a82a4b:3475f402:51c33d15:57
13:35:10,587 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::doAbort (LastResourceRecord(XAOnePhaseResource(LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:57, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:5a, subordinatenodename=null, eis_name=unknown eis name >])))
13:35:10,589 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) LastResourceRecord::topLevelAbort() for 0:0:0:0:1
13:35:10,590 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.afterCompletion
13:35:10,591 DEBUG [org.jboss.as.jpa] (http--0.0.0.0-3809-6) http--0.0.0.0-3809-6:[transaction scoped EntityManager]: closing entity managersession
13:35:10,591 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,592 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,592 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.afterCompletion
13:35:10,592 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.afterCompletion
13:35:10,593 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) afterCompletion(4) isTrackByTx=true for org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710417 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null]
13:35:10,595 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) ManagedConnectionPool: 71bd0d
Method: returnConnection(132df48, false)
ManagedConnectionFactory:
Class: org.jboss.jca.adapters.jdbc.local.LocalManagedConnectionFactory
Object: 1bc552c
ConnectionListenerFactory:
Class: org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl
Object: 17bd63d
Pool:
Name: jdbc/myDB
PoolConfiguration:
MinSize: 0
MaxSize: 20
BlockingTimeout: 30000
IdleTimeoutMinutes: 30
BackgroundValidation: false
BackgroundValidationMillis: 0
StrictMin: false
UseFastFail: false
Available:
InUse:
132df48 (NORMAL)
Statistics:
ActiveCount: 1
AvailableCount: 19
AverageBlockingTime: 0
AverageCreationTime: 14
CreatedCount: 1
DestroyedCount: 0
MaxCreationTime: 14
MaxUsedCount: 1
MaxWaitCount: 0
MaxWaitTime: 0
TimedOut: 0
TotalBlockingTime: 0
TotalCreationTime: 14
13:35:10,600 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Returning connection to pool org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710600 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null]
13:35:10,602 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.afterCompletion
13:35:10,603 INFO [org.jboss.as.ejb3] (http--0.0.0.0-3809-6) JBAS014101: Failed to find SFSB instance with session ID {[16, 120, -14, 4, -94, -20, 75, -120, -119, -73, 69, -94, 5, 71, -118, -72]} in cache
13:35:10,604 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::removeChildThread () action 0:ffffc0a82a4b:3475f402:51c33d15:57 removing TSThread:2
13:35:10,604 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::removeChildThread () action 0:ffffc0a82a4b:3475f402:51c33d15:57 removing TSThread:2 result = true
13:35:10,605 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) TransactionReaper::remove ( BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:57 status: ActionStatus.ABORTED )
13:35:10,606 ERROR [org.jboss.ejb3.invocation] (http--0.0.0.0-3809-6) JBAS014134: EJB Invocation failed on component WidgetManager30Bean for method public abstract mil.tis.Widget.TableABean mil.tis.Widget.WidgetManager30.createData(java.lang.String,mil.tis.Widget.TableABean,java.util.Collection) throws java.lang.Exception: javax.ejb.EJBException: java.lang.RuntimeException: EXCEPTION!
at org.jboss.as.ejb3.tx.CMTTxInterceptor.handleExceptionInOurTx(CMTTxInterceptor.java:166) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:230) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.required(CMTTxInterceptor.java:304) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:190) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.remote.EJBRemoteTransactionPropagatingInterceptor.processInvocation(EJBRemoteTransactionPropagatingInterceptor.java:80) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.interceptors.AdditionalSetupInterceptor.processInvocation(AdditionalSetupInterceptor.java:32) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.as.ejb3.remote.LocalEjbReceiver.processInvocation(LocalEjbReceiver.java:179) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.ejb.client.EJBClientInvocationContext.sendRequest(EJBClientInvocationContext.java:179) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.TransactionInterceptor.handleInvocation(TransactionInterceptor.java:43) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.EJBClientInvocationContext.sendRequest(EJBClientInvocationContext.java:181) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.ReceiverInterceptor.handleInvocation(ReceiverInterceptor.java:128) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.EJBClientInvocationContext.sendRequest(EJBClientInvocationContext.java:181) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.EJBInvocationHandler.doInvoke(EJBInvocationHandler.java:136) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.EJBInvocationHandler.doInvoke(EJBInvocationHandler.java:121) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at org.jboss.ejb.client.EJBInvocationHandler.invoke(EJBInvocationHandler.java:104) [jboss-ejb-client-1.0.5.Final.jar:1.0.5.Final]
at $Proxy69.createData(Unknown Source) at mil.tis.jsp.pages.movementWidgetning.WidgetManager.PageTOSourceSearch.createData(PageTOSourceSearch.java:576)
at mil.tis.jsp.pages.movementWidgetning.WidgetManager.PageTOSourceSearch.createNewWidget(PageTOSourceSearch.java:367)
at mil.tis.jsp.pages.movementWidgetning.WidgetManager.PageRTTATOImport.createWidgetWithRTTAUnits(PageRTTATOImport.java:178)
at mil.tis.jsp.pages.movementWidgetning.WidgetManager.PageRTTATOImport.importRTTAFile(PageRTTATOImport.java:137)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_07]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_07]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_07]
at java.lang.reflect.Method.invoke(Method.java:601) [rt.jar:1.7.0_07]
at org.apache.el.parser.AstValue.invoke(AstValue.java:262)
at org.apache.el.MethodExpressionImpl.invoke(MethodExpressionImpl.java:278)
at com.sun.faces.facelets.el.TagMethodExpression.invoke(TagMethodExpression.java:105)
at javax.faces.component.MethodBindingMethodExpressionAdapter.invoke(MethodBindingMethodExpressionAdapter.java:88)
at com.sun.faces.application.ActionListenerImpl.processAction(ActionListenerImpl.java:102)
at javax.faces.component.UICommand.broadcast(UICommand.java:315)
at javax.faces.component.UIViewRoot.broadcastEvents(UIViewRoot.java:794)
at javax.faces.component.UIViewRoot.processApplication(UIViewRoot.java:1259)
at com.sun.faces.lifecycle.InvokeApplicationPhase.execute(InvokeApplicationPhase.java:81)
at com.sun.faces.lifecycle.Phase.doPhase(Phase.java:101)
at com.sun.faces.lifecycle.LifecycleImpl.execute(LifecycleImpl.java:118)
at javax.faces.webapp.FacesServlet.service(FacesServlet.java:593)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:329)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:248)
at org.primefaces.webapp.filter.FileUploadFilter.doFilter(FileUploadFilter.java:77)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:280)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:248)
at mil.tis.authentication.AssetManagementAuthenticationFilter.doFilter(AssetManagementAuthenticationFilter.java:139)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:280)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:248)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:275)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:161)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:397)
at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:153)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:155)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:368)
at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:877)
at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:671)
at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:930)
at java.lang.Thread.run(Thread.java:722) [rt.jar:1.7.0_07]
Caused by: java.lang.RuntimeException: EXCEPTION!
at mil.tis.nonprofitOrg.nonprofitOrgManagerImpl.createnonprofitOrgBasedOnRTTA(nonprofitOrgManagerImpl.java:372) [myBusinessLogic.jar:]
at mil.tis.Widget.WidgetManagerImpl.createData(WidgetManagerImpl.java:395) [myBusinessLogic.jar:]
at mil.tis.Widget.WidgetManager30Bean.createData(WidgetManager30Bean.java:535) [myBusinessLogic.jar:]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_07]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_07]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_07]
at java.lang.reflect.Method.invoke(Method.java:601) [rt.jar:1.7.0_07]
at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.jpa.interceptor.SBInvocationInterceptor.processInvocation(SBInvocationInterceptor.java:47) [jboss-as-jpa-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.jpa.interceptor.SFSBInvocationInterceptor.processInvocation(SFSBInvocationInterceptor.java:58) [jboss-as-jpa-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.stateful.StatefulSessionSynchronizationInterceptor.processInvocation(StatefulSessionSynchronizationInterceptor.java:156) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.stateful.StatefulComponentInstanceInterceptor.processInvocation(StatefulComponentInstanceInterceptor.java:66) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:228) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
... 67 more
13:35:10,684 DEBUG [org.jboss.as.jpa] (http--0.0.0.0-3809-6) created new TransactionScopedEntityManager for unit name=Aims.ear/myBusinessLogic.jar#myEjb30
13:35:10,684 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.begin
13:35:10,685 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) StateManager::StateManager( 2, 0 )
13:35:10,685 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::BasicAction()
13:35:10,686 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::Begin() for action-id 0:ffffc0a82a4b:3475f402:51c33d15:5d
13:35:10,686 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::actionInitialise() for action-id 0:ffffc0a82a4b:3475f402:51c33d15:5d
13:35:10,687 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) ActionHierarchy::ActionHierarchy(5)
13:35:10,687 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) ActionHierarchy::add(0:ffffc0a82a4b:3475f402:51c33d15:5d, 1)
13:35:10,687 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::addChildThread () action 0:ffffc0a82a4b:3475f402:51c33d15:5d adding Thread[http--0.0.0.0-3809-6,5,main]
13:35:10,688 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::addChildThread () action 0:ffffc0a82a4b:3475f402:51c33d15:5d adding Thread[http--0.0.0.0-3809-6,5,main] result = true
13:35:10,689 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) TransactionReaper::insert ( BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:5d status: ActionStatus.RUNNING, 300 )
13:35:10,690 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) ReaperElement::ReaperElement ( BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:5d status: ActionStatus.RUNNING, 300 )
13:35:10,690 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,691 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,691 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionStatus
13:35:10,691 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,692 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,692 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.registerInterposedSynchronization
13:35:10,693 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,693 TRACE [org.jboss.jca.core.connectionmanager.TxConnectionManager] (http--0.0.0.0-3809-6) Subject: Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
13:35:10,694 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,695 TRACE [org.jboss.jca.core.connectionmanager.TxConnectionManager] (http--0.0.0.0-3809-6) getManagedConnection interleaving=false , tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:5d status: ActionStatus.RUNNING >
13:35:10,696 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,696 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,696 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,697 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,697 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,698 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,698 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,698 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.putResource
13:35:10,699 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,699 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,699 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,700 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) ManagedConnectionPool: 71bd0d
Method: getConnection(Subject:
Principal: JohnDoe
Principal: Roles(members:tisUser)
Principal: CallerPrincipal(members)
Private Credential: javax.resource.spi.security.PasswordCredential@e3ee18a7
, null)
ManagedConnectionFactory:
Class: org.jboss.jca.adapters.jdbc.local.LocalManagedConnectionFactory
Object: 1bc552c
ConnectionListenerFactory:
Class: org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl
Object: 17bd63d
Pool:
Name: jdbc/myDB
PoolConfiguration:
MinSize: 0
MaxSize: 20
BlockingTimeout: 30000
IdleTimeoutMinutes: 30
BackgroundValidation: false
BackgroundValidationMillis: 0
StrictMin: false
UseFastFail: false
Available:
132df48 (NORMAL)
InUse:
Statistics:
ActiveCount: 1
AvailableCount: 20
AverageBlockingTime: 0
AverageCreationTime: 14
CreatedCount: 1
DestroyedCount: 0
MaxCreationTime: 14
MaxUsedCount: 1
MaxWaitCount: 0
MaxWaitTime: 0
TimedOut: 0
TotalBlockingTime: 0
TotalCreationTime: 14
13:35:10,706 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) supplying ManagedConnection from pool: org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710600 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null]
13:35:10,708 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Got connection from pool tracked by transaction=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710600 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null] tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:5d status: ActionStatus.RUNNING >
13:35:10,710 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getTransactionKey
13:35:10,711 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,711 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,712 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.getResource
13:35:10,712 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,713 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.putResource
13:35:10,713 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,713 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Using connection from pool tracked by transaction=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710600 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null] tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:5d status: ActionStatus.RUNNING >
13:35:10,716 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,716 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,717 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Pre-enlist: org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710600 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null] threadTx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:5d status: ActionStatus.RUNNING >
13:35:10,719 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Get synchronizer org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710600 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null] threadTx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:5d status: ActionStatus.RUNNING >
13:35:10,722 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionSynchronizationRegistryImple.registerInterposedSynchronization
13:35:10,722 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,723 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Enlisting resource org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710600 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=TxSync21393570{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:5d status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=false}]
13:35:10,725 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.enlistResource ( LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] )
13:35:10,726 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,726 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) StateManager::StateManager( 0:0:0:0:1 )
13:35:10,727 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) AbstractRecord::AbstractRecord (0:0:0:0:1)
13:35:10,727 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) LastResourceRecord()
13:35:10,728 TRACE [org.jboss.jca.core.tx.jbossts.LocalXAResourceImpl] (http--0.0.0.0-3809-6) start(< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:5d, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:60, subordinatenodename=null, eis_name=unknown eis name >, 0)
13:35:10,729 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) RecordList::insert(RecordList: empty) : appending /StateManager/AbstractRecord/LastResourceRecord for 0:0:0:0:1
13:35:10,729 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Enlisted resource org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710600 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:5d, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:60, subordinatenodename=null, eis_name=unknown eis name >] txSync=TxSync21393570{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:5d status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=false}]
13:35:10,733 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) Check enlisted org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710600 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffffc0a82a4b:3475f402:51c33d15:5d, node_name=1, branch_uid=0:ffffc0a82a4b:3475f402:51c33d15:60, subordinatenodename=null, eis_name=unknown eis name >] txSync=TxSync21393570{tx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:5d status: ActionStatus.RUNNING > wasTrackByTx=true enlisted=true}] threadTx=TransactionImple < ac, BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:5d status: ActionStatus.RUNNING >
13:35:10,736 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) registering connection from connection manager: org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl@17bd63d, connection : org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@18cb4f4, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,739 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) connectionClosed called mc=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168
13:35:10,740 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) unregistering connection from connection manager: org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl@17bd63d, connection: org.jboss.jca.adapters.jdbc.jdk6.WrappedConnectionJDK6@18cb4f4, key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,741 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) unregisterConnection: 0 handles left
13:35:10,742 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) isManagedConnectionFree=false mc=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168
13:35:10,743 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.getStatus
13:35:10,743 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.commit
13:35:10,743 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) TransactionImple.commitAndDisassociate
13:35:10,744 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.beforeCompletion
13:35:10,744 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.beforeCompletion
13:35:10,744 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::End() for action-id 0:ffffc0a82a4b:3475f402:51c33d15:5d
13:35:10,745 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::onePhaseCommit() for action-id 0:ffffc0a82a4b:3475f402:51c33d15:5d
13:35:10,745 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) LastResourceRecord::topLevelPrepare() for 0:0:0:0:1
13:35:10,747 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) LastResourceRecord::topLevelCommit() for 0:0:0:0:1
13:35:10,747 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.afterCompletion
13:35:10,748 TRACE [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http--0.0.0.0-3809-6) afterCompletion(3) isTrackByTx=true for org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710600 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null]
13:35:10,750 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) ManagedConnectionPool: 71bd0d
Method: returnConnection(132df48, false)
ManagedConnectionFactory:
Class: org.jboss.jca.adapters.jdbc.local.LocalManagedConnectionFactory
Object: 1bc552c
ConnectionListenerFactory:
Class: org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl
Object: 17bd63d
Pool:
Name: jdbc/myDB
PoolConfiguration:
MinSize: 0
MaxSize: 20
BlockingTimeout: 30000
IdleTimeoutMinutes: 30
BackgroundValidation: false
BackgroundValidationMillis: 0
StrictMin: false
UseFastFail: false
Available:
InUse:
132df48 (NORMAL)
Statistics:
ActiveCount: 1
AvailableCount: 19
AverageBlockingTime: 0
AverageCreationTime: 14
CreatedCount: 1
DestroyedCount: 0
MaxCreationTime: 14
MaxUsedCount: 1
MaxWaitCount: 0
MaxWaitTime: 0
TimedOut: 0
TotalBlockingTime: 0
TotalCreationTime: 14
13:35:10,756 TRACE [org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject] (http--0.0.0.0-3809-6) Returning connection to pool org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@132df48[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@e11168 connection handles=0 lastUse=1371749710756 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.PoolBySubject@4ec328 pool internal context=SemaphoreArrayListManagedConnectionPool@71bd0d[pool=jdbc/myDB] xaResource=LocalXAResourceImpl@3dfdc4[connectionListener=132df48 connectionManager=17bd63d warned=false currentXid=null] txSync=null]
13:35:10,758 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) SynchronizationImple.afterCompletion
13:35:10,758 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::removeChildThread () action 0:ffffc0a82a4b:3475f402:51c33d15:5d removing TSThread:2
13:35:10,759 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) BasicAction::removeChildThread () action 0:ffffc0a82a4b:3475f402:51c33d15:5d removing TSThread:2 result = true
13:35:10,760 TRACE [com.arjuna.ats.arjuna] (http--0.0.0.0-3809-6) TransactionReaper::remove ( BasicAction: 0:ffffc0a82a4b:3475f402:51c33d15:5d status: ActionStatus.COMMITTED )
13:35:10,774 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,775 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,800 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,800 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,800 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,800 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-5) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,800 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-2) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,800 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-4) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,805 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-2) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,804 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-5) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,803 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,803 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,802 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,808 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-3) BaseTransaction.getStatus
13:35:10,807 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-1) BaseTransaction.getStatus
13:35:10,806 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-5) BaseTransaction.getStatus
13:35:10,806 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-2) BaseTransaction.getStatus
13:35:10,805 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-4) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,809 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,810 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,811 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-4) BaseTransaction.getStatus
13:35:10,809 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,812 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,810 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-2) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,810 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-5) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,814 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,813 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,820 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,815 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-3) BaseTransaction.getStatus
13:35:10,818 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-2) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,819 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-5) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,814 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-4) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,823 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-5) BaseTransaction.getStatus
13:35:10,823 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-2) BaseTransaction.getStatus
13:35:10,822 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,822 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,821 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-1) BaseTransaction.getStatus
13:35:10,824 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-4) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,825 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-2) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,826 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,826 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,826 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,827 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-4) BaseTransaction.getStatus
13:35:10,825 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-5) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,831 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-4) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,830 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,829 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,828 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-3) BaseTransaction.getStatus
13:35:10,828 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-2) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,834 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,833 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-1) BaseTransaction.getStatus
13:35:10,833 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-4) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,831 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-5) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,837 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-4) BaseTransaction.getStatus
13:35:10,836 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,836 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-2) BaseTransaction.getStatus
13:35:10,835 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,839 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,838 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-5) BaseTransaction.getStatus
13:35:10,841 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,840 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,842 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-3) BaseTransaction.getStatus
13:35:10,843 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,845 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,847 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,887 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,887 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,887 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,889 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,888 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,890 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-1) BaseTransaction.getStatus
13:35:10,889 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,891 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-3) BaseTransaction.getStatus
13:35:10,892 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,935 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,935 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,936 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,937 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,938 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-1) BaseTransaction.getStatus
13:35:10,938 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,940 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-2) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,940 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,940 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,942 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-3) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,942 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-2) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1efbafa
13:35:10,940 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,940 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-4) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,940 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-5) old stack for key: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,946 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-4) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,945 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-6) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,944 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-2) BaseTransaction.getStatus
13:35:10,944 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-3) BaseTransaction.getStatus
13:35:10,943 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-1) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,949 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-6) BaseTransaction.getStatus
13:35:10,948 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-4) BaseTransaction.getStatus
13:35:10,947 TRACE [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (http--0.0.0.0-3809-5) popped object: org.jboss.as.connector.deployers.processors.CachedConnectionManagerSetupProcessor$CachedConnectionManagerSetupAction@1058662
13:35:10,950 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-1) BaseTransaction.getStatus
13:35:10,952 TRACE [com.arjuna.ats.jta] (http--0.0.0.0-3809-5) BaseTransaction.getStatus