Failed clearing MariaDB JDBC cache store ---------------------------------------- Key: ISPN-7130 URL: https://issues.jboss.org/browse/ISPN-7130 Project: Infinispan Issue Type: Bug Components: Loaders and Stores Affects Versions: 8.2.4.Final Reporter: Paul Ferraro Priority: Minor During scenarion {code}eap-7x-failover-db-session-shutdown-repl-sync-mariadb-10{code} (failover test when session are stored in MariaDB database) we saw errors on server when the server was shutting down. According to stacktrace it could be related to Infinispan. {code} 10:25:43,315 INFO [org.jboss.test.clusterbench.common.session.CommonHttpSessionServlet] (default task-1) New session created: OcWgFKcNH9Qyn1lQO2wJBdIkrf3d-_wr2gVoUeBp [JBossINF] 10:25:49,725 ERROR [org.infinispan.persistence.jdbc.binary.JdbcBinaryStore] (expiration-thread--p18-t1) ISPN008001: Failed clearing cache store: java.sql.SQLException: No Parameters set. The command addBatch() must have been set [JBossINF] at org.mariadb.jdbc.internal.util.ExceptionMapper.getSqlException(ExceptionMapper.java:149) [JBossINF] at org.mariadb.jdbc.MariaDbServerPreparedStatement.executeBatch(MariaDbServerPreparedStatement.java:211) [JBossINF] at org.jboss.jca.adapters.jdbc.CachedPreparedStatement.executeBatch(CachedPreparedStatement.java:714) [JBossINF] at org.jboss.jca.adapters.jdbc.WrappedStatement.executeBatch(WrappedStatement.java:1190) [JBossINF] at org.infinispan.persistence.jdbc.binary.JdbcBinaryStore.purge(JdbcBinaryStore.java:329) [JBossINF] at org.infinispan.persistence.manager.PersistenceManagerImpl.purgeExpired(PersistenceManagerImpl.java:373) [JBossINF] at org.infinispan.expiration.impl.ClusterExpirationManager.processExpiration(ClusterExpirationManager.java:90) [JBossINF] at org.infinispan.expiration.impl.ExpirationManagerImpl$ScheduledTask.run(ExpirationManagerImpl.java:231) [JBossINF] at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [JBossINF] at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) [JBossINF] at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) [JBossINF] at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) [JBossINF] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [JBossINF] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [JBossINF] at org.jboss.as.clustering.infinispan.ClassLoaderThreadFactory.lambda$newThread$0(ClassLoaderThreadFactory.java:48) [JBossINF] at java.lang.Thread.run(Thread.java:745) {code} It was shortly after cluster-wide rebalance finished {code} 10:25:07,403 INFO [org.infinispan.CLUSTER] (remote-thread--p8-t1) ISPN000310: Starting cluster-wide rebalance for cache clusterbench-ee7.ear/clusterbench-ee7-ejb.jar, topology CacheTopology{id=6, rebalanceId=4, currentCH=DefaultConsistentHash{ns=256, owners = (3)[dev212: 90+92, dev215: 85+81, dev213: 81+83]}, pendingCH=DefaultConsistentHash{ns=256, owners = (4)[dev212: 67+72, dev215: 65+63, dev213: 59+55, dev214: 65+66]}, unionCH=null, actualMembers=[dev212, dev215, dev213, dev214]} [JBossINF] 10:25:07,403 INFO [org.infinispan.CLUSTER] (remote-thread--p8-t1) [Context=clusterbench-ee7.ear/clusterbench-ee7-ejb.jar][Scope=dev212]ISPN100002: Started local rebalance [JBossINF] 10:25:07,404 INFO [org.infinispan.CLUSTER] (transport-thread--p14-t21) [Context=clusterbench-ee7.ear/clusterbench-ee7-ejb.jar][Scope=dev212]ISPN100003: Finished local rebalance [JBossINF] 10:25:07,408 INFO [org.infinispan.CLUSTER] (remote-thread--p8-t1) [Context=clusterbench-ee7.ear/clusterbench-ee7-ejb.jar][Scope=dev213]ISPN100003: Finished local rebalance [JBossINF] 10:25:07,413 INFO [org.infinispan.CLUSTER] (remote-thread--p8-t1) [Context=clusterbench-ee7.ear/clusterbench-ee7-ejb.jar][Scope=dev215]ISPN100003: Finished local rebalance [JBossINF] 10:25:07,436 INFO [org.infinispan.CLUSTER] (remote-thread--p8-t1) [Context=clusterbench-ee7.ear/clusterbench-ee7-ejb.jar][Scope=dev214]ISPN100003: Finished local rebalance [JBossINF] 10:25:07,436 INFO [org.infinispan.CLUSTER] (remote-thread--p8-t1) ISPN000336: Finished cluster-wide rebalance for cache clusterbench-ee7.ear/clusterbench-ee7-ejb.jar, topology id = 6 [JBossINF] 10:25:08,270 INFO [org.infinispan.CLUSTER] (remote-thread--p6-t5) [Context=clusterbench-ee7.ear.clusterbench-ee7-web-granular.war][Scope=dev214]ISPN100003: Finished local rebalance [JBossINF] 10:25:08,270 INFO [org.infinispan.CLUSTER] (remote-thread--p6-t5) ISPN000336: Finished cluster-wide rebalance for cache clusterbench-ee7.ear.clusterbench-ee7-web-granular.war, topology id = 6 {code} or after new cluster view was received {code} 10:29:53,838 INFO [org.infinispan.remoting.transport.jgroups.JGroupsTransport] (thread-4,ee,dev212) ISPN000094: Received new cluster view for channel ejb: [dev215|6] (3) [dev215, dev214, dev212] {code} No errors or warning occured on client at that time. Link to server log: http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/eap-7x-failover-db-se...