Hello,
I am running keycloak 19.0.1 via docker container and using mysql (5.7).
When I run the setup, I can see my DB migrations taking place as entries in databasechangelog reflecting, but after that the keycloak fails to start giving errors.
Running keycloak in start-dev mode
I enabled trace log and see the following:
TRACE [org.infinispan.util.concurrent.locks.impl.InfinispanLock] (main) Try acquire. Next in queue=null. Current=null
TRACE [org.keycloak.connections.jpa.DefaultJpaConnectionProvider] (main) DefaultJpaConnectionProvider close()
TRACE [org.hibernate.internal.SessionImpl] (main) Closing session [aecd373a-111a-40ad-beb3-44cdd19a3468]
TRACE [org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl] (main) Closing JDBC container [org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl@22112da1]
DEBUG [org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl] (main) HHH000420: Closing un-released batch
TRACE [org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl] (main) Starting after statement execution processing [BEFORE_TRANSACTION_COMPLETION]
TRACE [org.hibernate.resource.jdbc.internal.ResourceRegistryStandardImpl] (main) Releasing JDBC resources
TRACE [org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl] (main) Starting after statement execution processing [BEFORE_TRANSACTION_COMPLETION]
TRACE [org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl] (main) Closing logical connection
TRACE [org.hibernate.resource.jdbc.internal.LogicalConnectionManagedImpl] (main) Logical connection closed
DEBUG [org.infinispan.manager.DefaultCacheManager] (main) Stopping cache manager keycloak
TRACE [org.infinispan.manager.DefaultCacheManager] (main) Cache stop order: [realms, authenticationSessions, sessions, authorizationRevisions, clientSessions, work, keys, org.infinispan.CLIENT_SERVER_TX_TABLE, users, loginFailures, offlineClientSessions, authorization, realmRevisions, default, org.infinispan.CONFIG, org.infinispan.COUNTER, offlineSessions, actionTokens, userRevisions]
DEBUG [org.infinispan.cache.impl.CacheImpl] (main) Stopping cache realms on keycloak
DEBUG [org.hibernate.internal.SessionFactoryImpl] (main) HHH000031: Closing
TRACE [org.hibernate.engine.query.spi.QueryPlanCache] (main) Cleaning QueryPlan Cache
TRACE [org.hibernate.type.spi.TypeConfiguration$Scope] (main) Handling #sessionFactoryClosed from [org.hibernate.internal.SessionFactoryImpl@20734bbd] for TypeConfiguration
DEBUG [org.hibernate.type.spi.TypeConfiguration$Scope] (main) Un-scoping TypeConfiguration [org.hibernate.type.spi.TypeConfiguration$Scope@1467dcd0] from SessionFactory [org.hibernate.internal.SessionFactoryImpl@20734bbd]
DEBUG [org.hibernate.service.internal.AbstractServiceRegistryImpl] (main) Implicitly destroying ServiceRegistry on de-registration of all child ServiceRegistries
DEBUG [org.infinispan.quarkus.hibernate.cache.QuarkusInfinispanRegionFactory] (main) Stop region factory
DEBUG [org.infinispan.quarkus.hibernate.cache.QuarkusInfinispanRegionFactory] (main) Clear region references
DEBUG [org.hibernate.boot.registry.internal.BootstrapServiceRegistryImpl] (main) Implicitly destroying Boot-strap registry on de-registration of all child ServiceRegistries
DEBUG [org.hibernate.orm.beans] (main) HHH10005004: Stopping BeanContainer : io.quarkus.hibernate.orm.runtime.cdi.QuarkusArcBeanContainer@794c22cd
TRACE [io.agroal.pool] (main) Datasource '<default>': Destroyed connection com.mysql.cj.jdbc.ConnectionWrapper@6b7f291d
TRACE [io.agroal.pool] (main) Datasource '<default>': Destroyed connection com.mysql.cj.jdbc.ConnectionWrapper@55d38079
DEBUG [io.quarkus.arc.impl] (main) ArC DI container shut down
DEBUG [io.quarkus.thread-pool] (main) loop: 1, remaining: 60000000000, intervalRemaining: 5000000000, interruptRemaining: 10000000000
ERROR [org.keycloak.quarkus.runtime.cli.ExecutionExceptionHandler] (main) ERROR: Failed to start server in (development) mode
ERROR [org.keycloak.quarkus.runtime.cli.ExecutionExceptionHandler] (main) ERROR: javax.persistence.PersistenceException: org.hibernate.exception.GenericJDBCException: could not prepare statement
ERROR [org.keycloak.quarkus.runtime.cli.ExecutionExceptionHandler] (main) ERROR: org.hibernate.exception.GenericJDBCException: could not prepare statement
ERROR [org.keycloak.quarkus.runtime.cli.ExecutionExceptionHandler] (main) ERROR: could not prepare statement
ERROR [org.keycloak.quarkus.runtime.cli.ExecutionExceptionHandler] (main) ERROR: Connection is closed
ERROR [org.keycloak.quarkus.runtime.cli.ExecutionExceptionHandler] (main) For more details run the same command passing the '--verbose' option. Also you can use '--help' to see the details about the usage of the particular command.
This is when I have existing data from previous version of keycloak and migrate on startup. I can confirm my db connections are there but still get connection closed errors and keycloak doesnt start.
When I try with empty mysql db the server starts-up fine.
Please help.