[keycloak-dev] Demo dist broken

Stan Silvert ssilvert at redhat.com
Wed Aug 17 12:22:49 EDT 2016


I did a clean build from head.  Unzipped demo dist and started up. Got this:

2016-08-17 12:16:08,126 INFO  [org.keycloak.services] (ServerService 
Thread Pool -- 67) KC-SERVICES0001: Loading config from 
c:\kctemp\keycloak-demo-2.2.0-SNAPSHOT\keycloak\standalone\configuration\keycloak-server.json
2016-08-17 12:16:08,717 INFO  [org.jboss.ws.common.management] (MSC 
service thread 1-1) JBWS022052: Starting JBossWS 5.1.3.Final (Apache CXF 
3.1.4)
2016-08-17 12:16:12,615 WARN 
[org.keycloak.connections.jpa.updater.liquibase.lock.LiquibaseDBLockProvider] 
(ServerService Thread Pool -- 67) Failed to rollback connection after 
error: java.sql.SQLException: IJ031021: You cannot rollback during a 
managed transaction
     at 
org.jboss.jca.adapters.jdbc.BaseWrapperManagedConnection.jdbcRollback(BaseWrapperManagedConnection.java:1122)
     at 
org.jboss.jca.adapters.jdbc.WrappedConnection.rollback(WrappedConnection.java:863)
     at 
org.keycloak.connections.jpa.updater.liquibase.lock.LiquibaseDBLockProvider.safeRollbackConnection(LiquibaseDBLockProvider.java:159)
     at 
org.keycloak.connections.jpa.updater.liquibase.lock.LiquibaseDBLockProvider.waitForLock(LiquibaseDBLockProvider.java:109)
     at 
org.keycloak.services.resources.KeycloakApplication$1.run(KeycloakApplication.java:104)
     at 
org.keycloak.models.utils.KeycloakModelUtils.runJobInTransaction(KeycloakModelUtils.java:287)
     at 
org.keycloak.services.resources.KeycloakApplication.<init>(KeycloakApplication.java:97)
     at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native 
Method)
     at 
sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
     at 
sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
     at java.lang.reflect.Constructor.newInstance(Constructor.java:422)
     at 
org.jboss.resteasy.core.ConstructorInjectorImpl.construct(ConstructorInjectorImpl.java:150)
     at 
org.jboss.resteasy.spi.ResteasyProviderFactory.createProviderInstance(ResteasyProviderFactory.java:2209)
     at 
org.jboss.resteasy.spi.ResteasyDeployment.createApplication(ResteasyDeployment.java:299)
     at 
org.jboss.resteasy.spi.ResteasyDeployment.start(ResteasyDeployment.java:240)
     at 
org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.init(ServletContainerDispatcher.java:113)
     at 
org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.init(HttpServletDispatcher.java:36)
     at 
io.undertow.servlet.core.LifecyleInterceptorInvocation.proceed(LifecyleInterceptorInvocation.java:117)
     at 
org.wildfly.extension.undertow.security.RunAsLifecycleInterceptor.init(RunAsLifecycleInterceptor.java:78)
     at 
io.undertow.servlet.core.LifecyleInterceptorInvocation.proceed(LifecyleInterceptorInvocation.java:103)
     at 
io.undertow.servlet.core.ManagedServlet$DefaultInstanceStrategy.start(ManagedServlet.java:231)
     at 
io.undertow.servlet.core.ManagedServlet.createServlet(ManagedServlet.java:132)
     at 
io.undertow.servlet.core.DeploymentManagerImpl.start(DeploymentManagerImpl.java:526)
     at 
org.wildfly.extension.undertow.deployment.UndertowDeploymentService.startContext(UndertowDeploymentService.java:101)
     at 
org.wildfly.extension.undertow.deployment.UndertowDeploymentService$1.run(UndertowDeploymentService.java:82)
     at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
     at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
     at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
     at java.lang.Thread.run(Thread.java:745)
     at org.jboss.threads.JBossThread.run(JBossThread.java:320)

