[jboss-user] [JBoss Cache: Core Edition] - Re: Rolled back transactions sometimes failing to release lo
nathanmesser
do-not-reply at jboss.com
Tue Feb 10 06:58:40 EST 2009
The full trace log for TxInteceptor and org.jboss.cache.lock, just for this transaction is 50MB, however I've attached the last few lines here in case they're helpful
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG Associated gtx in txTable is GlobalTransaction::28 org.jboss.cache.interceptors.TxInterceptor.attachGlobalTransaction(TxInterceptor.java:445)
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG Attempting to unlock /Parameters/SubagParam/1833517 org.jboss.cache.lock.MVCCLockManager.unlock(MVCCLockManager.java:140)
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG Transaction Name=[EJB uk.co.cdl.servercomponent.parameters.service.ParameterServiceEJB.bounceCache(java.lang.String)],Xid=BEA1-00209FA6A83F6F45BCD8(18207047),Status=Rolled back. [Reason=weblogic.transaction.internal.TimedOutException: Transaction timed out after 64 seconds
BEA1-00209FA6A83F6F45BCD8],numRepliesOwedMe=0,numRepliesOwedOthers=0,seconds since begin=77,seconds left=57,activeThread=Thread[[ACTIVE] ExecuteThread: '0' for queue: 'weblogic.kernel.Default (self-tuning)',5,Pooled Threads],XAServerResourceInfo[cdldbPool]=(ServerResourceInfo[cdldbPool]=(state=rolledback,assigned=trunkserver),xar=cdldbPool,re-Registered = false),SCInfo[trunkdomain+trunkserver]=(state=rolledback),properties=({weblogic.transaction.name=[EJB uk.co.cdl.servercomponent.parameters.service.ParameterServiceEJB.bounceCache(java.lang.String)]}),local properties=({weblogic.jdbc.jta.cdldbPool=[ No XAConnection is attached to this TxInfo ]}),OwnerTransactionManager=ServerTM[ServerCoordinatorDescriptor=(CoordinatorURL=trunkserver+10.26.50.104:7001+trunkdomain+t3+, XAResources={cdldbPool, siAuditPool, WLStore_trunkdomain__WLS_trunkserver},NonXAResources={})],CoordinatorURL=trunkserver+10.26.50.104:7001+trunkdomain+t3+) is already registered and is rolling back. org.jboss.cache.interceptors.TxInterceptor.registerTransaction(TxInterceptor.java:710)
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG Attempting to unlock /Expressions/1722808 org.jboss.cache.lock.MVCCLockManager.unlock(MVCCLockManager.java:140)
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG local transaction exists - registering global tx if not present for Thread[[ACTIVE] ExecuteThread: '0' for queue: 'weblogic.kernel.Default (self-tuning)',5,Pooled Threads] org.jboss.cache.interceptors.TxInterceptor.attachGlobalTransaction(TxInterceptor.java:440)
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG Attempting to unlock /Parameters/SubagParam/1722808 org.jboss.cache.lock.MVCCLockManager.unlock(MVCCLockManager.java:140)
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG Associated gtx in txTable is GlobalTransaction::28 org.jboss.cache.interceptors.TxInterceptor.attachGlobalTransaction(TxInterceptor.java:445)
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG Attempting to unlock /Expressions/1611838 org.jboss.cache.lock.MVCCLockManager.unlock(MVCCLockManager.java:140)
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG Transaction Name=[EJB uk.co.cdl.servercomponent.parameters.service.ParameterServiceEJB.bounceCache(java.lang.String)],Xid=BEA1-00209FA6A83F6F45BCD8(18207047),Status=Rolled back. [Reason=weblogic.transaction.internal.TimedOutException: Transaction timed out after 64 seconds
BEA1-00209FA6A83F6F45BCD8],numRepliesOwedMe=0,numRepliesOwedOthers=0,seconds since begin=77,seconds left=57,activeThread=Thread[[ACTIVE] ExecuteThread: '0' for queue: 'weblogic.kernel.Default (self-tuning)',5,Pooled Threads],XAServerResourceInfo[cdldbPool]=(ServerResourceInfo[cdldbPool]=(state=rolledback,assigned=trunkserver),xar=cdldbPool,re-Registered = false),SCInfo[trunkdomain+trunkserver]=(state=rolledback),properties=({weblogic.transaction.name=[EJB uk.co.cdl.servercomponent.parameters.service.ParameterServiceEJB.bounceCache(java.lang.String)]}),local properties=({weblogic.jdbc.jta.cdldbPool=[ No XAConnection is attached to this TxInfo ]}),OwnerTransactionManager=ServerTM[ServerCoordinatorDescriptor=(CoordinatorURL=trunkserver+10.26.50.104:7001+trunkdomain+t3+, XAResources={cdldbPool, siAuditPool, WLStore_trunkdomain__WLS_trunkserver},NonXAResources={})],CoordinatorURL=trunkserver+10.26.50.104:7001+trunkdomain+t3+) is already registered and is rolling back. org.jboss.cache.interceptors.TxInterceptor.registerTransaction(TxInterceptor.java:710)
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG Attempting to unlock /Parameters/SubagParam/1611838 org.jboss.cache.lock.MVCCLockManager.unlock(MVCCLockManager.java:140)
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG local transaction exists - registering global tx if not present for Thread[[ACTIVE] ExecuteThread: '0' for queue: 'weblogic.kernel.Default (self-tuning)',5,Pooled Threads] org.jboss.cache.interceptors.TxInterceptor.attachGlobalTransaction(TxInterceptor.java:440)
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG Attempting to unlock /Expressions/1274612 org.jboss.cache.lock.MVCCLockManager.unlock(MVCCLockManager.java:140)
[ERR] 2009-02-10 10:58:36,581 259269 DEBUG Associated gtx in txTable is GlobalTransaction::28 org.jboss.cache.interceptors.TxInterceptor.attachGlobalTransaction(TxInterceptor.java:445)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Attempting to unlock /Parameters/SubagParam/1274612 org.jboss.cache.lock.MVCCLockManager.unlock(MVCCLockManager.java:140)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Transaction Name=[EJB uk.co.cdl.servercomponent.parameters.service.ParameterServiceEJB.bounceCache(java.lang.String)],Xid=BEA1-00209FA6A83F6F45BCD8(18207047),Status=Rolled back. [Reason=weblogic.transaction.internal.TimedOutException: Transaction timed out after 64 seconds
BEA1-00209FA6A83F6F45BCD8],numRepliesOwedMe=0,numRepliesOwedOthers=0,seconds since begin=77,seconds left=57,activeThread=Thread[[ACTIVE] ExecuteThread: '0' for queue: 'weblogic.kernel.Default (self-tuning)',5,Pooled Threads],XAServerResourceInfo[cdldbPool]=(ServerResourceInfo[cdldbPool]=(state=rolledback,assigned=trunkserver),xar=cdldbPool,re-Registered = false),SCInfo[trunkdomain+trunkserver]=(state=rolledback),properties=({weblogic.transaction.name=[EJB uk.co.cdl.servercomponent.parameters.service.ParameterServiceEJB.bounceCache(java.lang.String)]}),local properties=({weblogic.jdbc.jta.cdldbPool=[ No XAConnection is attached to this TxInfo ]}),OwnerTransactionManager=ServerTM[ServerCoordinatorDescriptor=(CoordinatorURL=trunkserver+10.26.50.104:7001+trunkdomain+t3+, XAResources={cdldbPool, siAuditPool, WLStore_trunkdomain__WLS_trunkserver},NonXAResources={})],CoordinatorURL=trunkserver+10.26.50.104:7001+trunkdomain+t3+) is already registered and is rolling back. org.jboss.cache.interceptors.TxInterceptor.registerTransaction(TxInterceptor.java:710)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Attempting to unlock /Expressions/869814 org.jboss.cache.lock.MVCCLockManager.unlock(MVCCLockManager.java:140)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Attempting to lock /Expressions/2604877 org.jboss.cache.lock.MVCCLockManager.lockAndRecord(MVCCLockManager.java:126)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Attempting to unlock /Parameters/SubagParam/869814 org.jboss.cache.lock.MVCCLockManager.unlock(MVCCLockManager.java:140)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG local transaction exists - registering global tx if not present for Thread[[ACTIVE] ExecuteThread: '0' for queue: 'weblogic.kernel.Default (self-tuning)',5,Pooled Threads] org.jboss.cache.interceptors.TxInterceptor.attachGlobalTransaction(TxInterceptor.java:440)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Attempting to unlock /Expressions/519022 org.jboss.cache.lock.MVCCLockManager.unlock(MVCCLockManager.java:140)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Associated gtx in txTable is GlobalTransaction::28 org.jboss.cache.interceptors.TxInterceptor.attachGlobalTransaction(TxInterceptor.java:445)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Attempting to unlock /Parameters/SubagParam/519022 org.jboss.cache.lock.MVCCLockManager.unlock(MVCCLockManager.java:140)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Transaction Name=[EJB uk.co.cdl.servercomponent.parameters.service.ParameterServiceEJB.bounceCache(java.lang.String)],Xid=BEA1-00209FA6A83F6F45BCD8(18207047),Status=Rolled back. [Reason=weblogic.transaction.internal.TimedOutException: Transaction timed out after 64 seconds
BEA1-00209FA6A83F6F45BCD8],numRepliesOwedMe=0,numRepliesOwedOthers=0,seconds since begin=77,seconds left=57,activeThread=Thread[[ACTIVE] ExecuteThread: '0' for queue: 'weblogic.kernel.Default (self-tuning)',5,Pooled Threads],XAServerResourceInfo[cdldbPool]=(ServerResourceInfo[cdldbPool]=(state=rolledback,assigned=trunkserver),xar=cdldbPool,re-Registered = false),SCInfo[trunkdomain+trunkserver]=(state=rolledback),properties=({weblogic.transaction.name=[EJB uk.co.cdl.servercomponent.parameters.service.ParameterServiceEJB.bounceCache(java.lang.String)]}),local properties=({weblogic.jdbc.jta.cdldbPool=[ No XAConnection is attached to this TxInfo ]}),OwnerTransactionManager=ServerTM[ServerCoordinatorDescriptor=(CoordinatorURL=trunkserver+10.26.50.104:7001+trunkdomain+t3+, XAResources={cdldbPool, siAuditPool, WLStore_trunkdomain__WLS_trunkserver},NonXAResources={})],CoordinatorURL=trunkserver+10.26.50.104:7001+trunkdomain+t3+) is already registered and is rolling back. org.jboss.cache.interceptors.TxInterceptor.registerTransaction(TxInterceptor.java:710)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Attempting to unlock /Parameters/SubagParam org.jboss.cache.lock.MVCCLockManager.unlock(MVCCLockManager.java:140)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG local transaction exists - registering global tx if not present for Thread[[ACTIVE] ExecuteThread: '0' for queue: 'weblogic.kernel.Default (self-tuning)',5,Pooled Threads] org.jboss.cache.interceptors.TxInterceptor.attachGlobalTransaction(TxInterceptor.java:440)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Finished local commit/rollback method for GlobalTransaction::28 org.jboss.cache.interceptors.TxInterceptor.handleCommitRollback(TxInterceptor.java:521)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Associated gtx in txTable is GlobalTransaction::28 org.jboss.cache.interceptors.TxInterceptor.attachGlobalTransaction(TxInterceptor.java:445)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Finished rollback phase org.jboss.cache.interceptors.TxInterceptor$RemoteSynchronizationHandler.afterCompletion(TxInterceptor.java:922)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Transaction Name=[EJB uk.co.cdl.servercomponent.parameters.service.ParameterServiceEJB.bounceCache(java.lang.String)],Xid=BEA1-00209FA6A83F6F45BCD8(18207047),Status=Rolled back. [Reason=weblogic.transaction.internal.TimedOutException: Transaction timed out after 64 seconds
BEA1-00209FA6A83F6F45BCD8],numRepliesOwedMe=0,numRepliesOwedOthers=0,seconds since begin=77,seconds left=57,activeThread=Thread[[ACTIVE] ExecuteThread: '0' for queue: 'weblogic.kernel.Default (self-tuning)',5,Pooled Threads],XAServerResourceInfo[cdldbPool]=(ServerResourceInfo[cdldbPool]=(state=rolledback,assigned=trunkserver),xar=cdldbPool,re-Registered = false),SCInfo[trunkdomain+trunkserver]=(state=rolledback),properties=({weblogic.transaction.name=[EJB uk.co.cdl.servercomponent.parameters.service.ParameterServiceEJB.bounceCache(java.lang.String)]}),local properties=({weblogic.jdbc.jta.cdldbPool=[ No XAConnection is attached to this TxInfo ]}),OwnerTransactionManager=ServerTM[ServerCoordinatorDescriptor=(CoordinatorURL=trunkserver+10.26.50.104:7001+trunkdomain+t3+, XAResources={cdldbPool, siAuditPool, WLStore_trunkdomain__WLS_trunkserver},NonXAResources={})],CoordinatorURL=trunkserver+10.26.50.104:7001+trunkdomain+t3+) is already registered. org.jboss.cache.interceptors.TxInterceptor.registerTransaction(TxInterceptor.java:714)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Setting up transactional context. org.jboss.cache.interceptors.BaseTransactionalContextInterceptor.setTransactionalContext(BaseTransactionalContextInterceptor.java:71)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Attempting to lock /Expressions/2604877 org.jboss.cache.lock.MVCCLockManager.lockAndRecord(MVCCLockManager.java:126)
[ERR] 2009-02-10 10:58:36,597 259285 DEBUG Setting tx as null and gtx as null org.jboss.cache.interceptors.BaseTransactionalContextInterceptor.setTransactionalContext(BaseTransactionalContextInterceptor.java:72)
[ERR] 2009-02-10 10:58:39,755 262443 DEBUG local transaction exists - registering global tx if not present for Thread[[ACTIVE] ExecuteThread: '2' for queue: 'weblogic.kernel.Default (self-tuning)',5,Pooled Threads] org.jboss.cache.interceptors.TxInterceptor.attachGlobalTransaction(TxInterceptor.java:440)
[ERR] 2009-02-10 10:58:39,755 262443 DEBUG Associated gtx in txTable is null org.jboss.cache.interceptors.TxInterceptor.attachGlobalTransaction(TxInterceptor.java:445)
View the original post : http://www.jboss.org/index.html?module=bb&op=viewtopic&p=4208502#4208502
Reply to the post : http://www.jboss.org/index.html?module=bb&op=posting&mode=reply&p=4208502
More information about the jboss-user
mailing list