search

keycloak / keycloak

Open Source Identity and Access Management For Modern Applications and Services
https://www.keycloak.org
Apache License 2.0
23.07k stars 6.72k forks source link

OfflineServletsAdapterTest failure in the test pipeline #10634

Closed mabartos closed 1 year ago

mabartos commented 2 years ago

Describe the bug

Windows EAP adapters matrix / adapter_eap_win_tests / win2016 / eap_legacy-tls / win_oralcejdk8 / org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest.testServlet

https://keycloak-jenkins.com/job/universal-test-pipeline-adapters/906/testReport/org.keycloak.testsuite.adapter.servlet/OfflineServletsAdapterTest/

Stacktrace

javax.ws.rs.NotAuthorizedException: HTTP 401 Unauthorized
    at org.jboss.resteasy.client.jaxrs.internal.ClientInvocation.handleErrorStatus(ClientInvocation.java:243)
    at org.jboss.resteasy.client.jaxrs.internal.proxy.extractors.DefaultEntityExtractorFactory$3.extractEntity(DefaultEntityExtractorFactory.java:50)
    at org.jboss.resteasy.client.jaxrs.internal.proxy.ClientInvoker.invokeSync(ClientInvoker.java:154)
    at org.jboss.resteasy.client.jaxrs.internal.proxy.ClientInvoker.invoke(ClientInvoker.java:115)
    at org.jboss.resteasy.client.jaxrs.internal.proxy.ClientProxy.invoke(ClientProxy.java:76)
    at com.sun.proxy.$Proxy110.remove(Unknown Source)
    at org.keycloak.testsuite.AbstractKeycloakTest.removeRealm(AbstractKeycloakTest.java:496)
    at org.keycloak.testsuite.AbstractKeycloakTest.afterAbstractKeycloakTest(AbstractKeycloakTest.java:207)
    at sun.reflect.GeneratedMethodAccessor505.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:59)
    at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
    at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:56)
    at org.junit.internal.runners.statements.RunAfters.invokeMethod(RunAfters.java:46)
    at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:33)
    at org.jboss.arquillian.junit.Arquillian$StatementLifecycleExecutor.invoke(Arquillian.java:378)
    at org.jboss.arquillian.container.test.impl.execution.ClientBeforeAfterLifecycleEventExecuter.execute(ClientBeforeAfterLifecycleEventExecuter.java:88)
    at org.jboss.arquillian.container.test.impl.execution.ClientBeforeAfterLifecycleEventExecuter.on(ClientBeforeAfterLifecycleEventExecuter.java:72)
    at sun.reflect.GeneratedMethodAccessor268.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at org.jboss.arquillian.core.impl.ObserverImpl.invoke(ObserverImpl.java:86)
    at org.jboss.arquillian.core.impl.EventContextImpl.invokeObservers(EventContextImpl.java:103)
    at org.jboss.arquillian.core.impl.EventContextImpl.proceed(EventContextImpl.java:90)
    at org.jboss.arquillian.container.test.impl.client.ContainerEventController.createContext(ContainerEventController.java:128)
    at org.jboss.arquillian.container.test.impl.client.ContainerEventController.createAfterContext(ContainerEventController.java:122)
    at sun.reflect.GeneratedMethodAccessor267.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at org.jboss.arquillian.core.impl.ObserverImpl.invoke(ObserverImpl.java:86)
    at org.jboss.arquillian.core.impl.EventContextImpl.proceed(EventContextImpl.java:95)
    at org.jboss.arquillian.junit.extension.UpdateTestResultBeforeAfter.update(UpdateTestResultBeforeAfter.java:46)
    at sun.reflect.GeneratedMethodAccessor266.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at org.jboss.arquillian.core.impl.ObserverImpl.invoke(ObserverImpl.java:86)
    at org.jboss.arquillian.core.impl.EventContextImpl.proceed(EventContextImpl.java:95)
    at org.jboss.arquillian.test.impl.TestContextHandler.createSuiteContext(TestContextHandler.java:69)
    at sun.reflect.GeneratedMethodAccessor53.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at org.jboss.arquillian.core.impl.ObserverImpl.invoke(ObserverImpl.java:86)
    at org.jboss.arquillian.core.impl.EventContextImpl.proceed(EventContextImpl.java:95)
    at org.jboss.arquillian.test.impl.TestContextHandler.createClassContext(TestContextHandler.java:83)
    at sun.reflect.GeneratedMethodAccessor76.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at org.jboss.arquillian.core.impl.ObserverImpl.invoke(ObserverImpl.java:86)
    at org.jboss.arquillian.core.impl.EventContextImpl.proceed(EventContextImpl.java:95)
    at org.jboss.arquillian.test.impl.TestContextHandler.createTestContext(TestContextHandler.java:116)
    at sun.reflect.GeneratedMethodAccessor86.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at org.jboss.arquillian.core.impl.ObserverImpl.invoke(ObserverImpl.java:86)
    at org.jboss.arquillian.core.impl.EventContextImpl.proceed(EventContextImpl.java:95)
    at org.jboss.arquillian.core.impl.ManagerImpl.fire(ManagerImpl.java:133)
    at org.jboss.arquillian.core.impl.ManagerImpl.fire(ManagerImpl.java:105)
    at org.jboss.arquillian.test.impl.EventTestRunnerAdaptor.after(EventTestRunnerAdaptor.java:127)
    at org.jboss.arquillian.junit.Arquillian$5$1.evaluate(Arquillian.java:221)
    at org.jboss.arquillian.junit.Arquillian.multiExecute(Arquillian.java:350)
    at org.jboss.arquillian.junit.Arquillian.access$200(Arquillian.java:54)
    at org.jboss.arquillian.junit.Arquillian$5.evaluate(Arquillian.java:215)
    at org.keycloak.testsuite.AssertEvents$1.evaluate(AssertEvents.java:72)
    at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:54)
    at org.jboss.arquillian.junit.Arquillian$7$1.invoke(Arquillian.java:279)
    at org.jboss.arquillian.container.test.impl.execution.ClientBeforeAfterLifecycleEventExecuter.execute(ClientBeforeAfterLifecycleEventExecuter.java:88)
    at org.jboss.arquillian.container.test.impl.execution.ClientBeforeAfterLifecycleEventExecuter.on(ClientBeforeAfterLifecycleEventExecuter.java:66)
    at sun.reflect.GeneratedMethodAccessor175.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at org.jboss.arquillian.core.impl.ObserverImpl.invoke(ObserverImpl.java:86)
    at org.jboss.arquillian.core.impl.EventContextImpl.invokeObservers(EventContextImpl.java:103)
    at org.jboss.arquillian.core.impl.EventContextImpl.proceed(EventContextImpl.java:90)
    at org.jboss.arquillian.container.test.impl.client.ContainerEventController.createContext(ContainerEventController.java:128)
    at org.jboss.arquillian.container.test.impl.client.ContainerEventController.createBeforeContext(ContainerEventController.java:114)
    at sun.reflect.GeneratedMethodAccessor173.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at org.jboss.arquillian.core.impl.ObserverImpl.invoke(ObserverImpl.java:86)
    at org.jboss.arquillian.core.impl.EventContextImpl.proceed(EventContextImpl.java:95)
    at org.jboss.arquillian.test.impl.TestContextHandler.createSuiteContext(TestContextHandler.java:69)
    at sun.reflect.GeneratedMethodAccessor53.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at org.jboss.arquillian.core.impl.ObserverImpl.invoke(ObserverImpl.java:86)
    at org.jboss.arquillian.core.impl.EventContextImpl.proceed(EventContextImpl.java:95)
    at org.jboss.arquillian.test.impl.TestContextHandler.createClassContext(TestContextHandler.java:83)
    at sun.reflect.GeneratedMethodAccessor76.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at org.jboss.arquillian.core.impl.ObserverImpl.invoke(ObserverImpl.java:86)
    at org.jboss.arquillian.core.impl.EventContextImpl.proceed(EventContextImpl.java:95)
    at org.jboss.arquillian.test.impl.TestContextHandler.createTestContext(TestContextHandler.java:116)
    at sun.reflect.GeneratedMethodAccessor86.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at org.jboss.arquillian.core.impl.ObserverImpl.invoke(ObserverImpl.java:86)
    at org.jboss.arquillian.core.impl.EventContextImpl.proceed(EventContextImpl.java:95)
    at org.jboss.arquillian.core.impl.ManagerImpl.fire(ManagerImpl.java:133)
    at org.jboss.arquillian.core.impl.ManagerImpl.fire(ManagerImpl.java:105)
    at org.jboss.arquillian.test.impl.EventTestRunnerAdaptor.fireCustomLifecycle(EventTestRunnerAdaptor.java:159)
    at org.jboss.arquillian.junit.Arquillian$7.evaluate(Arquillian.java:273)
    at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
    at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
    at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
    at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
    at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
    at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
    at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
    at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
    at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
    at org.jboss.arquillian.junit.Arquillian$2.evaluate(Arquillian.java:166)
    at org.jboss.arquillian.junit.Arquillian.multiExecute(Arquillian.java:350)
    at org.jboss.arquillian.junit.Arquillian.access$200(Arquillian.java:54)
    at org.jboss.arquillian.junit.Arquillian$3.evaluate(Arquillian.java:177)
    at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
    at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
    at org.jboss.arquillian.junit.Arquillian.run(Arquillian.java:115)
    at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:364)
    at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:272)
    at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:237)
    at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:158)
    at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:428)
    at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:162)
    at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:562)
    at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:548)

