Lock timeout when registering a queried class to the registry cache

Solution In Progress - Updated -

Issue

  • With indexing enabled, org.infinispan.util.concurrent.TimeoutException: Unable to acquire lock after [10 seconds] on key ... happens when starting a cache
  • Increased lock timeout value, lockAcquisitionTimeout, to 20 seconds, but the error message is still Unable to acquire lock after [10 seconds] ...
2016-01-22 14:02:37,619 ERROR [org.infinispan.interceptors.InvocationContextInterceptor] (remote-thread-4,ekdgp343) ISPN000136: Execution error: org.infinispan.util.concurrent.TimeoutException: Unable to acquire lock after [10 seconds] on key [ScopedKey{scope = QueryKnownClasses#HOGE_USER, key = class com.example.HogeUserBean}] for requestor [GlobalTransaction:<node02-61650>:12:remote]! Lock held by [GlobalTransaction:<node01-12531>:2:remote]
    at org.infinispan.util.concurrent.locks.LockManagerImpl.lock(LockManagerImpl.java:198) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.util.concurrent.locks.LockManagerImpl.acquireLock(LockManagerImpl.java:171) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.locking.AbstractTxLockingInterceptor.lockKeyAndCheckOwnership(AbstractTxLockingInterceptor.java:186) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.locking.AbstractTxLockingInterceptor.lockAndRegisterBackupLock(AbstractTxLockingInterceptor.java:115) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.locking.OptimisticLockingInterceptor$LockAcquisitionVisitor.lockAndRecord(OptimisticLockingInterceptor.java:223) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.locking.OptimisticLockingInterceptor$LockAcquisitionVisitor.visitSingleKeyCommand(OptimisticLockingInterceptor.java:218) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.locking.OptimisticLockingInterceptor$LockAcquisitionVisitor.visitPutKeyValueCommand(OptimisticLockingInterceptor.java:211) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:71) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.locking.OptimisticLockingInterceptor.acquireLocksVisitingCommands(OptimisticLockingInterceptor.java:282) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.locking.OptimisticLockingInterceptor.visitPrepareCommand(OptimisticLockingInterceptor.java:76) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.tx.PrepareCommand.acceptVisitor(PrepareCommand.java:125) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.NotificationInterceptor.visitPrepareCommand(NotificationInterceptor.java:36) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.tx.PrepareCommand.acceptVisitor(PrepareCommand.java:125) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.TxInterceptor.invokeNextInterceptorAndVerifyTransaction(TxInterceptor.java:137) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.TxInterceptor.visitPrepareCommand(TxInterceptor.java:124) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.tx.PrepareCommand.acceptVisitor(PrepareCommand.java:125) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:112) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.AbstractVisitor.visitPrepareCommand(AbstractVisitor.java:117) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.statetransfer.TransactionSynchronizerInterceptor.visitPrepareCommand(TransactionSynchronizerInterceptor.java:39) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.tx.PrepareCommand.acceptVisitor(PrepareCommand.java:125) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.statetransfer.StateTransferInterceptor.handleTxCommand(StateTransferInterceptor.java:215) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.statetransfer.StateTransferInterceptor.visitPrepareCommand(StateTransferInterceptor.java:103) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.tx.PrepareCommand.acceptVisitor(PrepareCommand.java:125) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:112) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.AbstractVisitor.visitPrepareCommand(AbstractVisitor.java:117) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.tx.PrepareCommand.acceptVisitor(PrepareCommand.java:125) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.InvocationContextInterceptor.handleAll(InvocationContextInterceptor.java:104) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.InvocationContextInterceptor.handleDefault(InvocationContextInterceptor.java:73) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.AbstractVisitor.visitPrepareCommand(AbstractVisitor.java:117) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.tx.PrepareCommand.acceptVisitor(PrepareCommand.java:125) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.BatchingInterceptor.handleDefault(BatchingInterceptor.java:58) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.AbstractVisitor.visitPrepareCommand(AbstractVisitor.java:117) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.tx.PrepareCommand.acceptVisitor(PrepareCommand.java:125) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.interceptors.InterceptorChain.invoke(InterceptorChain.java:336) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.commands.tx.PrepareCommand.perform(PrepareCommand.java:115) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.remoting.InboundInvocationHandlerImpl.handleInternal(InboundInvocationHandlerImpl.java:92) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.remoting.InboundInvocationHandlerImpl.access$000(InboundInvocationHandlerImpl.java:47) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at org.infinispan.remoting.InboundInvocationHandlerImpl$2.run(InboundInvocationHandlerImpl.java:185) [infinispan-core-6.3.1.Final-redhat-1.jar:6.3.1.Final-redhat-1]
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [rt.jar:1.8.0_60]
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [rt.jar:1.8.0_60]
    at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_60]

Environment

  • Red Hat JBoss Data Grid (JDG)
    • 6.x

Subscriber exclusive content

A Red Hat subscription provides unlimited access to our knowledgebase, tools, and much more.

Current Customers and Partners

Log in for full access

Log In

New to Red Hat?

Learn more about Red Hat subscriptions

Using a Red Hat product through a public cloud?

How to access this content