[keycloak-user] Trying to use JTA transactions for JPA causes errors

Dean Peterson peterson.dean at gmail.com
Fri Mar 14 12:26:52 EDT 2014


That makes sense.  I do not necessarily need JTA transactions for keycloak
but I am experiencing the error you can see in the keycloak-log.txt
constantly.  Without fail, that error occurs when I let keycloak sit idle
for about 5 minutes or so.

It would be nice to let the container manage connections and transactions
to Keycloak still.  Without that, I am fairly certain a production
environment needs something like c3p0 or DBCP(Apache Database Connection
Pooling) to make the connections to the database stable.  What are your
thoughts?  I will try using c3p0 today to see if that fixes the problem in
the attached log.  Also, should the jta-data-source tag in the
persistence.xml be changed to non-jta-data-source?  The keycloak-server
persistence.xml comes with jta-data-source tag out of the box.  I did try
changing it to non-jta-data-source and I still get the same errors so that
is not the cause of my problem.

Thanks,

Dean


On Fri, Mar 14, 2014 at 3:53 AM, Stian Thorgersen <stian at redhat.com> wrote:

> Keycloak has been designed to work in multiple environments, not just
> JavaEE. That's why container managed transactions are not used. JTA
> transactions are not required either as there's a single database, hence no
> need for distributed transactions.
>
> Can you provide me with some more information about the errors you are
> seeing? Including the server log, persistence.xml, etc. It should work
> perfectly well with resource local transactions.
>
> If you have a real requirement for using JTA a data-source we can
> certainly look into supporting that.
>
> ----- Original Message -----
> > From: "Dean Peterson" <peterson.dean at gmail.com>
> > To: keycloak-user at lists.jboss.org
> > Sent: Thursday, 13 March, 2014 6:40:23 PM
> > Subject: [keycloak-user] Trying to use JTA transactions for JPA causes
> errors
> >
> > I get transaction rollback errors frequently. Every time I leave the
> > application idle for a few minutes and come back, the system has
> transaction
> > errors. I have to refresh multiple times for the keycloak admun-ui to
> start
> > responding again. I realized my settings were using local database
> > transactions and that does not work well. I am using JBOSS and J2EE so I
> > definitely want to use the container managed transactions. I switched the
> > settings in my management console and changed my persistence.xml to this:
> >
> > <persistence xmlns=" http://java.sun.com/xml/ns/persistence "
> > xmlns:xsi=" http://www.w3.org/2001/XMLSchema-instance "
> > xsi:schemaLocation=" http://java.sun.com/xml/ns/persistence
> > http://java.sun.com/xml/ns/persistence/persistence_1_0.xsd "
> > version="1.0">
> > <persistence-unit name="jpa-keycloak-identity-store"
> transaction-type="JTA">
> > <jta-data-source>java:jboss/datasources/ui_users</jta-data-source>
> > <class>org.keycloak.models.jpa.entities.ApplicationEntity</class>
> > <class>org.keycloak.models.jpa.entities.CredentialEntity</class>
> > <class>org.keycloak.models.jpa.entities.OAuthClientEntity</class>
> > <class>org.keycloak.models.jpa.entities.RealmEntity</class>
> > <class>org.keycloak.models.jpa.entities.RequiredCredentialEntity</class>
> > <class>org.keycloak.models.jpa.entities.ApplicationRoleEntity</class>
> > <class>org.keycloak.models.jpa.entities.RealmRoleEntity</class>
> > <class>org.keycloak.models.jpa.entities.SocialLinkEntity</class>
> > <class>org.keycloak.models.jpa.entities.UserEntity</class>
> > <class>org.keycloak.models.jpa.entities.UserRoleMappingEntity</class>
> > <class>org.keycloak.models.jpa.entities.ScopeMappingEntity</class>
> >
> > <exclude-unlisted-classes>true</exclude-unlisted-classes>
> >
> > <properties>
> > <property name="hibernate.dialect"
> > value="org.hibernate.dialect.SQLServer2008Dialect"/>
> > <property name="hibernate.hbm2ddl.auto" value="update"/>
> > </properties>
> > </persistence-unit>
> > </persistence>
> >
> >
> >
> >
> >
> > Now when I start the server I get the following error:
> >
> > java.lang.NullPointerException
> > at
> >
> org.hibernate.engine.transaction.internal.jta.JtaStatusHelper.getStatus(JtaStatusHelper.java:76)
> > at
> > .
> > .
> > .
> >
> org.keycloak.models.jpa.JpaKeycloakSessionFactory.createSession(JpaKeycloakSessionFactory.java:21)
> > at
> > .
> > .
> > .
> > jboss.undertow.deployment.default-server.default-host./auth: Failed to
> start
> > service
> > Caused by: java.lang.RuntimeException: Failed to construct public
> >
> org.keycloak.server.KeycloakServerApplication(javax.servlet.ServletContext)
> > throws java.io.FileNotFoundException
> >
> > Any ideas why this is happening?
> >
> > Thanks,
> >
> > Dean Peterson
> >
> > _______________________________________________
> > keycloak-user mailing list
> > keycloak-user at lists.jboss.org
> > https://lists.jboss.org/mailman/listinfo/keycloak-user
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.jboss.org/pipermail/keycloak-user/attachments/20140314/11107277/attachment-0001.html 
-------------- next part --------------
09:54:40,616 INFO  [org.jboss.modules] (main) JBoss Modules version 1.3.0.Final
09:54:40,937 INFO  [org.jboss.msc] (main) JBoss MSC version 1.2.0.Final
09:54:41,028 INFO  [org.jboss.as] (MSC service thread 1-6) JBAS015899: WildFly 8.0.0.Final "WildFly" starting
09:54:42,203 WARN  [org.jboss.as.server.deployment.scanner] (DeploymentScanner-threads - 1) JBAS015002: Deployment of 'keycloak-adapter-core' requested, but the deployment is not present
09:54:42,203 INFO  [org.jboss.as.server.deployment.scanner] (DeploymentScanner-threads - 1) JBAS015003: Found customer-portal-example.war in deployment directory. To trigger deployment create a file called customer-portal-example.war.dodeploy
09:54:42,204 INFO  [org.jboss.as.server.deployment.scanner] (DeploymentScanner-threads - 1) JBAS015003: Found database-service.war in deployment directory. To trigger deployment create a file called database-service.war.dodeploy
09:54:42,221 INFO  [org.jboss.as.server] (Controller Boot Thread) JBAS015888: Creating http management service using socket-binding (management-http)
09:54:42,243 INFO  [org.xnio] (MSC service thread 1-39) XNIO version 3.2.0.Final
09:54:42,251 INFO  [org.xnio.nio] (MSC service thread 1-39) XNIO NIO Implementation Version 3.2.0.Final
09:54:42,275 INFO  [org.jboss.as.security] (ServerService Thread Pool -- 47) JBAS013171: Activating Security Subsystem
09:54:42,279 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 34) JBAS010280: Activating Infinispan subsystem.
09:54:42,284 INFO  [org.jboss.as.naming] (ServerService Thread Pool -- 42) JBAS011800: Activating Naming Subsystem
09:54:42,289 INFO  [org.jboss.as.webservices] (ServerService Thread Pool -- 51) JBAS015537: Activating WebServices Extension
09:54:42,291 INFO  [org.jboss.as.security] (MSC service thread 1-26) JBAS013170: Current PicketBox version=4.0.20.Final
09:54:42,293 INFO  [org.jboss.as.jsf] (ServerService Thread Pool -- 40) JBAS012615: Activated the following JSF Implementations: [main]
09:54:42,323 INFO  [org.wildfly.extension.undertow] (MSC service thread 1-14) JBAS017502: Undertow 1.0.0.Final starting
09:54:42,324 INFO  [org.wildfly.extension.undertow] (ServerService Thread Pool -- 50) JBAS017502: Undertow 1.0.0.Final starting
09:54:42,329 INFO  [org.jboss.as.connector.logging] (MSC service thread 1-33) JBAS010408: Starting JCA Subsystem (IronJacamar 1.1.3.Final)
09:54:42,354 INFO  [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 29) JBAS010403: Deploying JDBC-compliant driver class org.h2.Driver (version 1.3)
09:54:42,360 INFO  [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-33) JBAS010417: Started Driver service with driver-name = h2
09:54:42,366 INFO  [org.jboss.as.naming] (MSC service thread 1-15) JBAS011802: Starting Naming Service
09:54:42,368 INFO  [org.jboss.as.mail.extension] (MSC service thread 1-34) JBAS015400: Bound mail session [java:jboss/mail/Default]
09:54:42,417 INFO  [org.jboss.remoting] (MSC service thread 1-4) JBoss Remoting version 4.0.0.Final
09:54:42,436 INFO  [org.wildfly.extension.undertow] (ServerService Thread Pool -- 50) JBAS017527: Creating file handler for path C:\wildfly-8.0.0.Final/welcome-content
09:54:42,450 INFO  [org.wildfly.extension.undertow] (MSC service thread 1-16) JBAS017525: Started server default-server.
09:54:42,460 INFO  [org.wildfly.extension.undertow] (MSC service thread 1-22) JBAS017531: Host default-host starting
09:54:42,495 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-10) JBAS010400: Bound data source [java:jboss/datasources/ExampleDS]
09:54:42,498 INFO  [org.wildfly.extension.undertow] (MSC service thread 1-17) JBAS017519: Undertow HTTP listener default listening on /0.0.0.0:8080
09:54:42,668 INFO  [org.jboss.as.server.deployment.scanner] (MSC service thread 1-12) JBAS015012: Started FileSystemDeploymentService for directory C:\wildfly-8.0.0.Final\standalone\deployments
09:54:42,673 INFO  [org.jboss.as.server.deployment] (MSC service thread 1-3) JBAS015876: Starting deployment of "sqljdbc4.jar" (runtime-name: "sqljdbc4.jar")
09:54:42,930 INFO  [org.jboss.ws.common.management] (MSC service thread 1-40) JBWS022052: Starting JBoss Web Services - Stack CXF Server 4.2.3.Final
09:54:43,218 INFO  [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-34) JBAS010403: Deploying JDBC-compliant driver class com.microsoft.sqlserver.jdbc.SQLServerDriver (version 4.0)
09:54:43,231 INFO  [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-7) JBAS010417: Started Driver service with driver-name = sqljdbc4.jar
09:54:43,233 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-35) JBAS010400: Bound data source [java:jboss/datasources/ui_users]
09:54:43,320 INFO  [org.jboss.as.server] (Controller Boot Thread) JBAS018559: Deployed "sqljdbc4.jar" (runtime-name : "sqljdbc4.jar")
09:54:43,519 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015961: Http management interface listening on http://127.0.0.1:9990/management
09:54:43,520 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015951: Admin console listening on http://127.0.0.1:9990
09:54:43,520 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015874: WildFly 8.0.0.Final "WildFly" started in 3301ms - Started 222 of 277 services (88 services are lazy, passive or on-demand)
09:55:17,767 INFO  [org.jboss.as.server.deployment.scanner] (DeploymentScanner-threads - 1) JBAS015003: Found keycloak-server.war in deployment directory. To trigger deployment create a file called keycloak-server.war.dodeploy
09:55:27,860 INFO  [org.jboss.as.server.deployment] (MSC service thread 1-16) JBAS015876: Starting deployment of "keycloak-server.war" (runtime-name: "keycloak-server.war")
09:55:32,770 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-40) JBAS015960: Class Path entry jaxb-api.jar in /C:/wildfly-8.0.0.Final/standalone/deployments/keycloak-server.war/WEB-INF/lib/jaxb-core-2.2.7.jar  does not point to a valid jar for a Class-Path reference.
09:55:32,771 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-40) JBAS015960: Class Path entry jaxb-api.jar in /C:/wildfly-8.0.0.Final/standalone/deployments/keycloak-server.war/WEB-INF/lib/jaxb-impl-2.2.7.jar  does not point to a valid jar for a Class-Path reference.
09:55:32,771 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-40) JBAS015960: Class Path entry jaxb-core.jar in /C:/wildfly-8.0.0.Final/standalone/deployments/keycloak-server.war/WEB-INF/lib/jaxb-impl-2.2.7.jar  does not point to a valid jar for a Class-Path reference.
09:55:32,881 INFO  [org.jboss.as.jpa] (MSC service thread 1-6) JBAS011401: Read persistence.xml for jpa-keycloak-identity-store
09:55:33,299 INFO  [org.jboss.as.jpa] (ServerService Thread Pool -- 54) JBAS011409: Starting Persistence Unit (phase 1 of 2) Service 'keycloak-server.war#jpa-keycloak-identity-store'
09:55:33,324 INFO  [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 54) HHH000204: Processing PersistenceUnitInfo [
	name: jpa-keycloak-identity-store
	...]
