[infinispan-issues] [JBoss JIRA] (ISPN-4887) Stale locks in non-tx cache after merge
Vladimir Dzhuvinov (JIRA)
issues at jboss.org
Tue Oct 6 14:12:00 EDT 2015
[ https://issues.jboss.org/browse/ISPN-4887?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13115645#comment-13115645 ]
Vladimir Dzhuvinov edited comment on ISPN-4887 at 10/6/15 2:11 PM:
-------------------------------------------------------------------
We have observed the same exception in logs of a server using Infinispan 7.2.3 in non-tx replicated cluster:
{{ISPN000136: Execution error
org.infinispan.util.concurrent.TimeoutException: ISPN000299: Unable to acquire lock after 10 seconds for key I9AIaoAPU1N_HqvOeamQ-YZg9qHvo-K2vP6Ksq6t6Yk and requestor Thread[remote-thread--p3-t23052,5,main]. Lock is held by Thread[remote-thread--p3-t23108,5,main], while request came from stage-auth-app02-2214
at org.infinispan.util.concurrent.locks.LockManagerImpl.lock(LockManagerImpl.java:198) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.util.concurrent.locks.LockManagerImpl.acquireLockNoCheck(LockManagerImpl.java:181) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.lockKey(AbstractLockingInterceptor.java:166) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.lockKey(AbstractLockingInterceptor.java:162) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.visitNonTxDataWriteCommand(AbstractLockingInterceptor.java:87) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.NonTransactionalLockingInterceptor.visitDataWriteCommand(NonTransactionalLockingInterceptor.java:40) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.visitReplaceCommand(AbstractLockingInterceptor.java:60) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:111) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.AbstractVisitor.visitReplaceCommand(AbstractVisitor.java:54) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.statetransfer.StateTransferInterceptor.handleNonTxWriteCommand(StateTransferInterceptor.java:311) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.statetransfer.StateTransferInterceptor.handleWriteCommand(StateTransferInterceptor.java:249) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.statetransfer.StateTransferInterceptor.visitReplaceCommand(StateTransferInterceptor.java:128) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.CacheMgmtInterceptor.updateStoreStatistics(CacheMgmtInterceptor.java:191) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.CacheMgmtInterceptor.visitReplaceCommand(CacheMgmtInterceptor.java:182) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.InvocationContextInterceptor.handleAll(InvocationContextInterceptor.java:102) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.InvocationContextInterceptor.handleDefault(InvocationContextInterceptor.java:71) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.AbstractVisitor.visitReplaceCommand(AbstractVisitor.java:54) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.InterceptorChain.invoke(InterceptorChain.java:336) [infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.remote.BaseRpcInvokingCommand.processVisitableCommand(BaseRpcInvokingCommand.java:39) [infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.remote.SingleRpcCommand.perform(SingleRpcCommand.java:48) [infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.remoting.inboundhandler.BasePerCacheInboundInvocationHandler.invokePerform(BasePerCacheInboundInvocationHandler.java:85) [infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.remoting.inboundhandler.BaseBlockingRunnable.run(BaseBlockingRunnable.java:32) [infinispan-embedded-7.2.3.Final.jar:na]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [na:1.8.0_60]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_60]
at java.lang.Thread.run(Thread.java:745) [na:1.8.0_60]
ISPN000071: Caught exception when handling command SingleRpcCommand{cacheName='sessionStore.sessionMap', command=ReplaceCommand{key=I9AIaoAPU1N_HqvOeamQ-YZg9qHvo-K2vP6Ksq6t6Yk, oldValue=null, newValue={"creation_time":1443662394,"sub":"CN-1G56N6E251W11","max_idle":120,"data":{"client_sessions":[{"client_id":"IX-1FXURP1U93W11"}]},"auth_time":1443662394,"amr":["ldap"],"max_life":20160,"auth_life":10080}, metadata=EmbeddedMetadata{version=null}, flags=null, successful=true, valueMatcher=MATCH_NON_NULL}}
org.infinispan.util.concurrent.TimeoutException: ISPN000299: Unable to acquire lock after 10 seconds for key I9AIaoAPU1N_HqvOeamQ-YZg9qHvo-K2vP6Ksq6t6Yk and requestor Thread[remote-thread--p3-t23069,5,main]. Lock is held by Thread[remote-thread--p3-t23108,5,main], while request came from stage-auth-app02-2214
at org.infinispan.util.concurrent.locks.LockManagerImpl.lock(LockManagerImpl.java:198) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.util.concurrent.locks.LockManagerImpl.acquireLockNoCheck(LockManagerImpl.java:181) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.lockKey(AbstractLockingInterceptor.java:166) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.lockKey(AbstractLockingInterceptor.java:162) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.visitNonTxDataWriteCommand(AbstractLockingInterceptor.java:87) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.NonTransactionalLockingInterceptor.visitDataWriteCommand(NonTransactionalLockingInterceptor.java:40) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.visitReplaceCommand(AbstractLockingInterceptor.java:60) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:111) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.AbstractVisitor.visitReplaceCommand(AbstractVisitor.java:54) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.statetransfer.StateTransferInterceptor.handleNonTxWriteCommand(StateTransferInterceptor.java:311) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.statetransfer.StateTransferInterceptor.handleWriteCommand(StateTransferInterceptor.java:249) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.statetransfer.StateTransferInterceptor.visitReplaceCommand(StateTransferInterceptor.java:128) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.CacheMgmtInterceptor.updateStoreStatistics(CacheMgmtInterceptor.java:191) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.CacheMgmtInterceptor.visitReplaceCommand(CacheMgmtInterceptor.java:182) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.InvocationContextInterceptor.handleAll(InvocationContextInterceptor.java:102) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.InvocationContextInterceptor.handleDefault(InvocationContextInterceptor.java:71) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.AbstractVisitor.visitReplaceCommand(AbstractVisitor.java:54) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.InterceptorChain.invoke(InterceptorChain.java:336) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.remote.BaseRpcInvokingCommand.processVisitableCommand(BaseRpcInvokingCommand.java:39) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.remote.SingleRpcCommand.perform(SingleRpcCommand.java:48) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.remoting.inboundhandler.BasePerCacheInboundInvocationHandler.invokePerform(BasePerCacheInboundInvocationHandler.java:85) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.remoting.inboundhandler.BaseBlockingRunnable.run(BaseBlockingRunnable.java:32) ~[infinispan-embedded-7.2.3.Final.jar:na]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) ~[na:1.8.0_60]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) ~[na:1.8.0_60]
at java.lang.Thread.run(Thread.java:745) ~[na:1.8.0_60]}}
}}
was (Author: vdzhuvinov):
We have observed the same exception in logs of a server using Infinispan 7.2.3 in non-tx replicated cluster:
{{ISPN000136: Execution error
org.infinispan.util.concurrent.TimeoutException: ISPN000299: Unable to acquire lock after 10 seconds for key I9AIaoAPU1N_HqvOeamQ-YZg9qHvo-K2vP6Ksq6t6Yk and requestor Thread[remote-thread--p3-t23052,5,main]. Lock is held by Thread[remote-thread--p3-t23108,5,main], while request came from stage-auth-app02-2214
at org.infinispan.util.concurrent.locks.LockManagerImpl.lock(LockManagerImpl.java:198) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.util.concurrent.locks.LockManagerImpl.acquireLockNoCheck(LockManagerImpl.java:181) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.lockKey(AbstractLockingInterceptor.java:166) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.lockKey(AbstractLockingInterceptor.java:162) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.visitNonTxDataWriteCommand(AbstractLockingInterceptor.java:87) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.NonTransactionalLockingInterceptor.visitDataWriteCommand(NonTransactionalLockingInterceptor.java:40) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.visitReplaceCommand(AbstractLockingInterceptor.java:60) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:111) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.AbstractVisitor.visitReplaceCommand(AbstractVisitor.java:54) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.statetransfer.StateTransferInterceptor.handleNonTxWriteCommand(StateTransferInterceptor.java:311) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.statetransfer.StateTransferInterceptor.handleWriteCommand(StateTransferInterceptor.java:249) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.statetransfer.StateTransferInterceptor.visitReplaceCommand(StateTransferInterceptor.java:128) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.CacheMgmtInterceptor.updateStoreStatistics(CacheMgmtInterceptor.java:191) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.CacheMgmtInterceptor.visitReplaceCommand(CacheMgmtInterceptor.java:182) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.InvocationContextInterceptor.handleAll(InvocationContextInterceptor.java:102) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.InvocationContextInterceptor.handleDefault(InvocationContextInterceptor.java:71) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.AbstractVisitor.visitReplaceCommand(AbstractVisitor.java:54) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.InterceptorChain.invoke(InterceptorChain.java:336) [infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.remote.BaseRpcInvokingCommand.processVisitableCommand(BaseRpcInvokingCommand.java:39) [infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.remote.SingleRpcCommand.perform(SingleRpcCommand.java:48) [infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.remoting.inboundhandler.BasePerCacheInboundInvocationHandler.invokePerform(BasePerCacheInboundInvocationHandler.java:85) [infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.remoting.inboundhandler.BaseBlockingRunnable.run(BaseBlockingRunnable.java:32) [infinispan-embedded-7.2.3.Final.jar:na]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [na:1.8.0_60]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_60]
at java.lang.Thread.run(Thread.java:745) [na:1.8.0_60]
ISPN000071: Caught exception when handling command SingleRpcCommand{cacheName='sessionStore.sessionMap', command=ReplaceCommand{key=I9AIaoAPU1N_HqvOeamQ-YZg9qHvo-K2vP6Ksq6t6Yk, oldValue=null, newValue={"creation_time":1443662394,"sub":"CN-1G56N6E251W11","max_idle":120,"data":{"client_sessions":[{"client_id":"IX-1FXURP1U93W11"}]},"auth_time":1443662394,"amr":["ldap"],"max_life":20160,"auth_life":10080}, metadata=EmbeddedMetadata{version=null}, flags=null, successful=true, valueMatcher=MATCH_NON_NULL}}
org.infinispan.util.concurrent.TimeoutException: ISPN000299: Unable to acquire lock after 10 seconds for key I9AIaoAPU1N_HqvOeamQ-YZg9qHvo-K2vP6Ksq6t6Yk and requestor Thread[remote-thread--p3-t23069,5,main]. Lock is held by Thread[remote-thread--p3-t23108,5,main], while request came from stage-auth-app02-2214
at org.infinispan.util.concurrent.locks.LockManagerImpl.lock(LockManagerImpl.java:198) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.util.concurrent.locks.LockManagerImpl.acquireLockNoCheck(LockManagerImpl.java:181) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.lockKey(AbstractLockingInterceptor.java:166) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.lockKey(AbstractLockingInterceptor.java:162) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.visitNonTxDataWriteCommand(AbstractLockingInterceptor.java:87) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.NonTransactionalLockingInterceptor.visitDataWriteCommand(NonTransactionalLockingInterceptor.java:40) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.locking.AbstractLockingInterceptor.visitReplaceCommand(AbstractLockingInterceptor.java:60) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:111) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.AbstractVisitor.visitReplaceCommand(AbstractVisitor.java:54) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.statetransfer.StateTransferInterceptor.handleNonTxWriteCommand(StateTransferInterceptor.java:311) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.statetransfer.StateTransferInterceptor.handleWriteCommand(StateTransferInterceptor.java:249) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.statetransfer.StateTransferInterceptor.visitReplaceCommand(StateTransferInterceptor.java:128) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.CacheMgmtInterceptor.updateStoreStatistics(CacheMgmtInterceptor.java:191) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.CacheMgmtInterceptor.visitReplaceCommand(CacheMgmtInterceptor.java:182) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:97) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.InvocationContextInterceptor.handleAll(InvocationContextInterceptor.java:102) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.InvocationContextInterceptor.handleDefault(InvocationContextInterceptor.java:71) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.AbstractVisitor.visitReplaceCommand(AbstractVisitor.java:54) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.write.ReplaceCommand.acceptVisitor(ReplaceCommand.java:55) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.interceptors.InterceptorChain.invoke(InterceptorChain.java:336) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.remote.BaseRpcInvokingCommand.processVisitableCommand(BaseRpcInvokingCommand.java:39) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.commands.remote.SingleRpcCommand.perform(SingleRpcCommand.java:48) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.remoting.inboundhandler.BasePerCacheInboundInvocationHandler.invokePerform(BasePerCacheInboundInvocationHandler.java:85) ~[infinispan-embedded-7.2.3.Final.jar:na]
at org.infinispan.remoting.inboundhandler.BaseBlockingRunnable.run(BaseBlockingRunnable.java:32) ~[infinispan-embedded-7.2.3.Final.jar:na]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) ~[na:1.8.0_60]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) ~[na:1.8.0_60]
at java.lang.Thread.run(Thread.java:745) ~[na:1.8.0_60]
}}
> Stale locks in non-tx cache after merge
> ---------------------------------------
>
> Key: ISPN-4887
> URL: https://issues.jboss.org/browse/ISPN-4887
> Project: Infinispan
> Issue Type: Bug
> Components: Core, Test Suite - Core
> Affects Versions: 7.0.0.CR2
> Reporter: Dan Berindei
> Assignee: Dan Berindei
> Priority: Blocker
> Labels: testsuite_stability
>
> It appears to cause random failures in {{ThreeNodesReplicatedSplitAndMergeTest.testSplitAndMerge0}}:
> {noformat}
> org.infinispan.util.concurrent.TimeoutException: ISPN000299: Unable to acquire lock after 10 seconds for key MagicKey#null{74043ff7 at ThreeNodesReplicatedSplitAndMergeTest-NodeC-12710/9} and requestor Thread[testng-ThreeNodesReplicatedSplitAndMergeTest,5,main]. Lock is held by Thread[remote-thread-ThreeNodesReplicatedSplitAndMergeTest-NodeC-p5654-t5,5,main], while request came from null
> at org.infinispan.util.concurrent.locks.LockManagerImpl.lock(LockManagerImpl.java:198)
> at org.infinispan.util.concurrent.locks.LockManagerImpl.acquireLockNoCheck(LockManagerImpl.java:181)
> at org.infinispan.interceptors.locking.AbstractLockingInterceptor.lockKey(AbstractLockingInterceptor.java:127)
> at org.infinispan.interceptors.locking.AbstractLockingInterceptor.lockKey(AbstractLockingInterceptor.java:123)
> at org.infinispan.interceptors.locking.AbstractLockingInterceptor.visitPutKeyValueCommand(AbstractLockingInterceptor.java:47)
> at org.infinispan.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:71)
> at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98)
> at org.infinispan.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:112)
> at org.infinispan.commands.AbstractVisitor.visitPutKeyValueCommand(AbstractVisitor.java:33)
> at org.infinispan.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:71)
> at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98)
> at org.infinispan.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:112)
> at org.infinispan.commands.AbstractVisitor.visitPutKeyValueCommand(AbstractVisitor.java:33)
> at org.infinispan.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:71)
> at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98)
> at org.infinispan.statetransfer.StateTransferInterceptor.handleNonTxWriteCommand(StateTransferInterceptor.java:172)
> at org.infinispan.statetransfer.StateTransferInterceptor.visitPutKeyValueCommand(StateTransferInterceptor.java:95)
> at org.infinispan.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:71)
> at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98)
> at org.infinispan.interceptors.CacheMgmtInterceptor.updateStoreStatistics(CacheMgmtInterceptor.java:148)
> at org.infinispan.interceptors.CacheMgmtInterceptor.visitPutKeyValueCommand(CacheMgmtInterceptor.java:134)
> at org.infinispan.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:71)
> at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98)
> at org.infinispan.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:112)
> at org.infinispan.commands.AbstractVisitor.visitPutKeyValueCommand(AbstractVisitor.java:33)
> at org.infinispan.partionhandling.impl.PartitionHandlingInterceptor.visitPutKeyValueCommand(PartitionHandlingInterceptor.java:34)
> at org.infinispan.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:71)
> at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98)
> at org.infinispan.interceptors.InvocationContextInterceptor.handleAll(InvocationContextInterceptor.java:102)
> at org.infinispan.interceptors.InvocationContextInterceptor.handleDefault(InvocationContextInterceptor.java:71)
> at org.infinispan.commands.AbstractVisitor.visitPutKeyValueCommand(AbstractVisitor.java:33)
> at org.infinispan.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:71)
> at org.infinispan.interceptors.InterceptorChain.invoke(InterceptorChain.java:333)
> at org.infinispan.cache.impl.CacheImpl.executeCommandAndCommitIfNeeded(CacheImpl.java:1512)
> at org.infinispan.cache.impl.CacheImpl.putInternal(CacheImpl.java:990)
> at org.infinispan.cache.impl.CacheImpl.put(CacheImpl.java:982)
> at org.infinispan.cache.impl.CacheImpl.put(CacheImpl.java:1582)
> at org.infinispan.cache.impl.CacheImpl.put(CacheImpl.java:235)
> at org.infinispan.partitionhandling.ThreeNodesReplicatedSplitAndMergeTest.testSplitAndMerge(ThreeNodesReplicatedSplitAndMergeTest.java:132)
> at org.infinispan.partitionhandling.ThreeNodesReplicatedSplitAndMergeTest.testSplitAndMerge0(ThreeNodesReplicatedSplitAndMergeTest.java:27)
> {noformat}
> http://ci.infinispan.org/viewLog.html?buildId=13499&tab=buildResultsDiv&buildTypeId=bt9#testNameId4661106290352603795
--
This message was sent by Atlassian JIRA
(v6.4.11#64026)
More information about the infinispan-issues
mailing list