org.infinispan.util.concurrent.TimeoutException：ISPN000299：密钥15秒后无法获取锁定

Question

我在Hibernate L2缓存中遇到以下问题：

• 线程1

  • 执行本机查询：从WHERE ...删除... =>整个L2缓存无效
  • 长时间运行

• 线程2

  • 执行本机查询：UPDATE SET ... WHERE ... =>整个L2缓存无效
  • 线程被线程1阻塞
  • 15秒后，引发ISPN000299。

这里是完整的堆栈跟踪：

2020-03-11 15:06:01,384 ERROR [InvocationContextInterceptor] ISPN000136: Error executing command RemoveCommand, writing keys [com.sylob.cochise.dm1.ejb.entite.plageHoraire.PlageHoraireCoreEntite#4028ae256b033913016b0342b7ed6229]: org.infinispan.util.concurrent.TimeoutException: ISPN000299: Unable to acquire lock after 15 seconds for key com.sylob.cochise.dm1.ejb.entite.plageHoraire.PlageHoraireCoreEntite#4028ae256b033913016b0342b7ed6229 and requestor GlobalTransaction:<null>:1485:local. Lock is held by GlobalTransaction:<null>:1402:local
    at org.infinispan.util.concurrent.locks.impl.DefaultLockManager$KeyAwareExtendedLockPromise.lock(DefaultLockManager.java:238)
    at org.infinispan.interceptors.locking.AbstractLockingInterceptor.lockAndRecord(AbstractLockingInterceptor.java:193)
    at org.infinispan.interceptors.locking.AbstractTxLockingInterceptor.checkPendingAndLockKey(AbstractTxLockingInterceptor.java:193)
    at org.infinispan.interceptors.locking.AbstractTxLockingInterceptor.lockOrRegisterBackupLock(AbstractTxLockingInterceptor.java:116)
    at org.infinispan.interceptors.locking.PessimisticLockingInterceptor.visitDataWriteCommand(PessimisticLockingInterceptor.java:134)
    at org.infinispan.interceptors.locking.AbstractLockingInterceptor.visitRemoveCommand(AbstractLockingInterceptor.java:75)
    at org.infinispan.commands.write.RemoveCommand.acceptVisitor(RemoveCommand.java:67)
    at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:99)
    at org.infinispan.interceptors.TxInterceptor.enlistWriteAndInvokeNext(TxInterceptor.java:367)
    at org.infinispan.interceptors.TxInterceptor.visitRemoveCommand(TxInterceptor.java:231)
    at org.infinispan.commands.write.RemoveCommand.acceptVisitor(RemoveCommand.java:67)
    at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:99)
    at org.infinispan.interceptors.InvocationContextInterceptor.handleAll(InvocationContextInterceptor.java:114)
    at org.infinispan.interceptors.InvocationContextInterceptor.handleDefault(InvocationContextInterceptor.java:83)
    at org.infinispan.commands.AbstractVisitor.visitRemoveCommand(AbstractVisitor.java:48)
    at org.infinispan.commands.write.RemoveCommand.acceptVisitor(RemoveCommand.java:67)
    at org.infinispan.interceptors.InterceptorChain.invoke(InterceptorChain.java:335)
    at org.infinispan.cache.impl.CacheImpl.executeCommandAndCommitIfNeeded(CacheImpl.java:1672)
    at org.infinispan.cache.impl.CacheImpl.removeInternal(CacheImpl.java:557)
    at org.infinispan.cache.impl.CacheImpl.remove(CacheImpl.java:549)
    at org.infinispan.cache.impl.CacheImpl.remove(CacheImpl.java:543)
    at org.infinispan.cache.impl.AbstractDelegatingCache.remove(AbstractDelegatingCache.java:296)
    at org.hibernate.cache.infinispan.util.Caches.removeAll(Caches.java:285)
    at org.hibernate.cache.infinispan.access.InvalidationCacheAccessDelegate.removeAll(InvalidationCacheAccessDelegate.java:149)
    at org.hibernate.cache.infinispan.entity.ReadOnlyAccess.removeAll(ReadOnlyAccess.java:65)
    at org.hibernate.action.internal.BulkOperationCleanupAction$EntityCleanup.<init>(BulkOperationCleanupAction.java:210)
    at org.hibernate.action.internal.BulkOperationCleanupAction$EntityCleanup.<init>(BulkOperationCleanupAction.java:203)
    at org.hibernate.action.internal.BulkOperationCleanupAction.<init>(BulkOperationCleanupAction.java:110)
    at org.hibernate.engine.query.spi.NativeSQLQueryPlan.coordinateSharedCacheCleanup(NativeSQLQueryPlan.java:152)
    at org.hibernate.engine.query.spi.NativeSQLQueryPlan.performExecuteUpdate(NativeSQLQueryPlan.java:176)
    at org.hibernate.internal.SessionImpl.executeNativeUpdate(SessionImpl.java:1373)
    at org.hibernate.internal.SQLQueryImpl.executeUpdate(SQLQueryImpl.java:373)

我正在运行带有Hibernate 5.0.10.Final / Infinispan 8.2.4.Final的Wildfly 10.1.0.Final（独立完整配置文件）。环境不是集群的，会话也不是复制的。

我正在使用Wildfly为Infinispan L2缓存提供的默认配置：

<cache-container name="hibernate" default-cache="local-query" module="org.hibernate.infinispan">
    <local-cache name="entity">
        <transaction mode="NON_XA"/>
        <eviction strategy="LRU" max-entries="10000"/>
        <expiration max-idle="100000"/>
    </local-cache>
    <local-cache name="local-query">
        <eviction strategy="LRU" max-entries="10000"/>
        <expiration max-idle="100000"/>
    </local-cache>
    <local-cache name="timestamps"/>
</cache-container>

使用Hibernate 3.x / EhCache时，它可以正常工作。

这里怎么了？

感谢任何支持...

Answer 1

理论上，没有错。但是，由于某些限制（试图正确），这两种方法都试图一次删除一个事务中的条目，这确实需要很长时间。

WildFly 10已超过4岁，因此Hibernate 5.0.10也是如此。我不记得在哪个次要/微型版本中已解决什么问题，但是在最近足够多的Hibernate版本中，您应该使用<transaction mode="NONE"/>，并且在支持数据库事务语义的同时，这个问题也应该消失。