09:55:33,481 INFO  [org.hibernate.Version] (ServerService Thread Pool -- 54) HHH000412: Hibernate Core {4.3.1.Final}
09:55:33,486 INFO  [org.hibernate.cfg.Environment] (ServerService Thread Pool -- 54) HHH000206: hibernate.properties not found
09:55:33,490 INFO  [org.hibernate.cfg.Environment] (ServerService Thread Pool -- 54) HHH000021: Bytecode provider name : javassist
09:55:33,736 WARN  [org.jboss.as.ee] (MSC service thread 1-12) JBAS011006: Not installing optional component org.jboss.resteasy.plugins.server.servlet.Servlet3AsyncHttpRequest$Servlet3ExecutionContext$Servle3AsychronousResponse due to an exception (enable DEBUG log level to see the cause)
09:55:33,903 INFO  [org.jboss.as.jpa] (ServerService Thread Pool -- 54) JBAS011409: Starting Persistence Unit (phase 2 of 2) Service 'keycloak-server.war#jpa-keycloak-identity-store'
09:55:34,039 INFO  [org.hibernate.annotations.common.Version] (ServerService Thread Pool -- 54) HCANN000001: Hibernate Commons Annotations {4.0.4.Final}
09:55:36,415 INFO  [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 54) HHH000400: Using dialect: org.hibernate.dialect.SQLServer2008Dialect
09:55:36,933 INFO  [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (ServerService Thread Pool -- 54) HHH000397: Using ASTQueryTranslatorFactory
09:55:37,031 INFO  [org.hibernate.validator.internal.util.Version] (ServerService Thread Pool -- 54) HV000001: Hibernate Validator 5.0.3.Final
09:55:38,229 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 54) HHH000228: Running hbm2ddl schema update
09:55:38,231 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 54) HHH000102: Fetching database metadata
09:55:38,245 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 54) HHH000396: Updating schema
09:55:38,835 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.ApplicationDefaultRoles
09:55:38,836 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [defaultroles_id, applicationentity_id]
09:55:38,836 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_g6l8hy3l98i72814tlecxbsal, fk_63mlbcao16xl0fihhba5hj955]
09:55:38,837 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [ix_applicationdefaultroles_column, uk_63mlbcao16xl0fihhba5hj955]
09:55:38,944 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.ApplicationEntity
09:55:38,945 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [id, beareronly, realm_id, managementurl, baseurl, surrogateauthrequired]
09:55:38,946 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_2ne1lwypulqs3pini9phv5fr2, fk_5lh1t23ye3m5taifap3eoh6e5]
09:55:38,946 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__applicat__3213e83f39c1eba6]
09:55:39,047 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.ApplicationRole
09:55:39,048 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [id, application_id]
09:55:39,048 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_ulxuhip32h8nk5pbb1m6103n, fk_9rk108fvewkeagy9qjhuqfb9m]
09:55:39,049 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__applicat__3213e83f7c129ea3]
09:55:39,164 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.ClientEntity
09:55:39,165 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [id, enabled, publicclient, notbefore, name, secret, allowedclaimsmask]
09:55:39,165 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: []
09:55:39,166 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__clienten__3213e83f43042403]
09:55:39,310 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.ClientEntity_redirectUris
09:55:39,311 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [cliententity_id, redirecturis]
09:55:39,312 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_feix1pdp92lddt2ou5qa7u2l6]
09:55:39,313 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [ix_cliententity_redirecturis_column]
09:55:39,422 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.ClientEntity_webOrigins
09:55:39,423 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [weborigins, cliententity_id]
09:55:39,423 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_gh3h7pfhqdulen2dafqy5i4y0]
09:55:39,423 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [ix_cliententity_weborigins_column]
09:55:39,523 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.CredentialEntity
09:55:39,524 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [id, value, device, user_id, type, salt]
09:55:39,524 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_pn32x46lgmhlaldchhp47wfgj]
09:55:39,525 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__credenti__3213e83fd607e6bd]
09:55:39,620 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.OAuthClientEntity
09:55:39,621 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [id, realm_id]
09:55:39,621 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_c7p5k3d5mewb3yym9qypp76uj, fk_qlc5yqdm2qs1kpiias2ccx8qw]
09:55:39,622 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__oauthcli__3213e83ffce156ca]
09:55:39,728 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.RealmDefaultRoles
09:55:39,729 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [realmentity_id, defaultroles_id]
09:55:39,729 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_olcemcd95akm5sj17xr8rwrkg, fk_lm3mms6o7y861qvb68sycmkaj]
09:55:39,730 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [ix_realmdefaultroles_column, uk_olcemcd95akm5sj17xr8rwrkg]
09:55:39,836 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.RealmEntity
09:55:39,838 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [rememberme, enabled, publickeypem, accounttheme, passwordpolicy, registrationallowed, centralloginlifespan, notbefore, accesstokenlifespan, resetpasswordallowed, privatekeypem, updateprofileoninitsoclogin, accesscodelifespan, accesscodelifespanuseraction, id, refreshtokenlifespan, logintheme, sslnotrequired, social, name, verifyemail]
09:55:39,838 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: []
09:55:39,838 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__realment__3213e83feb80b4a2]
09:55:39,941 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.RealmEntity_smtpConfig
09:55:39,942 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [realmentity_id, name, value]
09:55:39,942 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_hbtlvt068mnrudm3cf0px691h]
09:55:39,943 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__realment__672db377a990e010]
09:55:40,046 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.RealmEntity_socialConfig
09:55:40,046 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [realmentity_id, name, value]
09:55:40,046 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_18sn19xqpu83b06jv6w8ksvfv]
09:55:40,046 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__realment__672db37711d130f8]
09:55:40,207 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.RequiredCredentialEntity
09:55:40,207 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [id, input, secret, formlabel, type]
09:55:40,208 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: []
09:55:40,209 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__required__3213e83fc274502a]
09:55:40,309 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.RoleEntity
09:55:40,310 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [id, realm_id, description, name, dtype]
09:55:40,310 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_2wxhye0e7ejl1swt4ju9buaxw]
09:55:40,311 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__roleenti__3213e83f9783b1ca]
09:55:40,411 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.RoleEntity_RoleEntity
09:55:40,412 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [roleentity_id, compositeroles_id]
09:55:40,412 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_rhas6cbjwjewh3qe1ar3ewv3x, fk_fqxkb97litt72ru58fr1y8v8n]
09:55:40,413 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [ix_roleentity_roleentity_column]
09:55:40,507 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.ScopeMappingEntity
09:55:40,508 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [id, role_id, client_id]
09:55:40,508 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_bkaeyvs28ip6gx4y2h4ij4277, fk_so3wyrspaer7i9it9fr8t9a0o]
09:55:40,508 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__scopemap__3213e83f29ccb440]
09:55:40,605 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.SocialLinkEntity
09:55:40,606 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [id, socialusername, realm_id, socialprovider, user_id]
09:55:40,606 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_jav76o82ob85iuxm2l0gg904h, fk_of3vi3cc8yo5aavbsq2flfm32]
09:55:40,607 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__socialli__3213e83f99518587]
09:55:40,706 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.UserEntity
09:55:40,708 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [id, loginname, enabled, realm_id, totp, email, emailverified, lastname, firstname]
09:55:40,708 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_1u1wm7gj4o98kabis6et6klh5]
09:55:40,708 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__userenti__3213e83fb65d69ce]
09:55:40,810 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.UserEntity_CredentialEntity
09:55:40,811 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [credentials_id, userentity_id]
09:55:40,812 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_302t29u9komfu7d7qffci0cie, fk_kwlok0nencsu8kuhwervrn2p5]
09:55:40,812 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [ix_userentity_credentialentity_column, uk_kwlok0nencsu8kuhwervrn2p5]
09:55:40,916 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.UserEntity_attributes
09:55:40,916 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [userentity_id, name, value]
09:55:40,916 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_pv89d7hl2qoyg2dc1b9bupw7l]
09:55:40,917 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__userenti__cbbe5e2fcbbb72d1]
09:55:41,018 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.UserEntity_requiredActions
09:55:41,019 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [userentity_id, requiredactions]
09:55:41,019 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_eclsk6gyvwy477usdcwu8l1mx]
09:55:41,020 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [ix_userentity_requiredactions_column]
09:55:41,117 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.UserRoleMappingEntity
09:55:41,118 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [id, role_id, user_id]
09:55:41,118 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_agpsm5ca3g409ed9l3tn2j2ei, fk_j518aofj2vsvq3uo7qygnx6kn]
09:55:41,119 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [pk__userrole__3213e83f2a2d4194]
09:55:41,220 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000261: Table found: ui_users.dbo.User_RequiredCreds
09:55:41,221 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000037: Columns: [realmentity_id, requiredcredentials_id]
09:55:41,222 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000108: Foreign keys: [fk_anp4huiptj153jqe0muwgsvkf, fk_4vn3690ov78s8nai1fmpgax0m]
09:55:41,222 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (ServerService Thread Pool -- 54) HHH000126: Indexes: [uk_anp4huiptj153jqe0muwgsvkf, ix_user_requiredcreds_column]
09:55:41,227 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 54) HHH000232: Schema update complete
09:55:41,228 WARN  [org.hibernate.internal.SessionFactoryImpl] (ServerService Thread Pool -- 54) HHH000008: JTASessionContext being used with JDBCTransactionFactory; auto-flush will not operate correctly with getCurrentSession()
09:55:42,505 INFO  [org.hibernate.jpa.internal.util.LogHelper] (MSC service thread 1-10) HHH000204: Processing PersistenceUnitInfo [
	name: jpa-keycloak-identity-store
	...]
