[
https://issues.jboss.org/browse/ISPN-1595?page=com.atlassian.jira.plugin....
]
Galder Zamarreño updated ISPN-1595:
-----------------------------------
Description:
The attached test case results in a failure to stop the cache in time with a warning
message like this:
{code}2011-12-06 17:34:20,018 31733 WARN [org.infinispan.transaction.TransactionTable]
(main:) ISPN000100: Stopping but there're transactions that did not finish in time:
localTransactions={TransactionImple < ac, BasicAction: 0:ffffa9fe8742:dc96:4ede43ed:2
status: ActionStatus.COMMITTED >=LocalXaTransaction{xid=<
131076, 29, 28, 0000000000-1-1-87-2-1216600-36-10678-3467-19000249,
0000000000-1-1-87-2-1216600-36-10678-3467-190003 >}
LocalTransaction{remoteLockedNodes=null, isMarkedForRollback=false,
transaction=TransactionImple < ac, BasicAction: 0:ffffa9fe8742:dc96:4ede43ed:2 status:
ActionStatus.COMMITTED >, lockedKeys=null, backupKeyLocks=null, viewId=1}
org.infinispan.transaction.xa.recovery.RecoveryAwareLocalTransaction@1},
remoteTransactions{}{code}
It would appear that the implicitly started cache operation for "c0.put(1,
"v1");" is not properly cleared?
{code}2011-12-06 17:33:49,862 1577 TRACE [org.infinispan.CacheImpl] (main:) Implicit
transaction started!
2011-12-06 17:33:49,862 1577 TRACE [org.infinispan.CacheImpl] (main:) Marked tx as
implicit.
2011-12-06 17:33:49,863 1578 TRACE
[org.infinispan.interceptors.InvocationContextInterceptor] (main:___defaultcache) Invoked
with command
PutKeyValueCommand{key=1, value=v1, flags=null, putIfAbsent=false, lifespanMillis=-1,
maxIdleTimeMillis=-1} and InvocationContext
[LocalTxInvocationContext{flags=null}]
2011-12-06 17:33:49,863 1578 TRACE [org.infinispan.statetransfer.StateTransferLockImpl]
(main:___defaultcache) Acquired shared state transfer shared lock,
total holders: 1
2011-12-06 17:33:49,866 1581 TRACE [org.infinispan.transaction.TransactionTable]
(main:___defaultcache) Created a new tx: LocalXaTransaction{xid=null}
LocalTransaction{remoteLockedNodes=null, isMarkedForRollback=false,
transaction=TransactionImple < ac, BasicAction: 0:ffffa9fe8742:dc96:4ede43ed:2 status:
ActionStatus.RUNNING >, lockedKeys=null, backupKeyLocks=null, viewId=1}
org.infinispan.transaction.xa.recovery.RecoveryAwareLocalTransaction@1
...
2011-12-06 17:33:49,876 1591 TRACE [org.infinispan.CacheImpl] (main:) Committing
transaction as it was implicit: TransactionImple < ac, BasicAction:
0:ffffa9fe8742:dc96:4ede43ed:2 status: ActionStatus.RUNNING >
{code}
Find attached both test and trace log file.
was:
The attached test case results in a failure to stop the cache in time with a warning
message like this:
{code}2011-12-06 17:34:20,018 31733 WARN [org.infinispan.transaction.TransactionTable]
(main:) ISPN000100: Stopping but there're transactions that did not finish
in time: localTransactions={TransactionImple < ac, BasicAction:
0:ffffa9fe8742:dc96:4ede43ed:2 status: ActionStatus.COMMITTED
>=LocalXaTransaction{xid=<
131076, 29, 28, 0000000000-1-1-87-2-1216600-36-10678-3467-19000249,
0000000000-1-1-87-2-1216600-36-10678-3467-190003 >}
LocalTransaction{remoteLockedNodes=null, isMarkedForRollback=false,
transaction=TransactionImple < ac, BasicAction: 0:ffffa9fe8742:dc96:4ede43ed:2 status:
ActionStatus.COMMITTED >, lockedKeys=null, backupKeyLocks=null, viewId=1}
org.infinispan.transaction.xa.recovery.RecoveryAwareLocalTransaction@1},
remoteTransactions{}{code}
It would appear that the implicitly started cache operation for "c0.put(1,
"v1");" is not properly cleared?
{code}2011-12-06 17:33:49,862 1577 TRACE [org.infinispan.CacheImpl] (main:) Implicit
transaction started!
2011-12-06 17:33:49,862 1577 TRACE [org.infinispan.CacheImpl] (main:) Marked tx as
implicit.
2011-12-06 17:33:49,863 1578 TRACE
[org.infinispan.interceptors.InvocationContextInterceptor] (main:___defaultcache) Invoked
with command PutKeyValueCommand{key=1, value=v1, flags=null, putIfAbsent=false,
lifespanMillis=-1, maxIdleTimeMillis=-1} and InvocationContext
[LocalTxInvocationContext{flags=null}]
2011-12-06 17:33:49,863 1578 TRACE [org.infinispan.statetransfer.StateTransferLockImpl]
(main:___defaultcache) Acquired shared state transfer shared lock, total holders: 1
2011-12-06 17:33:49,866 1581 TRACE [org.infinispan.transaction.TransactionTable]
(main:___defaultcache) Created a new tx: LocalXaTransaction{xid=null}
LocalTransaction{remoteLockedNodes=null, isMarkedForRollback=false,
transaction=TransactionImple < ac, BasicAction: 0:ffffa9fe8742:dc96:4ede43ed:2 status:
ActionStatus.RUNNING >, lockedKeys=null, backupKeyLocks=null, viewId=1}
org.infinispan.transaction.xa.recovery.RecoveryAwareLocalTransaction@1
...
2011-12-06 17:33:49,876 1591 TRACE [org.infinispan.CacheImpl] (main:) Committing
transaction as it was implicit: TransactionImple < ac, BasicAction:
0:ffffa9fe8742:dc96:4ede43ed:2 status: ActionStatus.RUNNING >
{code}
Find attached both test and trace log file.
Implicit transactions not being cleared from transaction table
--------------------------------------------------------------
Key: ISPN-1595
URL:
https://issues.jboss.org/browse/ISPN-1595
Project: Infinispan
Issue Type: Bug
Components: Transactions
Affects Versions: 5.1.0.CR1
Reporter: Galder Zamarreño
Assignee: Mircea Markus
Fix For: 5.1.0.CR2
The attached test case results in a failure to stop the cache in time with a warning
message like this:
{code}2011-12-06 17:34:20,018 31733 WARN [org.infinispan.transaction.TransactionTable]
(main:) ISPN000100: Stopping but there're transactions that did not finish in time:
localTransactions={TransactionImple < ac, BasicAction: 0:ffffa9fe8742:dc96:4ede43ed:2
status: ActionStatus.COMMITTED >=LocalXaTransaction{xid=<
131076, 29, 28, 0000000000-1-1-87-2-1216600-36-10678-3467-19000249,
0000000000-1-1-87-2-1216600-36-10678-3467-190003 >}
LocalTransaction{remoteLockedNodes=null, isMarkedForRollback=false,
transaction=TransactionImple < ac, BasicAction: 0:ffffa9fe8742:dc96:4ede43ed:2 status:
ActionStatus.COMMITTED >, lockedKeys=null, backupKeyLocks=null, viewId=1}
org.infinispan.transaction.xa.recovery.RecoveryAwareLocalTransaction@1},
remoteTransactions{}{code}
It would appear that the implicitly started cache operation for "c0.put(1,
"v1");" is not properly cleared?
{code}2011-12-06 17:33:49,862 1577 TRACE [org.infinispan.CacheImpl] (main:) Implicit
transaction started!
2011-12-06 17:33:49,862 1577 TRACE [org.infinispan.CacheImpl] (main:) Marked tx as
implicit.
2011-12-06 17:33:49,863 1578 TRACE
[org.infinispan.interceptors.InvocationContextInterceptor] (main:___defaultcache) Invoked
with command
PutKeyValueCommand{key=1, value=v1, flags=null, putIfAbsent=false, lifespanMillis=-1,
maxIdleTimeMillis=-1} and InvocationContext
[LocalTxInvocationContext{flags=null}]
2011-12-06 17:33:49,863 1578 TRACE [org.infinispan.statetransfer.StateTransferLockImpl]
(main:___defaultcache) Acquired shared state transfer shared lock,
total holders: 1
2011-12-06 17:33:49,866 1581 TRACE [org.infinispan.transaction.TransactionTable]
(main:___defaultcache) Created a new tx: LocalXaTransaction{xid=null}
LocalTransaction{remoteLockedNodes=null, isMarkedForRollback=false,
transaction=TransactionImple < ac, BasicAction: 0:ffffa9fe8742:dc96:4ede43ed:2 status:
ActionStatus.RUNNING >, lockedKeys=null, backupKeyLocks=null, viewId=1}
org.infinispan.transaction.xa.recovery.RecoveryAwareLocalTransaction@1
...
2011-12-06 17:33:49,876 1591 TRACE [org.infinispan.CacheImpl] (main:) Committing
transaction as it was implicit: TransactionImple < ac, BasicAction:
0:ffffa9fe8742:dc96:4ede43ed:2 status: ActionStatus.RUNNING >
{code}
Find attached both test and trace log file.
--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators:
https://issues.jboss.org/secure/ContactAdministrators!default.jspa
For more information on JIRA, see:
http://www.atlassian.com/software/jira