2016-08-17 12:16:12,623 ERROR [org.jboss.as.txn] (ServerService Thread 
Pool -- 67) WFLYTX0003: APPLICATION ERROR: transaction still active in 
request with status 4
2016-08-17 12:16:12,624 WARN  [com.arjuna.ats.arjuna] (ServerService 
Thread Pool -- 67) ARJUNA012077: Abort called on already aborted atomic 
action 0:ffff0a0a3838:-30eee89c:57b48dc5:b
2016-08-17 12:16:12,625 ERROR [org.jboss.msc.service.fail] 
(ServerService Thread Pool -- 67) MSC000001: Failed to start service 
jboss.undertow.deployment.default-server.default-host./auth: 
org.jboss.msc.service.StartException in service 
jboss.undertow.deployment.default-server.default-host./auth: 
java.lang.RuntimeException: RESTEASY003325: Failed to construct public 
org.keycloak.services.resources.KeycloakApplication(javax.servlet.ServletContext,org.jboss.resteasy.core.Dispatcher)
     at 
org.wildfly.extension.undertow.deployment.UndertowDeploymentService$1.run(UndertowDeploymentService.java:85)
     at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
     at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
     at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
     at java.lang.Thread.run(Thread.java:745)
     at org.jboss.threads.JBossThread.run(JBossThread.java:320)
Caused by: java.lang.RuntimeException: RESTEASY003325: Failed to 
construct public 
org.keycloak.services.resources.KeycloakApplication(javax.servlet.ServletContext,org.jboss.resteasy.core.Dispatcher)
     at 
org.jboss.resteasy.core.ConstructorInjectorImpl.construct(ConstructorInjectorImpl.java:162)
     at 
org.jboss.resteasy.spi.ResteasyProviderFactory.createProviderInstance(ResteasyProviderFactory.java:2209)
     at 
org.jboss.resteasy.spi.ResteasyDeployment.createApplication(ResteasyDeployment.java:299)
     at 
org.jboss.resteasy.spi.ResteasyDeployment.start(ResteasyDeployment.java:240)
     at 
org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.init(ServletContainerDispatcher.java:113)
     at 
org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.init(HttpServletDispatcher.java:36)
     at 
io.undertow.servlet.core.LifecyleInterceptorInvocation.proceed(LifecyleInterceptorInvocation.java:117)
     at 
org.wildfly.extension.undertow.security.RunAsLifecycleInterceptor.init(RunAsLifecycleInterceptor.java:78)
     at 
io.undertow.servlet.core.LifecyleInterceptorInvocation.proceed(LifecyleInterceptorInvocation.java:103)
     at 
io.undertow.servlet.core.ManagedServlet$DefaultInstanceStrategy.start(ManagedServlet.java:231)
     at 
io.undertow.servlet.core.ManagedServlet.createServlet(ManagedServlet.java:132)
     at 
io.undertow.servlet.core.DeploymentManagerImpl.start(DeploymentManagerImpl.java:526)
     at 
org.wildfly.extension.undertow.deployment.UndertowDeploymentService.startContext(UndertowDeploymentService.java:101)
     at 
org.wildfly.extension.undertow.deployment.UndertowDeploymentService$1.run(UndertowDeploymentService.java:82)
     ... 6 more
Caused by: java.lang.IllegalStateException: Failed to retrieve lock
     at 
org.keycloak.connections.jpa.updater.liquibase.lock.CustomLockService.acquireLock(CustomLockService.java:157)
     at 
org.keycloak.connections.jpa.updater.liquibase.lock.CustomLockService.waitForLock(CustomLockService.java:123)
     at 
org.keycloak.connections.jpa.updater.liquibase.lock.LiquibaseDBLockProvider.waitForLock(LiquibaseDBLockProvider.java:99)
     at 
org.keycloak.services.resources.KeycloakApplication$1.run(KeycloakApplication.java:104)
     at 
org.keycloak.models.utils.KeycloakModelUtils.runJobInTransaction(KeycloakModelUtils.java:287)
     at 
org.keycloak.services.resources.KeycloakApplication.<init>(KeycloakApplication.java:97)
     at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native 
Method)
     at 
sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
     at 
sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
     at java.lang.reflect.Constructor.newInstance(Constructor.java:422)
     at 
org.jboss.resteasy.core.ConstructorInjectorImpl.construct(ConstructorInjectorImpl.java:150)
     ... 19 more
Caused by: liquibase.exception.DatabaseException: 
liquibase.exception.DatabaseException: java.sql.SQLException: IJ031021: 
You cannot rollback during a managed transaction
     at 
liquibase.database.AbstractJdbcDatabase.rollback(AbstractJdbcDatabase.java:1139)
     at 
org.keycloak.connections.jpa.updater.liquibase.lock.CustomLockService.acquireLock(CustomLockService.java:152)
     ... 29 more
Caused by: liquibase.exception.DatabaseException: java.sql.SQLException: 
IJ031021: You cannot rollback during a managed transaction
     at 
liquibase.database.jvm.JdbcConnection.rollback(JdbcConnection.java:340)
     at 
liquibase.database.AbstractJdbcDatabase.rollback(AbstractJdbcDatabase.java:1137)
     ... 30 more
Caused by: java.sql.SQLException: IJ031021: You cannot rollback during a 
managed transaction
     at 
org.jboss.jca.adapters.jdbc.BaseWrapperManagedConnection.jdbcRollback(BaseWrapperManagedConnection.java:1122)
     at 
org.jboss.jca.adapters.jdbc.WrappedConnection.rollback(WrappedConnection.java:863)
     at 
liquibase.database.jvm.JdbcConnection.rollback(JdbcConnection.java:337)
     ... 31 more