Standard Output

00:23:32,453 INFO  [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] [OfflineServletsAdapterTest] testServletWithConsent() FINISHED

00:23:32,453 INFO  [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] [OfflineServletsAdapterTest] testServlet() STARTED
00:23:32,911 INFO  [org.keycloak.testsuite.model.infinispan.InfinispanTestUtil] (default task-19) Will set KeycloakIspnTimeService to the infinispan cacheManager
00:23:33,362 DEBUG [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] loading test realms
Loaded realm test
00:23:33,363 INFO  [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] Setting redirect-uris in test realm 'test' as non-relative
00:23:33,363 INFO  [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] importing test realms
00:23:33,364 DEBUG [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] --importing realm: test
00:23:34,233 INFO  [org.keycloak.testsuite.util.URLUtils] starting navigation
00:23:34,233 INFO  [org.keycloak.testsuite.util.URLUtils] current URL:  https://auth-server-127-0-0-1.nip.io:8543/auth/realms/test/protocol/openid-connect/auth?response_type=code&client_id=offline-client&redirect_uri=https%3A%2F%2F127.0.0.1.sslip.io%3A8643%2Foffline-client&state=f88f74d7-fcb4-4260-af02-7da805b14d1d&login=true&scope=openid
00:23:34,233 INFO  [org.keycloak.testsuite.util.URLUtils] navigating to https://auth-server-127-0-0-1.nip.io:8543/auth/realms/test/super-random-page
00:23:34,265 INFO  [org.keycloak.testsuite.util.URLUtils] new current URL:  https://auth-server-127-0-0-1.nip.io:8543/auth/realms/test/super-random-page
00:23:34,265 INFO  [org.keycloak.testsuite.util.URLUtils] navigation complete
00:23:34,265 INFO  [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] deleting cookies in 'test' realm
00:23:34,275 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/?scope=offline_access
00:23:34,276 DEBUG [org.keycloak.adapters.undertow.ServletSessionTokenStore] (default task-1) Account was not in session, returning null
00:23:34,276 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) there was no code
00:23:34,276 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) redirecting to auth server
00:23:34,276 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) callback uri: https://127.0.0.1.sslip.io:8643/offline-client/?scope=offline_access
00:23:34,277 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) Sending redirect to login page: https://auth-server-127-0-0-1.nip.io:8543/auth/realms/test/protocol/openid-connect/auth?response_type=code&client_id=offline-client&redirect_uri=https%3A%2F%2F127.0.0.1.sslip.io%3A8643%2Foffline-client%2F&state=2b328726-dfd5-45be-8575-ba31b0e1e43f&login=true&scope=openid+offline_access
00:23:34,419 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/?state=2b328726-dfd5-45be-8575-ba31b0e1e43f&session_state=f9f8d04f-8e06-4f60-9ca7-c7c0bbd898bc&code=02f9afaa-190d-4290-a0cc-17eb2a066e4b.f9f8d04f-8e06-4f60-9ca7-c7c0bbd898bc.eec288b1-fc44-40b8-a1cc-95fdcac9e107
00:23:34,420 DEBUG [org.keycloak.adapters.undertow.ServletSessionTokenStore] (default task-1) Account was not in session, returning null
00:23:34,420 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) there was a code, resolving
00:23:34,420 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) checking state cookie for after code
00:23:34,420 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) ** reseting application state cookie
00:23:34,433 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) Verifying tokens
00:23:34,435 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) Token Verification succeeded!
00:23:34,435 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) successful authenticated
00:23:34,435 DEBUG [org.keycloak.adapters.wildfly.WildflyRequestAuthenticator] (default task-1) propagate security context to wildfly
00:23:34,435 DEBUG [org.keycloak.adapters.RequestAuthenticator] (default task-1) User '65892368-ef0c-4630-b204-64025fbb7203' invoking '[https://127.0.0.1.sslip.io:8643/offline-client/?state=2b328726-dfd5-45be-8575-ba31b0e1e43f&session_state=f9f8d04f-8e06-4f60-9ca7-c7c0bbd898bc&code=02f9afaa-190d-4290-a0cc-17eb2a066e4b.f9f8d04f-8e06-4f60-9ca7-c7c0bbd898bc.eec288b1-fc44-40b8-a1cc-95fdcac9e107'](https://127.0.0.1.sslip.io:8643/offline-client/?state=2b328726-dfd5-45be-8575-ba31b0e1e43f&session_state=f9f8d04f-8e06-4f60-9ca7-c7c0bbd898bc&code=02f9afaa-190d-4290-a0cc-17eb2a066e4b.f9f8d04f-8e06-4f60-9ca7-c7c0bbd898bc.eec288b1-fc44-40b8-a1cc-95fdcac9e107%27) on client 'offline-client'
00:23:34,436 DEBUG [org.keycloak.adapters.RequestAuthenticator] (default task-1) AUTHENTICATED
00:23:34,437 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,438 DEBUG [org.keycloak.adapters.undertow.KeycloakUndertowAccount] (default task-1) session is active
00:23:34,438 DEBUG [org.keycloak.adapters.undertow.ServletSessionTokenStore] (default task-1) Cached account found
00:23:34,438 DEBUG [org.keycloak.adapters.wildfly.WildflyRequestAuthenticator] (default task-1) propagate security context to wildfly
00:23:34,438 DEBUG [org.keycloak.adapters.RequestAuthenticator] (default task-1) AUTHENTICATED: was cached
00:23:34,439 DEBUG [org.keycloak.adapters.AuthenticatedActionsHandler] (default task-1) AuthenticatedActionsValve.invoke https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,439 DEBUG [org.keycloak.adapters.AuthenticatedActionsHandler] (default task-1) Policy enforcement is disabled.
00:23:34,469 DEBUG [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] Set time offset, response {currentTime=1646536213, offset=9999}
00:23:34,472 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/?timeOffset=9999
00:23:34,472 DEBUG [org.keycloak.adapters.undertow.KeycloakUndertowAccount] (default task-1) session is active
00:23:34,472 DEBUG [org.keycloak.adapters.undertow.ServletSessionTokenStore] (default task-1) Cached account found
00:23:34,472 DEBUG [org.keycloak.adapters.wildfly.WildflyRequestAuthenticator] (default task-1) propagate security context to wildfly
00:23:34,472 DEBUG [org.keycloak.adapters.RequestAuthenticator] (default task-1) AUTHENTICATED: was cached
00:23:34,472 DEBUG [org.keycloak.adapters.AuthenticatedActionsHandler] (default task-1) AuthenticatedActionsValve.invoke https://127.0.0.1.sslip.io:8643/offline-client/?timeOffset=9999
00:23:34,472 DEBUG [org.keycloak.adapters.AuthenticatedActionsHandler] (default task-1) Policy enforcement is disabled.
00:23:34,472 INFO  [org.keycloak.testsuite.adapter.filter.AdapterActionsFilter] (default task-1) Time offset updated to 9999 for application /offline-client/
00:23:34,478 INFO  [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] <?xml version="1.0" encoding="ISO-8859-1"?>
<html>
  <head/>
  <body>
    Offset set successfully

  </body>
</html>

00:23:34,478 INFO  [org.keycloak.testsuite.util.URLUtils] starting navigation
00:23:34,478 INFO  [org.keycloak.testsuite.util.URLUtils] current URL:  https://127.0.0.1.sslip.io:8643/offline-client/?timeOffset=9999
00:23:34,478 INFO  [org.keycloak.testsuite.util.URLUtils] navigating to https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,480 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,481 DEBUG [org.keycloak.adapters.undertow.KeycloakUndertowAccount] (default task-1) session is not active or refresh is enforced. Try refresh
00:23:34,494 DEBUG [org.keycloak.adapters.RefreshableKeycloakSecurityContext] (default task-1) Token Verification succeeded!
00:23:34,494 DEBUG [org.keycloak.adapters.undertow.KeycloakUndertowAccount] (default task-1) refresh succeeded
00:23:34,494 DEBUG [org.keycloak.adapters.undertow.ServletSessionTokenStore] (default task-1) Cached account found
00:23:34,495 DEBUG [org.keycloak.adapters.wildfly.WildflyRequestAuthenticator] (default task-1) propagate security context to wildfly
00:23:34,495 DEBUG [org.keycloak.adapters.RequestAuthenticator] (default task-1) AUTHENTICATED: was cached
00:23:34,495 DEBUG [org.keycloak.adapters.AuthenticatedActionsHandler] (default task-1) AuthenticatedActionsValve.invoke https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,495 DEBUG [org.keycloak.adapters.AuthenticatedActionsHandler] (default task-1) Policy enforcement is disabled.
00:23:34,503 INFO  [org.keycloak.testsuite.util.URLUtils] new current URL:  https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,503 INFO  [org.keycloak.testsuite.util.URLUtils] navigation complete
00:23:34,579 INFO  [org.keycloak.testsuite.util.URLUtils] starting navigation
00:23:34,579 INFO  [org.keycloak.testsuite.util.URLUtils] current URL:  https://auth-server-127-0-0-1.nip.io:8543/auth/realms/test/protocol/openid-connect/auth?response_type=code&client_id=offline-client&redirect_uri=https%3A%2F%2F127.0.0.1.sslip.io%3A8643%2Foffline-client%2F&state=8bcfa9f8-866c-41ac-8b79-4d6ba1ffdb34&scope=openid
00:23:34,579 INFO  [org.keycloak.testsuite.util.URLUtils] navigating to https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,582 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,583 DEBUG [org.keycloak.adapters.undertow.KeycloakUndertowAccount] (default task-1) session is active
00:23:34,583 DEBUG [org.keycloak.adapters.undertow.ServletSessionTokenStore] (default task-1) Cached account found
00:23:34,583 DEBUG [org.keycloak.adapters.wildfly.WildflyRequestAuthenticator] (default task-1) propagate security context to wildfly
00:23:34,583 DEBUG [org.keycloak.adapters.RequestAuthenticator] (default task-1) AUTHENTICATED: was cached
00:23:34,584 DEBUG [org.keycloak.adapters.AuthenticatedActionsHandler] (default task-1) AuthenticatedActionsValve.invoke https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,584 DEBUG [org.keycloak.adapters.AuthenticatedActionsHandler] (default task-1) Policy enforcement is disabled.
00:23:34,593 INFO  [org.keycloak.testsuite.util.URLUtils] new current URL:  https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,593 INFO  [org.keycloak.testsuite.util.URLUtils] navigation complete
00:23:34,717 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/logout/k_logout
00:23:34,718 DEBUG [org.keycloak.adapters.undertow.UndertowUserSessionManagement] (default task-1) logoutHttpSessions: [9E0zIpSI3cuIq2gMxwpaWyJWbWmGto4YSyqXhiK1]
00:23:34,718 DEBUG [org.keycloak.adapters.undertow.UndertowUserSessionManagement] (default task-1) logoutHttpSession: 9E0zIpSI3cuIq2gMxwpaWyJWbWmGto4YSyqXhiK1
00:23:34,721 INFO  [org.keycloak.testsuite.util.URLUtils] starting navigation
00:23:34,721 INFO  [org.keycloak.testsuite.util.URLUtils] current URL:  https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,721 INFO  [org.keycloak.testsuite.util.URLUtils] navigating to https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,721 INFO  [org.keycloak.testsuite.util.URLUtils] target URL equals current URL - refreshing the page
00:23:34,723 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,723 DEBUG [org.keycloak.adapters.undertow.ServletSessionTokenStore] (default task-1) session was null, returning null
00:23:34,723 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) there was no code
00:23:34,723 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) redirecting to auth server
00:23:34,723 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) callback uri: https://127.0.0.1.sslip.io:8643/offline-client/
00:23:34,724 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) Sending redirect to login page: https://auth-server-127-0-0-1.nip.io:8543/auth/realms/test/protocol/openid-connect/auth?response_type=code&client_id=offline-client&redirect_uri=https%3A%2F%2F127.0.0.1.sslip.io%3A8643%2Foffline-client%2F&state=14e64330-1581-4363-91a1-4102a284ac4f&login=true&scope=openid
00:23:34,733 INFO  [org.keycloak.testsuite.util.URLUtils] new current URL:  https://auth-server-127-0-0-1.nip.io:8543/auth/realms/test/protocol/openid-connect/auth?response_type=code&client_id=offline-client&redirect_uri=https%3A%2F%2F127.0.0.1.sslip.io%3A8643%2Foffline-client%2F&state=14e64330-1581-4363-91a1-4102a284ac4f&login=true&scope=openid
00:23:34,733 INFO  [org.keycloak.testsuite.util.URLUtils] navigation complete
00:23:34,746 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/?timeOffset=0
00:23:34,746 DEBUG [org.keycloak.adapters.undertow.ServletSessionTokenStore] (default task-1) Account was not in session, returning null
00:23:34,746 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) there was no code
00:23:34,746 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) redirecting to auth server
00:23:34,747 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) callback uri: https://127.0.0.1.sslip.io:8643/offline-client/?timeOffset=0
00:23:34,747 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) Sending redirect to login page: https://auth-server-127-0-0-1.nip.io:8543/auth/realms/test/protocol/openid-connect/auth?response_type=code&client_id=offline-client&redirect_uri=https%3A%2F%2F127.0.0.1.sslip.io%3A8643%2Foffline-client%2F?timeOffset%3D0&state=9fb26cff-35e0-42f9-8376-0c581172096f&login=true&scope=openid
00:23:34,756 INFO  [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] <?xml version="1.0" encoding="UTF-8"?>
<html class="login-pf">
  <head>
    <meta charset="utf-8"/>
    <meta http-equiv="Content-Type" content="text/html; charset=UTF-8"/>
    <meta name="robots" content="noindex, nofollow"/>
    <meta name="viewport" content="width=device-width,initial-scale=1"/>
    <title>
      Sign in to test
    </title>
    <link rel="icon" href="/auth/resources/76vj9/login/keycloak/img/favicon.ico"/>
    <link href="/auth/resources/76vj9/common/keycloak/web_modules/@patternfly/react-core/dist/styles/base.css" rel="stylesheet"/>
    <link href="/auth/resources/76vj9/common/keycloak/web_modules/@patternfly/react-core/dist/styles/app.css" rel="stylesheet"/>
    <link href="/auth/resources/76vj9/common/keycloak/node_modules/patternfly/dist/css/patternfly.min.css" rel="stylesheet"/>
    <link href="/auth/resources/76vj9/common/keycloak/node_modules/patternfly/dist/css/patternfly-additions.min.css" rel="stylesheet"/>
    <link href="/auth/resources/76vj9/common/keycloak/lib/pficon/pficon.css" rel="stylesheet"/>
    <link href="/auth/resources/76vj9/login/keycloak/css/login.css" rel="stylesheet"/>
    <link href="/auth/resources/76vj9/login/keycloak/css/tile.css" rel="stylesheet"/>
  </head>
  <body class="">
    <div class="login-pf-page">
      <div id="kc-header" class="login-pf-page-header">
        <div id="kc-header-wrapper" class="">
          test
        </div>
      </div>
      <div class="card-pf">
        <header class="login-pf-header">
          <div class="pf-c-dropdown" id="kc-locale">
            <div id="kc-locale-wrapper" class="">
              <div id="kc-locale-dropdown" class="">
                <a href="#" id="kc-current-locale-link">
                  English
                </a>
                <ul class="pf-c-dropdown__menu pf-m-align-right">
                  <li class="">
                    <a class="pf-c-dropdown__menu-item" href="/auth/realms/test/login-actions/authenticate?client_id=offline-client&amp;tab_id=_cJHI4FNlp8&amp;execution=269a1e29-5eec-42ba-bf5d-3933253ce555&amp;kc_locale=de">
                      Deutsch
                    </a>
                  </li>
                  <li class="">
                    <a class="pf-c-dropdown__menu-item" href="/auth/realms/test/login-actions/authenticate?client_id=offline-client&amp;tab_id=_cJHI4FNlp8&amp;execution=269a1e29-5eec-42ba-bf5d-3933253ce555&amp;kc_locale=en">
                      English
                    </a>
                  </li>
                </ul>
              </div>
            </div>
          </div>
          <h1 id="kc-page-title">
                    Sign in to your account

          </h1>
        </header>
        <div id="kc-content">
          <div id="kc-content-wrapper">
            <div id="kc-form">
              <div id="kc-form-wrapper">
                <form id="kc-form-login" onsubmit="login.disabled = true; return true;" action="[https://auth-server-127-0-0-1.nip.io:8543/auth/realms/test/login-actions/authenticate?session_code=DD8iO0EyH8vWf90wywGHFQF8eY_rhWl11Z8sTmEZzWk&amp;execution=269a1e29-5eec-42ba-bf5d-3933253ce555&amp;client_id=offline-client&amp;tab_id=_cJHI4FNlp8"](https://auth-server-127-0-0-1.nip.io:8543/auth/realms/test/login-actions/authenticate?session_code=DD8iO0EyH8vWf90wywGHFQF8eY_rhWl11Z8sTmEZzWk&amp;execution=269a1e29-5eec-42ba-bf5d-3933253ce555&amp;client_id=offline-client&amp;tab_id=_cJHI4FNlp8) method="post">
                  <div class="form-group">
                    <label for="username" class="pf-c-form__label pf-c-form__label-text">
                      Username or email
                    </label>
                    <input tabindex="1" id="username" class="pf-c-form-control" name="username" value="" type="text" autofocus="" autocomplete="off" aria-invalid=""/>
                  </div>
                  <div class="form-group">
                    <label for="password" class="pf-c-form__label pf-c-form__label-text">
                      Password
                    </label>
                    <input tabindex="2" id="password" class="pf-c-form-control" name="password" type="password" autocomplete="off" aria-invalid=""/>
                  </div>
                  <div class="form-group login-pf-settings">
                    <div id="kc-form-options">
                    </div>
                    <div class="">
                      <span>
                        <a tabindex="5" href="/auth/realms/test/login-actions/reset-credentials?client_id=offline-client&amp;tab_id=_cJHI4FNlp8">
                          Forgot Password?
                        </a>
                      </span>
                    </div>
                  </div>
                  <div id="kc-form-buttons" class="form-group">
                    <input type="hidden" id="id-hidden-input" name="credentialId"/>
                    <input tabindex="4" class="pf-c-button pf-m-primary pf-m-block btn-lg" name="login" id="kc-login" type="submit" value="Sign In"/>
                  </div>
                </form>
              </div>
            </div>
            <div id="kc-info" class="login-pf-signup">
              <div id="kc-info-wrapper" class="">
                <div id="kc-registration-container">
                  <div id="kc-registration">
                    <span>
                      New user? 
                      <a tabindex="6" href="/auth/realms/test/login-actions/registration?client_id=offline-client&amp;tab_id=_cJHI4FNlp8">
                        Register
                      </a>
                    </span>
                  </div>
                </div>
              </div>
            </div>
          </div>
        </div>
      </div>
    </div>
  </body>
</html>

00:23:34,873 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/?timeOffset=0&state=9fb26cff-35e0-42f9-8376-0c581172096f&session_state=964f9478-fdfb-49d7-a90d-159d845ca479&code=4f62ffaa-0152-4a5e-8736-ddf8ff69402c.964f9478-fdfb-49d7-a90d-159d845ca479.eec288b1-fc44-40b8-a1cc-95fdcac9e107
00:23:34,874 DEBUG [org.keycloak.adapters.undertow.ServletSessionTokenStore] (default task-1) Account was not in session, returning null
00:23:34,874 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) there was a code, resolving
00:23:34,874 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) checking state cookie for after code
00:23:34,874 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) ** reseting application state cookie
00:23:34,883 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) Verifying tokens
00:23:34,888 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) Token Verification succeeded!
00:23:34,888 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) successful authenticated
00:23:34,888 DEBUG [org.keycloak.adapters.wildfly.WildflyRequestAuthenticator] (default task-1) propagate security context to wildfly
00:23:34,889 DEBUG [org.keycloak.adapters.RequestAuthenticator] (default task-1) User '65892368-ef0c-4630-b204-64025fbb7203' invoking '[https://127.0.0.1.sslip.io:8643/offline-client/?timeOffset=0&state=9fb26cff-35e0-42f9-8376-0c581172096f&session_state=964f9478-fdfb-49d7-a90d-159d845ca479&code=4f62ffaa-0152-4a5e-8736-ddf8ff69402c.964f9478-fdfb-49d7-a90d-159d845ca479.eec288b1-fc44-40b8-a1cc-95fdcac9e107'](https://127.0.0.1.sslip.io:8643/offline-client/?timeOffset=0&state=9fb26cff-35e0-42f9-8376-0c581172096f&session_state=964f9478-fdfb-49d7-a90d-159d845ca479&code=4f62ffaa-0152-4a5e-8736-ddf8ff69402c.964f9478-fdfb-49d7-a90d-159d845ca479.eec288b1-fc44-40b8-a1cc-95fdcac9e107%27) on client 'offline-client'
00:23:34,889 DEBUG [org.keycloak.adapters.RequestAuthenticator] (default task-1) AUTHENTICATED
00:23:34,889 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/?timeOffset=0
00:23:34,890 DEBUG [org.keycloak.adapters.undertow.KeycloakUndertowAccount] (default task-1) session is active
00:23:34,890 DEBUG [org.keycloak.adapters.undertow.ServletSessionTokenStore] (default task-1) Cached account found
00:23:34,890 DEBUG [org.keycloak.adapters.wildfly.WildflyRequestAuthenticator] (default task-1) propagate security context to wildfly
00:23:34,890 DEBUG [org.keycloak.adapters.RequestAuthenticator] (default task-1) AUTHENTICATED: was cached
00:23:34,890 DEBUG [org.keycloak.adapters.AuthenticatedActionsHandler] (default task-1) AuthenticatedActionsValve.invoke https://127.0.0.1.sslip.io:8643/offline-client/?timeOffset=0
00:23:34,890 DEBUG [org.keycloak.adapters.AuthenticatedActionsHandler] (default task-1) Policy enforcement is disabled.
00:23:34,890 INFO  [org.keycloak.testsuite.adapter.filter.AdapterActionsFilter] (default task-1) Time offset updated to 0 for application /offline-client/
00:23:34,896 INFO  [org.keycloak.testsuite.adapter.page.OfflineToken] Logging out, navigating to: https://127.0.0.1.sslip.io:8643/offline-client/logout
00:23:34,897 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/logout
00:23:34,898 DEBUG [org.keycloak.adapters.undertow.KeycloakUndertowAccount] (default task-1) session is active
00:23:34,898 DEBUG [org.keycloak.adapters.undertow.ServletSessionTokenStore] (default task-1) Cached account found
00:23:34,898 DEBUG [org.keycloak.adapters.wildfly.WildflyRequestAuthenticator] (default task-1) propagate security context to wildfly
00:23:34,898 DEBUG [org.keycloak.adapters.RequestAuthenticator] (default task-1) AUTHENTICATED: was cached
00:23:34,898 DEBUG [org.keycloak.adapters.AuthenticatedActionsHandler] (default task-1) AuthenticatedActionsValve.invoke https://127.0.0.1.sslip.io:8643/offline-client/logout
00:23:34,898 DEBUG [org.keycloak.adapters.AuthenticatedActionsHandler] (default task-1) Policy enforcement is disabled.
00:23:34,913 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client/logout/k_logout
00:23:34,914 DEBUG [org.keycloak.adapters.undertow.UndertowUserSessionManagement] (default task-1) logoutHttpSessions: [aTvR4yt-Mp4ZmuDkXOuNal-r-EaXHn8DOJCWxIVh]
00:23:34,914 DEBUG [org.keycloak.adapters.undertow.UndertowUserSessionManagement] (default task-1) logoutHttpSession: aTvR4yt-Mp4ZmuDkXOuNal-r-EaXHn8DOJCWxIVh
00:23:34,919 DEBUG [org.keycloak.adapters.PreAuthActionsHandler] (default task-1) adminRequest https://127.0.0.1.sslip.io:8643/offline-client
00:23:34,920 DEBUG [org.keycloak.adapters.undertow.ServletSessionTokenStore] (default task-1) session was null, returning null
00:23:34,920 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) there was no code
00:23:34,920 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) redirecting to auth server
00:23:34,920 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) callback uri: https://127.0.0.1.sslip.io:8643/offline-client
00:23:34,921 DEBUG [org.keycloak.adapters.OAuthRequestAuthenticator] (default task-1) Sending redirect to login page: https://auth-server-127-0-0-1.nip.io:8543/auth/realms/test/protocol/openid-connect/auth?response_type=code&client_id=offline-client&redirect_uri=https%3A%2F%2F127.0.0.1.sslip.io%3A8643%2Foffline-client&state=6618d621-21d0-4d66-a8cb-e6e6df408b68&login=true&scope=openid
00:23:34,930 INFO  [org.keycloak.testsuite.util.WaitUtils] Wait: 300ms
00:23:35,239 DEBUG [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] Set time offset, response {currentTime=1646526215, offset=0}
00:23:35,240 INFO  [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] removing test realms after test method
00:23:35,240 INFO  [org.keycloak.testsuite.adapter.servlet.OfflineServletsAdapterTest] removing realm: test
00:23:35,279 INFO  [org.keycloak.connections.infinispan.InfinispanUtil] (default task-19) Revert set KeycloakIspnTimeService to the infinispan cacheManager

Version

17.0.0-SNAPSHOT

mposolda commented 1 year ago

@mabartos Is this a blocker for Keycloak 22 or can we add to Backlog? AFAIK we should set milestone 22 or Backlog. IMO Backlog is completely fine :-)

mabartos commented 1 year ago

Not relevant anymore.