09:55:42,581 INFO  [org.hibernate.dialect.Dialect] (MSC service thread 1-10) HHH000400: Using dialect: org.hibernate.dialect.SQLServer2008Dialect
09:55:42,681 INFO  [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (MSC service thread 1-10) HHH000397: Using ASTQueryTranslatorFactory
09:55:43,034 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (MSC service thread 1-10) HHH000228: Running hbm2ddl schema update
09:55:43,034 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (MSC service thread 1-10) HHH000102: Fetching database metadata
09:55:43,036 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (MSC service thread 1-10) HHH000396: Updating schema
09:55:43,133 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.ApplicationDefaultRoles
09:55:43,134 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [defaultroles_id, applicationentity_id]
09:55:43,134 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_g6l8hy3l98i72814tlecxbsal, fk_63mlbcao16xl0fihhba5hj955]
09:55:43,135 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [ix_applicationdefaultroles_column, uk_63mlbcao16xl0fihhba5hj955]
09:55:43,232 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.ApplicationEntity
09:55:43,233 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [id, beareronly, realm_id, managementurl, baseurl, surrogateauthrequired]
09:55:43,233 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_2ne1lwypulqs3pini9phv5fr2, fk_5lh1t23ye3m5taifap3eoh6e5]
09:55:43,234 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__applicat__3213e83f39c1eba6]
09:55:43,325 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.ApplicationRole
09:55:43,326 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [id, application_id]
09:55:43,326 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_ulxuhip32h8nk5pbb1m6103n, fk_9rk108fvewkeagy9qjhuqfb9m]
09:55:43,326 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__applicat__3213e83f7c129ea3]
09:55:43,422 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.ClientEntity
09:55:43,423 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [id, enabled, publicclient, notbefore, name, secret, allowedclaimsmask]
09:55:43,423 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: []
09:55:43,424 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__clienten__3213e83f43042403]
09:55:43,529 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.ClientEntity_redirectUris
09:55:43,530 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [cliententity_id, redirecturis]
09:55:43,531 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_feix1pdp92lddt2ou5qa7u2l6]
09:55:43,531 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [ix_cliententity_redirecturis_column]
09:55:43,625 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.ClientEntity_webOrigins
09:55:43,625 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [weborigins, cliententity_id]
09:55:43,626 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_gh3h7pfhqdulen2dafqy5i4y0]
09:55:43,626 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [ix_cliententity_weborigins_column]
09:55:43,723 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.CredentialEntity
09:55:43,724 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [id, value, device, user_id, type, salt]
09:55:43,724 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_pn32x46lgmhlaldchhp47wfgj]
09:55:43,725 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__credenti__3213e83fd607e6bd]
09:55:43,821 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.OAuthClientEntity
09:55:43,821 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [id, realm_id]
09:55:43,821 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_c7p5k3d5mewb3yym9qypp76uj, fk_qlc5yqdm2qs1kpiias2ccx8qw]
09:55:43,821 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__oauthcli__3213e83ffce156ca]
09:55:43,917 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.RealmDefaultRoles
09:55:43,918 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [realmentity_id, defaultroles_id]
09:55:43,918 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_olcemcd95akm5sj17xr8rwrkg, fk_lm3mms6o7y861qvb68sycmkaj]
09:55:43,919 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [ix_realmdefaultroles_column, uk_olcemcd95akm5sj17xr8rwrkg]
09:55:44,022 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.RealmEntity
09:55:44,023 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [rememberme, enabled, publickeypem, accounttheme, passwordpolicy, registrationallowed, centralloginlifespan, notbefore, accesstokenlifespan, resetpasswordallowed, privatekeypem, updateprofileoninitsoclogin, accesscodelifespan, accesscodelifespanuseraction, id, refreshtokenlifespan, logintheme, sslnotrequired, social, name, verifyemail]
09:55:44,023 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: []
09:55:44,024 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__realment__3213e83feb80b4a2]
09:55:44,126 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.RealmEntity_smtpConfig
09:55:44,126 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [realmentity_id, name, value]
09:55:44,127 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_hbtlvt068mnrudm3cf0px691h]
09:55:44,127 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__realment__672db377a990e010]
09:55:44,225 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.RealmEntity_socialConfig
09:55:44,225 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [realmentity_id, name, value]
09:55:44,226 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_18sn19xqpu83b06jv6w8ksvfv]
09:55:44,226 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__realment__672db37711d130f8]
09:55:44,326 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.RequiredCredentialEntity
09:55:44,326 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [id, input, secret, formlabel, type]
09:55:44,326 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: []
09:55:44,327 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__required__3213e83fc274502a]
09:55:44,444 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.RoleEntity
09:55:44,445 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [id, realm_id, description, name, dtype]
09:55:44,445 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_2wxhye0e7ejl1swt4ju9buaxw]
09:55:44,446 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__roleenti__3213e83f9783b1ca]
09:55:44,542 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.RoleEntity_RoleEntity
09:55:44,543 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [roleentity_id, compositeroles_id]
09:55:44,543 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_rhas6cbjwjewh3qe1ar3ewv3x, fk_fqxkb97litt72ru58fr1y8v8n]
09:55:44,543 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [ix_roleentity_roleentity_column]
09:55:44,637 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.ScopeMappingEntity
09:55:44,637 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [id, role_id, client_id]
09:55:44,637 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_bkaeyvs28ip6gx4y2h4ij4277, fk_so3wyrspaer7i9it9fr8t9a0o]
09:55:44,638 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__scopemap__3213e83f29ccb440]
09:55:44,732 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.SocialLinkEntity
09:55:44,732 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [id, socialusername, realm_id, socialprovider, user_id]
09:55:44,734 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_jav76o82ob85iuxm2l0gg904h, fk_of3vi3cc8yo5aavbsq2flfm32]
09:55:44,734 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__socialli__3213e83f99518587]
09:55:44,835 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.UserEntity
09:55:44,837 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [id, loginname, enabled, realm_id, totp, email, emailverified, lastname, firstname]
09:55:44,837 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_1u1wm7gj4o98kabis6et6klh5]
09:55:44,837 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__userenti__3213e83fb65d69ce]
09:55:44,937 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.UserEntity_CredentialEntity
09:55:44,938 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [credentials_id, userentity_id]
09:55:44,938 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_302t29u9komfu7d7qffci0cie, fk_kwlok0nencsu8kuhwervrn2p5]
09:55:44,939 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [ix_userentity_credentialentity_column, uk_kwlok0nencsu8kuhwervrn2p5]
09:55:45,037 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.UserEntity_attributes
09:55:45,038 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [userentity_id, name, value]
09:55:45,039 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_pv89d7hl2qoyg2dc1b9bupw7l]
09:55:45,039 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__userenti__cbbe5e2fcbbb72d1]
09:55:45,136 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.UserEntity_requiredActions
09:55:45,137 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [userentity_id, requiredactions]
09:55:45,137 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_eclsk6gyvwy477usdcwu8l1mx]
09:55:45,138 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [ix_userentity_requiredactions_column]
09:55:45,232 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.UserRoleMappingEntity
09:55:45,232 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [id, role_id, user_id]
09:55:45,233 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_agpsm5ca3g409ed9l3tn2j2ei, fk_j518aofj2vsvq3uo7qygnx6kn]
09:55:45,234 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [pk__userrole__3213e83f2a2d4194]
09:55:45,332 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000261: Table found: ui_users.dbo.User_RequiredCreds
09:55:45,333 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000037: Columns: [realmentity_id, requiredcredentials_id]
09:55:45,334 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000108: Foreign keys: [fk_anp4huiptj153jqe0muwgsvkf, fk_4vn3690ov78s8nai1fmpgax0m]
09:55:45,334 INFO  [org.hibernate.tool.hbm2ddl.TableMetadata] (MSC service thread 1-10) HHH000126: Indexes: [uk_anp4huiptj153jqe0muwgsvkf, ix_user_requiredcreds_column]
09:55:45,337 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (MSC service thread 1-10) HHH000232: Schema update complete
09:55:45,898 INFO  [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-10) Deploying javax.ws.rs.core.Application: class org.keycloak.server.KeycloakServerApplication
09:55:45,904 INFO  [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-10) Adding class resource org.keycloak.services.resources.QRCodeResource from Application class org.keycloak.server.KeycloakServerApplication
09:55:45,904 INFO  [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-10) Adding provider class org.keycloak.SkeletonKeyContextResolver from Application class org.keycloak.server.KeycloakServerApplication
09:55:45,905 INFO  [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-10) Adding class resource org.keycloak.services.resources.ThemeResource from Application class org.keycloak.server.KeycloakServerApplication
09:55:45,905 INFO  [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-10) Adding singleton resource org.keycloak.services.resources.admin.AdminService from Application class org.keycloak.server.KeycloakServerApplication
09:55:45,905 INFO  [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-10) Adding singleton resource org.keycloak.services.resources.SocialResource from Application class org.keycloak.server.KeycloakServerApplication
09:55:45,906 INFO  [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-10) Adding singleton resource org.keycloak.services.resources.RealmsResource from Application class org.keycloak.server.KeycloakServerApplication
09:55:46,286 INFO  [org.wildfly.extension.undertow] (MSC service thread 1-10) JBAS017534: Registered web context: /auth
09:55:46,467 INFO  [org.jboss.as.server] (DeploymentScanner-threads - 2) JBAS018559: Deployed "keycloak-server.war" (runtime-name : "keycloak-server.war")
09:56:04,139 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-6) authenticateCookie
09:56:04,143 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-6) authenticateCookie could not find cookie: KEYCLOAK_ADMIN_CONSOLE_IDENTITY
09:56:04,678 INFO  [org.keycloak.services.resources.TokenService] (default task-1) TokenService.loginPage
09:56:05,028 INFO  [org.keycloak.services.resources.TokenService] (default task-1) Checking cookie...
09:56:05,028 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-1) authenticateIdentityCookie
09:56:05,029 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-1) authenticateIdentityCookie
09:56:05,030 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-1) authenticateCookie could not find cookie: KEYCLOAK_IDENTITY
09:56:05,030 INFO  [org.keycloak.services.resources.TokenService] (default task-1) createLogin() now...
09:56:10,033 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-15) createLoginCookie
09:56:10,034 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-15) createIdentityToken
09:56:10,284 INFO  [org.keycloak.services.resources.admin.AdminService] (default task-12) loginRedirect ********************** <---
09:56:10,594 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-12) createIdentityToken
09:56:11,351 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-8) authenticateCookie
09:56:11,401 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-8) token verified
09:56:12,864 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-14) authenticateCookie
09:56:12,865 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-9) authenticateCookie
09:56:12,868 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-14) token verified
09:56:12,868 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-9) token verified
09:56:14,202 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-1) authenticateCookie
09:56:14,203 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-4) authenticateCookie
09:56:14,206 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-1) token verified
09:56:14,207 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-4) token verified
09:57:11,895 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-3) authenticateCookie
09:57:11,900 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-3) token verified
09:57:12,171 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-3) createIdentityToken
09:58:12,894 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-6) authenticateCookie
09:58:12,897 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-6) token verified
09:58:13,184 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-6) createIdentityToken
09:59:13,335 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-2) authenticateCookie
09:59:13,339 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-2) token verified
09:59:13,567 INFO  [org.keycloak.services.managers.AuthenticationManager] (default task-2) createIdentityToken
10:06:20,809 WARN  [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (default task-14) SQL Error: 0, SQLState: 08S01
10:06:20,810 ERROR [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (default task-14) Read timed out
10:06:20,815 INFO  [org.hibernate.event.internal.DefaultLoadEventListener] (default task-14) HHH000327: Error performing load command : org.hibernate.exception.JDBCConnectionException: could not prepare statement
10:06:20,822 ERROR [io.undertow.request] (default task-14) UT005023: Exception handling request to /auth/rest/admin/logout: javax.persistence.PersistenceException: unexpected error when rollbacking
	at org.hibernate.jpa.internal.TransactionImpl.rollback(TransactionImpl.java:111) [hibernate-entitymanager-4.3.1.Final.jar:4.3.1.Final]
	at org.keycloak.models.jpa.JpaKeycloakSession.close(JpaKeycloakSession.java:99) [keycloak-model-jpa-1.0-alpha-3-SNAPSHOT.jar:]
	at org.keycloak.services.filters.KeycloakSessionServletFilter.doFilter(KeycloakSessionServletFilter.java:52) [keycloak-services-1.0-alpha-3-SNAPSHOT.jar:]
	at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:56) [undertow-servlet-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:132) [undertow-servlet-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.servlet.handlers.FilterHandler.handleRequest(FilterHandler.java:85) [undertow-servlet-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.servlet.handlers.security.ServletSecurityRoleHandler.handleRequest(ServletSecurityRoleHandler.java:61) [undertow-servlet-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.servlet.handlers.ServletDispatchingHandler.handleRequest(ServletDispatchingHandler.java:36) [undertow-servlet-1.0.0.Final.jar:1.0.0.Final]
	at org.wildfly.extension.undertow.security.SecurityContextAssociationHandler.handleRequest(SecurityContextAssociationHandler.java:78)
	at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:25) [undertow-core-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.servlet.handlers.security.SSLInformationAssociationHandler.handleRequest(SSLInformationAssociationHandler.java:113) [undertow-servlet-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.security.handlers.AuthenticationCallHandler.handleRequest(AuthenticationCallHandler.java:52) [undertow-core-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.security.handlers.AbstractConfidentialityHandler.handleRequest(AbstractConfidentialityHandler.java:45) [undertow-core-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.servlet.handlers.security.ServletConfidentialityConstraintHandler.handleRequest(ServletConfidentialityConstraintHandler.java:61) [undertow-servlet-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.servlet.handlers.security.CachedAuthenticatedSessionHandler.handleRequest(CachedAuthenticatedSessionHandler.java:70) [undertow-servlet-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.security.handlers.SecurityInitialHandler.handleRequest(SecurityInitialHandler.java:76) [undertow-core-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:25) [undertow-core-1.0.0.Final.jar:1.0.0.Final]
	at org.wildfly.extension.undertow.security.jacc.JACCContextIdHandler.handleRequest(JACCContextIdHandler.java:61)
	at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:25) [undertow-core-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:25) [undertow-core-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.servlet.handlers.ServletInitialHandler.handleFirstRequest(ServletInitialHandler.java:240) [undertow-servlet-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.servlet.handlers.ServletInitialHandler.dispatchRequest(ServletInitialHandler.java:227) [undertow-servlet-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.servlet.handlers.ServletInitialHandler.access$000(ServletInitialHandler.java:73) [undertow-servlet-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.servlet.handlers.ServletInitialHandler$1.handleRequest(ServletInitialHandler.java:146) [undertow-servlet-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.server.Connectors.executeRootHandler(Connectors.java:168) [undertow-core-1.0.0.Final.jar:1.0.0.Final]
	at io.undertow.server.HttpServerExchange$1.run(HttpServerExchange.java:687) [undertow-core-1.0.0.Final.jar:1.0.0.Final]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_13]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_13]
	at java.lang.Thread.run(Thread.java:722) [rt.jar:1.7.0_13]
Caused by: org.hibernate.TransactionException: rollback failed
	at org.hibernate.engine.transaction.spi.AbstractTransactionImpl.rollback(AbstractTransactionImpl.java:217) [hibernate-core-4.3.1.Final.jar:4.3.1.Final]
	at org.hibernate.jpa.internal.TransactionImpl.rollback(TransactionImpl.java:108) [hibernate-entitymanager-4.3.1.Final.jar:4.3.1.Final]
	... 28 more
Caused by: java.lang.NullPointerException
	at org.hibernate.engine.transaction.internal.jdbc.JdbcTransaction.doRollback(JdbcTransaction.java:163) [hibernate-core-4.3.1.Final.jar:4.3.1.Final]
	at org.hibernate.engine.transaction.spi.AbstractTransactionImpl.rollback(AbstractTransactionImpl.java:211) [hibernate-core-4.3.1.Final.jar:4.3.1.Final]
	... 29 more

-------------- next part --------------
A non-text attachment was scrubbed...
Name: persistence.xml
Type: text/xml
Size: 1613 bytes
Desc: not available
Url : http://lists.jboss.org/pipermail/keycloak-user/attachments/20140314/11107277/attachment-0001.xml 


More information about the keycloak-user mailing list