2016-08-17 12:16:12,635 ERROR 
[org.jboss.as.controller.management-operation] (Controller Boot Thread) 
WFLYCTL0013: Operation ("add") failed - address: ([("deployment" => 
"keycloak-server.war")]) - failure description: {"WFLYCTL0080: Failed 
services" => 
{"jboss.undertow.deployment.default-server.default-host./auth" => 
"org.jboss.msc.service.StartException in service 
jboss.undertow.deployment.default-server.default-host./auth: 
java.lang.RuntimeException: RESTEASY003325: Failed to construct public 
org.keycloak.services.resources.KeycloakApplication(javax.servlet.ServletContext,org.jboss.resteasy.core.Dispatcher)
     Caused by: java.lang.RuntimeException: RESTEASY003325: Failed to 
construct public 
org.keycloak.services.resources.KeycloakApplication(javax.servlet.ServletContext,org.jboss.resteasy.core.Dispatcher)
     Caused by: java.lang.IllegalStateException: Failed to retrieve lock
     Caused by: liquibase.exception.DatabaseException: 
liquibase.exception.DatabaseException: java.sql.SQLException: IJ031021: 
You cannot rollback during a managed transaction
     Caused by: liquibase.exception.DatabaseException: 
java.sql.SQLException: IJ031021: You cannot rollback during a managed 
transaction
     Caused by: java.sql.SQLException: IJ031021: You cannot rollback 
during a managed transaction"}}
2016-08-17 12:16:12,661 INFO  [org.jboss.as.server] (ServerService 
Thread Pool -- 61) WFLYSRV0010: Deployed "keycloak-server.war" 
(runtime-name : "keycloak-server.war")
2016-08-17 12:16:12,663 INFO  [org.jboss.as.controller] (Controller Boot 
Thread) WFLYCTL0183: Service status report
WFLYCTL0186:   Services which failed to start:      service 
jboss.undertow.deployment.default-server.default-host./auth: 
org.jboss.msc.service.StartException in service 
jboss.undertow.deployment.default-server.default-host./auth: 
java.lang.RuntimeException: RESTEASY003325: Failed to construct public 
org.keycloak.services.resources.KeycloakApplication(javax.servlet.ServletContext,org.jboss.resteasy.core.Dispatcher)

2016-08-17 12:16:12,745 INFO  [org.jboss.as] (Controller Boot Thread) 
WFLYSRV0060: Http management interface listening on 
http://127.0.0.1:9990/management
2016-08-17 12:16:12,746 INFO  [org.jboss.as] (Controller Boot Thread) 
WFLYSRV0051: Admin console listening on http://127.0.0.1:9990
2016-08-17 12:16:12,746 ERROR [org.jboss.as] (Controller Boot Thread) 
WFLYSRV0026: WildFly Full 10.0.0.Final (WildFly Core 2.0.10.Final) 
started (with errors) in 24670ms - Started 429 of 785 services (2 
services failed or missing dependencies, 513 services are lazy, passive 
or on-demand)
2016-08-17 12:19:32,948 INFO  [org.jboss.as.server] (Thread-2) 
WFLYSRV0220: Server shutdown has been requested.
2016-08-17 12:19:32,977 INFO 
[org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-1) 
WFLYJCA0010: Unbound data source [java:jboss/datasources/KeycloakDS]
2016-08-17 12:19:32,984 INFO  [org.wildfly.extension.undertow] (MSC 
service thread 1-3) WFLYUT0019: Host default-host stopping
2016-08-17 12:19:32,994 INFO 
[org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-8) 
WFLYJCA0010: Unbound data source [java:jboss/datasources/ExampleDS]
2016-08-17 12:19:32,999 INFO [org.jboss.as.connector.deployers.jdbc] 
(MSC service thread 1-8) WFLYJCA0019: Stopped Driver service with 
driver-name = h2
2016-08-17 12:19:33,005 INFO  [org.wildfly.extension.undertow] (MSC 
service thread 1-8) WFLYUT0008: Undertow HTTP listener default suspending
2016-08-17 12:19:33,006 INFO  [org.wildfly.extension.undertow] (MSC 
service thread 1-8) WFLYUT0007: Undertow HTTP listener default stopped, 
was bound to 127.0.0.1:8080
2016-08-17 12:19:33,007 INFO  [org.jboss.as.clustering.infinispan] 
(ServerService Thread Pool -- 76) WFLYCLINF0003: Stopped offlineSessions 
cache from keycloak container
2016-08-17 12:19:33,007 INFO  [org.jboss.as.clustering.infinispan] 
(ServerService Thread Pool -- 73) WFLYCLINF0003: Stopped sessions cache 
from keycloak container
2016-08-17 12:19:33,013 INFO  [org.jboss.as.clustering.infinispan] 
(ServerService Thread Pool -- 77) WFLYCLINF0003: Stopped authorization 
cache from keycloak container
2016-08-17 12:19:33,014 INFO  [org.jboss.as.clustering.infinispan] 
(ServerService Thread Pool -- 78) WFLYCLINF0003: Stopped realms cache 
from keycloak container
2016-08-17 12:19:33,015 INFO  [org.jboss.as.clustering.infinispan] 
(ServerService Thread Pool -- 74) WFLYCLINF0003: Stopped loginFailures 
cache from keycloak container
2016-08-17 12:19:33,016 INFO  [org.jboss.as.clustering.infinispan] 
(ServerService Thread Pool -- 79) WFLYCLINF0003: Stopped work cache from 
keycloak container
2016-08-17 12:19:33,016 INFO  [org.jboss.as.clustering.infinispan] 
(ServerService Thread Pool -- 75) WFLYCLINF0003: Stopped users cache 
from keycloak container
2016-08-17 12:19:33,024 INFO  [org.wildfly.extension.undertow] (MSC 
service thread 1-8) WFLYUT0004: Undertow 1.3.15.Final stopping
2016-08-17 12:19:33,029 INFO 
[org.hibernate.validator.internal.util.Version] (MSC service thread 1-2) 
HV000001: Hibernate Validator 5.2.3.Final
2016-08-17 12:19:33,083 INFO  [org.jboss.as.server.deployment] (MSC 
service thread 1-7) WFLYSRV0028: Stopped deployment keycloak-server.war 
(runtime-name: keycloak-server.war) in 126ms
2016-08-17 12:19:33,086 INFO  [org.jboss.as] (MSC service thread 1-6) 
WFLYSRV0050: WildFly Full 10.0.0.Final (WildFly Core 2.0.10.Final) 
stopped in 115ms



More information about the keycloak-dev mailing list