2 Replies Latest reply on Apr 22, 2011 7:58 AM by Changgeng Li

    JbossTM+JTA+ISPN5.0.0.Beta2 lock not released

    Changgeng Li Newbie

      It seems I met an issue that some locks are not released after transaction commit with jbossTM.

      From the log file, I can see several XA resources are started, but only one is got commited, so the locks acquired by others are not released.

      Following log is a bit long, but it shows that jboss TM think there's only one resource need to be committed.

       

       

      2011-04-22 08:20:02,607 TRACE [org.infinispan.transaction.TransactionTable] (http-0.0.0.0-8080-8) Created a new GlobalTransaction GlobalTransaction:<perf-g-sm1-1-17441>:7:local

      2011-04-22 08:20:02,618 TRACE [org.infinispan.transaction.xa.TransactionXaAdapter] (http-0.0.0.0-8080-8) start called on tx GlobalTransaction:<perf-g-sm1-1-17441>:7:local

      ....

      2011-04-22 08:20:02,618 TRACE [org.infinispan.interceptors.DistLockingInterceptor] (http-0.0.0.0-8080-8) Transactional.  Not cleaning up locks till the transaction ends.

      2011-04-22 08:20:02,618 TRACE [org.infinispan.interceptors.InvocationContextInterceptor] (http-0.0.0.0-8080-8) Invoked with command LockControlCommand{keys=null, cacheName='qamAllocation, flags=null', implicit=false, unlock=false, singleKey='EdgeResourceCacheKey[edgeDeviceId=18,resourceId=76]'} and InvocationContext [LocalTxInvocationContext{flags=null}]

      2011-04-22 08:20:02,618 TRACE [org.infinispan.transaction.TransactionTable] (http-0.0.0.0-8080-8) Created a new GlobalTransaction GlobalTransaction:<perf-g-sm1-1-17441>:8:local

      2011-04-22 08:20:02,619 TRACE [org.infinispan.transaction.xa.TransactionXaAdapter] (http-0.0.0.0-8080-8) start called on tx GlobalTransaction:<perf-g-sm1-1-17441>:8:local

      2011-04-22 08:20:02,619 TRACE [org.infinispan.util.concurrent.locks.LockManagerImpl] (http-0.0.0.0-8080-8) Attempting to lock EdgeResourceCacheKey[edgeDeviceId=18,resourceId=76] with acquisition timeout of 30000 millis

      2011-04-22 08:20:02,619 TRACE [org.infinispan.util.concurrent.locks.LockManagerImpl] (http-0.0.0.0-8080-8) Successfully acquired lock!

      ...

      2011-04-22 08:20:02,621 TRACE [org.infinispan.transaction.TransactionTable] (http-0.0.0.0-8080-8) Created a new GlobalTransaction GlobalTransaction:<perf-g-sm1-1-17441>:9:local

      ...

      2011-04-22 08:20:02,624 TRACE [org.infinispan.transaction.xa.TransactionXaAdapter] (http-0.0.0.0-8080-8) end called on tx GlobalTransaction:<perf-g-sm1-1-17441>:7:local

      2011-04-22 08:20:02,624 TRACE [org.infinispan.transaction.xa.TransactionXaAdapter] (http-0.0.0.0-8080-8) end called on tx GlobalTransaction:<perf-g-sm1-1-17441>:8:local

      2011-04-22 08:20:02,624 TRACE [org.infinispan.transaction.xa.TransactionXaAdapter] (http-0.0.0.0-8080-8) end called on tx GlobalTransaction:<perf-g-sm1-1-17441>:9:local

      2011-04-22 08:20:02,624 TRACE [org.jboss.tm.TransactionImpl] (http-0.0.0.0-8080-8) One phase commit TransactionImpl:XidImpl[FormatId=257, GlobalId=perf-g-sm1-1/73, BranchQual=, localId=73]: One resource.

      2011-04-22 08:20:02,643 TRACE [org.infinispan.transaction.xa.TransactionXaAdapter] (http-0.0.0.0-8080-8) Committing transaction GlobalTransaction:<perf-g-sm1-1-17441>:7:local

      2011-04-22 08:20:02,643 TRACE [org.infinispan.transaction.TransactionCoordinator] (http-0.0.0.0-8080-8) Committing transaction GlobalTransaction:<perf-g-sm1-1-17441>:7:local

      2011-04-22 08:20:02,643 TRACE [org.infinispan.transaction.TransactionCoordinator] (http-0.0.0.0-8080-8) Doing an 1PC prepare call on the interceptor chain

      2011-04-22 08:20:02,643 TRACE [org.infinispan.interceptors.InvocationContextInterceptor] (http-0.0.0.0-8080-8) Invoked with command PrepareCommand {gtx=GlobalTransaction:<perf-g-sm1-1-17441>:7:local, modifications=null, onePhaseCommit=true, gtx=GlobalTransaction:<perf-g-sm1-1-17441>:7:local, cacheName='ermSession'} and InvocationContext [LocalTxInvocationContext{flags=null}]

      2011-04-22 08:20:02,643 TRACE [org.infinispan.interceptors.CallInterceptor] (http-0.0.0.0-8080-8) Suppressing invocation of method handlePrepareCommand.

      2011-04-22 08:20:02,645 TRACE [org.infinispan.interceptors.DistLockingInterceptor] (http-0.0.0.0-8080-8) Number of entries in context: 1

      2011-04-22 08:20:02,645 TRACE [org.infinispan.interceptors.DistLockingInterceptor] (http-0.0.0.0-8080-8) Entry for key db957c02-01f3-40d2-8088-b61a9818f677 is null, not calling commitUpdate