Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

OIDC scenarion with authorization using @ClientHeaderParam doesn't work after move to reactive #27959

Closed
rsvoboda opened this issue Sep 15, 2022 · 12 comments · Fixed by #27961
Closed

OIDC scenarion with authorization using @ClientHeaderParam doesn't work after move to reactive #27959

rsvoboda opened this issue Sep 15, 2022 · 12 comments · Fixed by #27961
Assignees
@geoand
Labels
area/oidc kind/bug Something isn't working
Milestone
2.13.0.Final

Comments

@rsvoboda
Copy link
Member

Describe the bug

I'm trying to migrate testing scenarios we have for quarkus-oidc-client-filter / quarkus-oidc-token-propagation / quarkus-rest-client into their reactive variants.

Changes for the move are here: rsvoboda/quarkus-test-suite@818b363

There is failure in one scenario called "LookupAuthorization" with authorization using @ClientHeaderParam where the Bearer token gets constructed using direct communication with oidc server.
https://github.com/quarkus-qe/quarkus-test-suite/blob/main/security/keycloak-oidc-client-extended/src/main/java/io/quarkus/ts/security/keycloak/oidcclient/extended/restclient/ping/clients/LookupAuthorizationPongClient.java#L25

I can't say for sure if the trouble is in resteasy-reactive, rest-client-reactive or in oidc extensions.
Thus CCing @sberyozkin, @Sgitario (who created that test coverage ;) ) and @geoand

Expected behavior

All tests to pass

Actual behavior

Test failure

[ERROR] Failures:
[ERROR]   OidcRestClientIT.testLookupAuthorization:49->assertPingEndpoints:57->assertPingPong:109 1 expectation failed.
Expected status code <200> but was <500>.

[INFO]
[ERROR] Tests run: 9, Failures: 1, Errors: 0, Skipped: 0

How to Reproduce?

Output of uname -a or ver

macOS Monterey

Output of java -version

Java 17

GraalVM version (if different from Java)

No response

Quarkus version or git rev

Quarkus main

Build tool (ie. output of mvnw --version or gradlew --version)

No response

Additional information

No response
@rsvoboda rsvoboda added the kind/bug Something isn't working label Sep 15, 2022
@quarkus-bot
Copy link

quarkus-bot bot commented Sep 15, 2022

/cc @pedroigor, @sberyozkin

@geoand
Copy link
Contributor

geoand commented Sep 15, 2022 •
edited

Do the server logs contain any useful info?

@rsvoboda
Copy link
Member Author

nope :/

@geoand
Copy link
Contributor

geoand commented Sep 15, 2022

That's likely because of the use of @QuarkusScenario

@rsvoboda
Copy link
Member Author

Why do you think so?

@geoand
Copy link
Contributor

geoand commented Sep 15, 2022 •
edited

Nevermind, I was able to get a stacktrace (by adding quarkus.log.category."org.jboss.resteasy.reactive.common.core.AbstractResteasyReactiveContext".level=DEBUG to application.properties):

15:14:42,904 INFO  [app] 15:14:41,882 Restarting handler chain for exception exception: java.lang.VerifyError: Bad type on operand stack
15:14:42,905 INFO  [app] Exception Details:
15:14:42,905 INFO  [app]   Location:
15:14:42,905 INFO  [app]     io/quarkus/ts/security/keycloak/oidcclient/extended/restclient/ping/clients/LookupAuthorizationPongClient99f1c15d97f8fb0b7bd6567c66a5a78c9f265a8e.deletePongById(Ljava/lang/String;)Z @1: ireturn
15:14:42,905 INFO  [app]   Reason:
15:14:42,905 INFO  [app]     Type null (current frame, stack[0]) is not assignable to integer
15:14:42,906 INFO  [app]   Current Frame:
15:14:42,906 INFO  [app]     bci: @1
15:14:42,906 INFO  [app]     flags: { }
15:14:42,906 INFO  [app]     locals: { 'io/quarkus/ts/security/keycloak/oidcclient/extended/restclient/ping/clients/LookupAuthorizationPongClient99f1c15d97f8fb0b7bd6567c66a5a78c9f265a8e', 'java/lang/String' }
15:14:42,906 INFO  [app]     stack: { null }
15:14:42,907 INFO  [app]   Bytecode:
15:14:42,907 INFO  [app]     0000000: 01ac                                   
15:14:42,907 INFO  [app]        at io.quarkus.ts.security.keycloak.oidcclient.extended.restclient.ping.clients.LookupAuthorizationPongClient$$getPong$$2.addHeaders(Unknown Source)
15:14:42,907 INFO  [app]        at io.quarkus.rest.client.reactive.runtime.MicroProfileRestClientRequestFilter.filter(MicroProfileRestClientRequestFilter.java:47)
15:14:42,907 INFO  [app]        at org.jboss.resteasy.reactive.client.spi.ResteasyReactiveClientRequestFilter.filter(ResteasyReactiveClientRequestFilter.java:11)
15:14:42,907 INFO  [app]        at org.jboss.resteasy.reactive.client.handlers.ClientRequestFilterRestHandler.handle(ClientRequestFilterRestHandler.java:24)
15:14:42,908 INFO  [app]        at org.jboss.resteasy.reactive.client.handlers.ClientRequestFilterRestHandler.handle(ClientRequestFilterRestHandler.java:9)
15:14:42,908 INFO  [app]        at org.jboss.resteasy.reactive.common.core.AbstractResteasyReactiveContext.invokeHandler(AbstractResteasyReactiveContext.java:224)
15:14:42,908 INFO  [app]        at org.jboss.resteasy.reactive.common.core.AbstractResteasyReactiveContext.run(AbstractResteasyReactiveContext.java:140)
15:14:42,908 INFO  [app]        at org.jboss.resteasy.reactive.client.impl.AsyncInvokerImpl.performRequestInternal(AsyncInvokerImpl.java:262)
15:14:42,908 INFO  [app]        at org.jboss.resteasy.reactive.client.impl.AsyncInvokerImpl.performRequestInternal(AsyncInvokerImpl.java:252)
15:14:42,909 INFO  [app]        at org.jboss.resteasy.reactive.client.impl.AsyncInvokerImpl.method(AsyncInvokerImpl.java:192)
15:14:42,909 INFO  [app]        at org.jboss.resteasy.reactive.client.impl.InvocationBuilderImpl.method(InvocationBuilderImpl.java:321)
15:14:42,909 INFO  [app]        at io.quarkus.ts.security.keycloak.oidcclient.extended.restclient.ping.clients.LookupAuthorizationPongClient$$QuarkusRestClientInterface.getPong(Unknown Source)
15:14:42,909 INFO  [app]        at io.quarkus.ts.security.keycloak.oidcclient.extended.restclient.ping.clients.LookupAuthorizationPongClient$$CDIWrapper.getPong(Unknown Source)
15:14:42,909 INFO  [app]        at io.quarkus.ts.security.keycloak.oidcclient.extended.restclient.ping.LookupAuthorizationPingResource.getPing(LookupAuthorizationPingResource.java:28)
15:14:42,909 INFO  [app]        at io.quarkus.ts.security.keycloak.oidcclient.extended.restclient.ping.LookupAuthorizationPingResource$quarkusrestinvoker$getPing_fcdc448473f52389690945211c28548ba4f40cba.invoke(Unknown Source)
15:14:42,910 INFO  [app]        at org.jboss.resteasy.reactive.server.handlers.InvocationHandler.handle(InvocationHandler.java:29)
15:14:42,910 INFO  [app]        at io.quarkus.resteasy.reactive.server.runtime.QuarkusResteasyReactiveRequestContext.invokeHandler(QuarkusResteasyReactiveRequestContext.java:115)
15:14:42,910 INFO  [app]        at org.jboss.resteasy.reactive.common.core.AbstractResteasyReactiveContext.run(AbstractResteasyReactiveContext.java:140)
15:14:42,910 INFO  [app]        at io.quarkus.vertx.core.runtime.VertxCoreRecorder$14.runWith(VertxCoreRecorder.java:560)
15:14:42,911 INFO  [app]        at org.jboss.threads.EnhancedQueueExecutor$Task.run(EnhancedQueueExecutor.java:2449)
15:14:42,911 INFO  [app]        at org.jboss.threads.EnhancedQueueExecutor$ThreadBody.run(EnhancedQueueExecutor.java:1478)
15:14:42,911 INFO  [app]        at org.jboss.threads.DelegatingRunnable.run(DelegatingRunnable.java:29)
15:14:42,911 INFO  [app]        at org.jboss.threads.ThreadLocalResettingRunnable.run(ThreadLocalResettingRunnable.java:29)
15:14:42,911 INFO  [app]        at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
15:14:42,911 INFO  [app]        at java.base/java.lang.Thread.run(Thread.java:829)
15:14:42,912 INFO  [app] 15:14:41,883 Restarting handler chain for exception exception: javax.ws.rs.ProcessingException: Bad type on operand stack
15:14:42,912 INFO  [app] Exception Details:
15:14:42,912 INFO  [app]   Location:
15:14:42,912 INFO  [app]     io/quarkus/ts/security/keycloak/oidcclient/extended/restclient/ping/clients/LookupAuthorizationPongClient99f1c15d97f8fb0b7bd6567c66a5a78c9f265a8e.deletePongById(Ljava/lang/String;)Z @1: ireturn
15:14:42,912 INFO  [app]   Reason:
15:14:42,913 INFO  [app]     Type null (current frame, stack[0]) is not assignable to integer
15:14:42,913 INFO  [app]   Current Frame:
15:14:42,913 INFO  [app]     bci: @1
15:14:42,913 INFO  [app]     flags: { }
15:14:42,913 INFO  [app]     locals: { 'io/quarkus/ts/security/keycloak/oidcclient/extended/restclient/ping/clients/LookupAuthorizationPongClient99f1c15d97f8fb0b7bd6567c66a5a78c9f265a8e', 'java/lang/String' }
15:14:42,913 INFO  [app]     stack: { null }
15:14:42,913 INFO  [app]   Bytecode:
15:14:42,913 INFO  [app]     0000000: 01ac                                   
15:14:42,913 INFO  [app]        at org.jboss.resteasy.reactive.client.impl.InvocationBuilderImpl.unwrap(InvocationBuilderImpl.java:220)
15:14:42,913 INFO  [app]        at org.jboss.resteasy.reactive.client.impl.InvocationBuilderImpl.method(InvocationBuilderImpl.java:321)
15:14:42,913 INFO  [app]        at io.quarkus.ts.security.keycloak.oidcclient.extended.restclient.ping.clients.LookupAuthorizationPongClient$$QuarkusRestClientInterface.getPong(Unknown Source)
15:14:42,914 INFO  [app]        at io.quarkus.ts.security.keycloak.oidcclient.extended.restclient.ping.clients.LookupAuthorizationPongClient$$CDIWrapper.getPong(Unknown Source)
15:14:42,914 INFO  [app]        at io.quarkus.ts.security.keycloak.oidcclient.extended.restclient.ping.LookupAuthorizationPingResource.getPing(LookupAuthorizationPingResource.java:28)
15:14:42,914 INFO  [app]        at io.quarkus.ts.security.keycloak.oidcclient.extended.restclient.ping.LookupAuthorizationPingResource$quarkusrestinvoker$getPing_fcdc448473f52389690945211c28548ba4f40cba.invoke(Unknown Source)
15:14:42,914 INFO  [app]        at org.jboss.resteasy.reactive.server.handlers.InvocationHandler.handle(InvocationHandler.java:29)
15:14:42,914 INFO  [app]        at io.quarkus.resteasy.reactive.server.runtime.QuarkusResteasyReactiveRequestContext.invokeHandler(QuarkusResteasyReactiveRequestContext.java:115)
15:14:42,914 INFO  [app]        at org.jboss.resteasy.reactive.common.core.AbstractResteasyReactiveContext.run(AbstractResteasyReactiveContext.java:140)
15:14:42,914 INFO  [app]        at io.quarkus.vertx.core.runtime.VertxCoreRecorder$14.runWith(VertxCoreRecorder.java:560)
15:14:42,914 INFO  [app]        at org.jboss.threads.EnhancedQueueExecutor$Task.run(EnhancedQueueExecutor.java:2449)
15:14:42,914 INFO  [app]        at org.jboss.threads.EnhancedQueueExecutor$ThreadBody.run(EnhancedQueueExecutor.java:1478)
15:14:42,914 INFO  [app]        at org.jboss.threads.DelegatingRunnable.run(DelegatingRunnable.java:29)
15:14:42,914 INFO  [app]        at org.jboss.threads.ThreadLocalResettingRunnable.run(ThreadLocalResettingRunnable.java:29)
15:14:42,914 INFO  [app]        at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
15:14:42,914 INFO  [app]        at java.base/java.lang.Thread.run(Thread.java:829)
15:14:42,914 INFO  [app] Caused by: java.lang.VerifyError: Bad type on operand stack
15:14:42,915 INFO  [app] Exception Details:
15:14:42,915 INFO  [app]   Location:
15:14:42,915 INFO  [app]     io/quarkus/ts/security/keycloak/oidcclient/extended/restclient/ping/clients/LookupAuthorizationPongClient99f1c15d97f8fb0b7bd6567c66a5a78c9f265a8e.deletePongById(Ljava/lang/String;)Z @1: ireturn
15:14:42,915 INFO  [app]   Reason:
15:14:42,915 INFO  [app]     Type null (current frame, stack[0]) is not assignable to integer
15:14:42,915 INFO  [app]   Current Frame:
15:14:42,915 INFO  [app]     bci: @1
15:14:42,915 INFO  [app]     flags: { }
15:14:42,915 INFO  [app]     locals: { 'io/quarkus/ts/security/keycloak/oidcclient/extended/restclient/ping/clients/LookupAuthorizationPongClient99f1c15d97f8fb0b7bd6567c66a5a78c9f265a8e', 'java/lang/String' }
15:14:42,915 INFO  [app]     stack: { null }
15:14:42,915 INFO  [app]   Bytecode:
15:14:42,915 INFO  [app]     0000000: 01ac                                   
15:14:42,915 INFO  [app]        at io.quarkus.ts.security.keycloak.oidcclient.extended.restclient.ping.clients.LookupAuthorizationPongClient$$getPong$$2.addHeaders(Unknown Source)
15:14:42,915 INFO  [app]        at io.quarkus.rest.client.reactive.runtime.MicroProfileRestClientRequestFilter.filter(MicroProfileRestClientRequestFilter.java:47)
15:14:42,916 INFO  [app]        at org.jboss.resteasy.reactive.client.spi.ResteasyReactiveClientRequestFilter.filter(ResteasyReactiveClientRequestFilter.java:11)
15:14:42,916 INFO  [app]        at org.jboss.resteasy.reactive.client.handlers.ClientRequestFilterRestHandler.handle(ClientRequestFilterRestHandler.java:24)
15:14:42,916 INFO  [app]        at org.jboss.resteasy.reactive.client.handlers.ClientRequestFilterRestHandler.handle(ClientRequestFilterRestHandler.java:9)
15:14:42,916 INFO  [app]        at org.jboss.resteasy.reactive.common.core.AbstractResteasyReactiveContext.invokeHandler(AbstractResteasyReactiveContext.java:224)
15:14:42,916 INFO  [app]        at org.jboss.resteasy.reactive.common.core.AbstractResteasyReactiveContext.run(AbstractResteasyReactiveContext.java:140)
15:14:42,916 INFO  [app]        at org.jboss.resteasy.reactive.client.impl.AsyncInvokerImpl.performRequestInternal(AsyncInvokerImpl.java:262)
15:14:42,916 INFO  [app]        at org.jboss.resteasy.reactive.client.impl.AsyncInvokerImpl.performRequestInternal(AsyncInvokerImpl.java:252)
15:14:42,916 INFO  [app]        at org.jboss.resteasy.reactive.client.impl.AsyncInvokerImpl.method(AsyncInvokerImpl.java:192)
15:14:42,916 INFO  [app]        ... 15 more
15:14:42,916 INFO  [app] 15:14:41,884 Custom exception mapper invoked.
15:14:43,088 INFO  [app] getPing
15:14:43,453 INFO  ## Running test OidcRestClientIT.testReactive()
15:14:44,457 INFO  [app] 15:14:43,437 Restarting handler chain for exception exception: javax.ws.rs.NotFoundException: Unable to find matching target resource method
15:14:44,457 INFO  [app]        at org.jboss.resteasy.reactive.server.handlers.ClassRoutingHandler.throwNotFound(ClassRoutingHandler.java:221)
15:14:44,458 INFO  [app]        at org.jboss.resteasy.reactive.server.handlers.ClassRoutingHandler.handle(ClassRoutingHandler.java:99)
15:14:44,458 INFO  [app]        at io.quarkus.resteasy.reactive.server.runtime.QuarkusResteasyReactiveRequestContext.invokeHandler(QuarkusResteasyReactiveRequestContext.java:97)
15:14:44,458 INFO  [app]        at org.jboss.resteasy.reactive.common.core.AbstractResteasyReactiveContext.run(AbstractResteasyReactiveContext.java:140)
15:14:44,458 INFO  [app]        at org.jboss.resteasy.reactive.server.handlers.RestInitialHandler.beginProcessing(RestInitialHandler.java:49)
15:14:44,458 INFO  [app]        at org.jboss.resteasy.reactive.server.vertx.ResteasyReactiveVertxHandler.handle(ResteasyReactiveVertxHandler.java:17)
15:14:44,458 INFO  [app]        at org.jboss.resteasy.reactive.server.vertx.ResteasyReactiveVertxHandler.handle(ResteasyReactiveVertxHandler.java:7)
15:14:44,458 INFO  [app]        at io.vertx.ext.web.impl.RouteState.handleContext(RouteState.java:1284)
15:14:44,458 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImplBase.iterateNext(RoutingContextImplBase.java:173)
15:14:44,459 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImpl.next(RoutingContextImpl.java:140)
15:14:44,459 INFO  [app]        at io.quarkus.vertx.http.runtime.StaticResourcesRecorder$2.handle(StaticResourcesRecorder.java:84)
15:14:44,459 INFO  [app]        at io.quarkus.vertx.http.runtime.StaticResourcesRecorder$2.handle(StaticResourcesRecorder.java:71)
15:14:44,459 INFO  [app]        at io.vertx.ext.web.impl.RouteState.handleContext(RouteState.java:1284)
15:14:44,459 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImplBase.iterateNext(RoutingContextImplBase.java:173)
15:14:44,459 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImpl.next(RoutingContextImpl.java:140)
15:14:44,459 INFO  [app]        at io.quarkus.vertx.http.runtime.VertxHttpRecorder$6.handle(VertxHttpRecorder.java:430)
15:14:44,459 INFO  [app]        at io.quarkus.vertx.http.runtime.VertxHttpRecorder$6.handle(VertxHttpRecorder.java:408)
15:14:44,460 INFO  [app]        at io.vertx.ext.web.impl.RouteState.handleContext(RouteState.java:1284)
15:14:44,460 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImplBase.iterateNext(RoutingContextImplBase.java:173)
15:14:44,460 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImpl.next(RoutingContextImpl.java:140)
15:14:44,460 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpAuthorizer.doPermissionCheck(HttpAuthorizer.java:117)
15:14:44,460 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpAuthorizer$2.accept(HttpAuthorizer.java:134)
15:14:44,460 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpAuthorizer$2.accept(HttpAuthorizer.java:123)
15:14:44,460 INFO  [app]        at io.smallrye.context.impl.wrappers.SlowContextualConsumer.accept(SlowContextualConsumer.java:21)
15:14:44,460 INFO  [app]        at io.smallrye.mutiny.helpers.UniCallbackSubscriber.onItem(UniCallbackSubscriber.java:77)
15:14:44,460 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:60)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.performInnerSubscription(UniOnItemTransformToUni.java:81)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:57)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransform$UniOnItemTransformProcessor.onItem(UniOnItemTransform.java:43)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniMemoizeOp.subscribe(UniMemoizeOp.java:73)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransform.subscribe(UniOnItemTransform.java:22)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni.subscribe(UniOnItemTransformToUni.java:25)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.groups.UniSubscribe.withSubscriber(UniSubscribe.java:52)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.groups.UniSubscribe.with(UniSubscribe.java:112)
15:14:44,461 INFO  [app]        at io.smallrye.mutiny.groups.UniSubscribe.with(UniSubscribe.java:89)
15:14:44,462 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpAuthorizer.doPermissionCheck(HttpAuthorizer.java:123)
15:14:44,462 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpAuthorizer.checkPermission(HttpAuthorizer.java:100)
15:14:44,462 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpSecurityRecorder$3.handle(HttpSecurityRecorder.java:227)
15:14:44,462 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpSecurityRecorder$3.handle(HttpSecurityRecorder.java:219)
15:14:44,462 INFO  [app]        at io.vertx.ext.web.impl.RouteState.handleContext(RouteState.java:1284)
15:14:44,462 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImplBase.iterateNext(RoutingContextImplBase.java:173)
15:14:44,462 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImpl.next(RoutingContextImpl.java:140)
15:14:44,462 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpSecurityRecorder$2$2.onItem(HttpSecurityRecorder.java:152)
15:14:44,462 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpSecurityRecorder$2$2.onItem(HttpSecurityRecorder.java:113)
15:14:44,462 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniMemoizeOp.drain(UniMemoizeOp.java:160)
15:14:44,462 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniMemoizeOp.onItem(UniMemoizeOp.java:180)
15:14:44,462 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:60)
15:14:44,462 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:60)
15:14:44,462 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.onItem(UniOnItemOrFailureFlatMap.java:56)
15:14:44,462 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.onItem(UniOnItemOrFailureFlatMap.java:56)
15:14:44,462 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.onItem(UniOnItemOrFailureFlatMap.java:56)
15:14:44,462 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:44,462 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:44,462 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:44,462 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,462 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.performInnerSubscription(UniOnItemOrFailureFlatMap.java:99)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.onItem(UniOnItemOrFailureFlatMap.java:54)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap.subscribe(UniOnItemOrFailureFlatMap.java:27)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.performInnerSubscription(UniOnItemOrFailureFlatMap.java:99)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.onItem(UniOnItemOrFailureFlatMap.java:54)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap.subscribe(UniOnItemOrFailureFlatMap.java:27)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.performInnerSubscription(UniOnItemOrFailureFlatMap.java:99)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.onItem(UniOnItemOrFailureFlatMap.java:54)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:44,463 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap.subscribe(UniOnItemOrFailureFlatMap.java:27)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromDeferredSupplier.subscribe(UniCreateFromDeferredSupplier.java:36)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.performInnerSubscription(UniOnItemTransformToUni.java:81)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:57)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:60)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.performInnerSubscription(UniOnItemTransformToUni.java:81)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:57)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:60)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:44,464 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.performInnerSubscription(UniOnItemTransformToUni.java:81)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:57)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni.subscribe(UniOnItemTransformToUni.java:25)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni.subscribe(UniOnItemTransformToUni.java:25)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni.subscribe(UniOnItemTransformToUni.java:25)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.performInnerSubscription(UniOnItemTransformToUni.java:81)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:57)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransform$UniOnItemTransformProcessor.onItem(UniOnItemTransform.java:43)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransform$UniOnItemTransformProcessor.onItem(UniOnItemTransform.java:43)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:44,465 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:44,466 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:44,466 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,466 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransform.subscribe(UniOnItemTransform.java:22)
15:14:44,466 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,466 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransform.subscribe(UniOnItemTransform.java:22)
15:14:44,466 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,466 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni.subscribe(UniOnItemTransformToUni.java:25)
15:14:44,466 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,466 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniMemoizeOp.subscribe(UniMemoizeOp.java:84)
15:14:44,466 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:44,466 INFO  [app]        at io.smallrye.mutiny.groups.UniSubscribe.withSubscriber(UniSubscribe.java:52)
15:14:44,466 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpSecurityRecorder$2.handle(HttpSecurityRecorder.java:113)
15:14:44,466 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpSecurityRecorder$2.handle(HttpSecurityRecorder.java:60)
15:14:44,466 INFO  [app]        at io.vertx.ext.web.impl.RouteState.handleContext(RouteState.java:1284)
15:14:44,466 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImplBase.iterateNext(RoutingContextImplBase.java:173)
15:14:44,466 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImpl.next(RoutingContextImpl.java:140)
15:14:44,466 INFO  [app]        at io.vertx.ext.web.impl.RouterImpl.handle(RouterImpl.java:68)
15:14:44,466 INFO  [app]        at io.vertx.ext.web.impl.RouterImpl.handle(RouterImpl.java:37)
15:14:44,466 INFO  [app]        at io.quarkus.vertx.http.runtime.VertxHttpRecorder$15.handle(VertxHttpRecorder.java:606)
15:14:44,466 INFO  [app]        at io.quarkus.vertx.http.runtime.VertxHttpRecorder$15.handle(VertxHttpRecorder.java:589)
15:14:44,466 INFO  [app]        at io.quarkus.vertx.http.runtime.VertxHttpRecorder$1.handle(VertxHttpRecorder.java:185)
15:14:44,466 INFO  [app]        at io.quarkus.vertx.http.runtime.VertxHttpRecorder$1.handle(VertxHttpRecorder.java:160)
15:14:44,466 INFO  [app]        at io.vertx.core.http.impl.Http1xServerRequestHandler.handle(Http1xServerRequestHandler.java:67)
15:14:44,466 INFO  [app]        at io.vertx.core.http.impl.Http1xServerRequestHandler.handle(Http1xServerRequestHandler.java:30)
15:14:44,466 INFO  [app]        at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:55)
15:14:44,467 INFO  [app]        at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:158)
15:14:44,467 INFO  [app]        at io.vertx.core.http.impl.Http1xServerConnection.handleMessage(Http1xServerConnection.java:145)
15:14:44,467 INFO  [app]        at io.vertx.core.net.impl.ConnectionBase.read(ConnectionBase.java:157)
15:14:44,467 INFO  [app]        at io.vertx.core.net.impl.VertxHandler.channelRead(VertxHandler.java:153)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:44,467 INFO  [app]        at io.netty.channel.ChannelInboundHandlerAdapter.channelRead(ChannelInboundHandlerAdapter.java:93)
15:14:44,467 INFO  [app]        at io.netty.handler.codec.http.websocketx.extensions.WebSocketServerExtensionHandler.channelRead(WebSocketServerExtensionHandler.java:99)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:44,467 INFO  [app]        at io.vertx.core.http.impl.Http1xUpgradeToH2CHandler.channelRead(Http1xUpgradeToH2CHandler.java:116)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:44,467 INFO  [app]        at io.netty.handler.timeout.IdleStateHandler.channelRead(IdleStateHandler.java:286)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:44,467 INFO  [app]        at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:327)
15:14:44,467 INFO  [app]        at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:299)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:44,467 INFO  [app]        at io.vertx.core.http.impl.Http1xOrH2CHandler.end(Http1xOrH2CHandler.java:61)
15:14:44,467 INFO  [app]        at io.vertx.core.http.impl.Http1xOrH2CHandler.channelRead(Http1xOrH2CHandler.java:38)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:44,467 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:44,467 INFO  [app]        at io.netty.handler.timeout.IdleStateHandler.channelRead(IdleStateHandler.java:286)
15:14:44,468 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:44,468 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:44,468 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:44,468 INFO  [app]        at io.netty.channel.DefaultChannelPipeline$HeadContext.channelRead(DefaultChannelPipeline.java:1410)
15:14:44,468 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:44,468 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:44,468 INFO  [app]        at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:919)
15:14:44,468 INFO  [app]        at io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe.read(AbstractNioByteChannel.java:166)
15:14:44,468 INFO  [app]        at io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEventLoop.java:722)
15:14:44,468 INFO  [app]        at io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimized(NioEventLoop.java:658)
15:14:44,468 INFO  [app]        at io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEventLoop.java:584)
15:14:44,468 INFO  [app]        at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:496)
15:14:44,468 INFO  [app]        at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:997)
15:14:44,468 INFO  [app]        at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74)
15:14:44,468 INFO  [app]        at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
15:14:44,468 INFO  [app]        at java.base/java.lang.Thread.run(Thread.java:829)
15:14:44,468 INFO  [app] 15:14:43,438 Custom exception mapper invoked.
15:14:44,969 INFO  ## Running test OidcRestClientIT.testAutoAcquireToken()
15:14:45,973 INFO  [app] 15:14:44,963 Restarting handler chain for exception exception: javax.ws.rs.NotFoundException: Unable to find matching target resource method
15:14:45,973 INFO  [app]        at org.jboss.resteasy.reactive.server.handlers.ClassRoutingHandler.throwNotFound(ClassRoutingHandler.java:221)
15:14:45,973 INFO  [app]        at org.jboss.resteasy.reactive.server.handlers.ClassRoutingHandler.handle(ClassRoutingHandler.java:99)
15:14:45,973 INFO  [app]        at io.quarkus.resteasy.reactive.server.runtime.QuarkusResteasyReactiveRequestContext.invokeHandler(QuarkusResteasyReactiveRequestContext.java:97)
15:14:45,974 INFO  [app]        at org.jboss.resteasy.reactive.common.core.AbstractResteasyReactiveContext.run(AbstractResteasyReactiveContext.java:140)
15:14:45,974 INFO  [app]        at org.jboss.resteasy.reactive.server.handlers.RestInitialHandler.beginProcessing(RestInitialHandler.java:49)
15:14:45,974 INFO  [app]        at org.jboss.resteasy.reactive.server.vertx.ResteasyReactiveVertxHandler.handle(ResteasyReactiveVertxHandler.java:17)
15:14:45,974 INFO  [app]        at org.jboss.resteasy.reactive.server.vertx.ResteasyReactiveVertxHandler.handle(ResteasyReactiveVertxHandler.java:7)
15:14:45,974 INFO  [app]        at io.vertx.ext.web.impl.RouteState.handleContext(RouteState.java:1284)
15:14:45,974 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImplBase.iterateNext(RoutingContextImplBase.java:173)
15:14:45,974 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImpl.next(RoutingContextImpl.java:140)
15:14:45,974 INFO  [app]        at io.quarkus.vertx.http.runtime.StaticResourcesRecorder$2.handle(StaticResourcesRecorder.java:84)
15:14:45,974 INFO  [app]        at io.quarkus.vertx.http.runtime.StaticResourcesRecorder$2.handle(StaticResourcesRecorder.java:71)
15:14:45,974 INFO  [app]        at io.vertx.ext.web.impl.RouteState.handleContext(RouteState.java:1284)
15:14:45,974 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImplBase.iterateNext(RoutingContextImplBase.java:173)
15:14:45,974 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImpl.next(RoutingContextImpl.java:140)
15:14:45,974 INFO  [app]        at io.quarkus.vertx.http.runtime.VertxHttpRecorder$6.handle(VertxHttpRecorder.java:430)
15:14:45,974 INFO  [app]        at io.quarkus.vertx.http.runtime.VertxHttpRecorder$6.handle(VertxHttpRecorder.java:408)
15:14:45,974 INFO  [app]        at io.vertx.ext.web.impl.RouteState.handleContext(RouteState.java:1284)
15:14:45,974 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImplBase.iterateNext(RoutingContextImplBase.java:173)
15:14:45,974 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImpl.next(RoutingContextImpl.java:140)
15:14:45,974 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpAuthorizer.doPermissionCheck(HttpAuthorizer.java:117)
15:14:45,974 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpAuthorizer$2.accept(HttpAuthorizer.java:134)
15:14:45,974 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpAuthorizer$2.accept(HttpAuthorizer.java:123)
15:14:45,974 INFO  [app]        at io.smallrye.context.impl.wrappers.SlowContextualConsumer.accept(SlowContextualConsumer.java:21)
15:14:45,974 INFO  [app]        at io.smallrye.mutiny.helpers.UniCallbackSubscriber.onItem(UniCallbackSubscriber.java:77)
15:14:45,974 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:60)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.performInnerSubscription(UniOnItemTransformToUni.java:81)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:57)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransform$UniOnItemTransformProcessor.onItem(UniOnItemTransform.java:43)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniMemoizeOp.subscribe(UniMemoizeOp.java:73)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransform.subscribe(UniOnItemTransform.java:22)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni.subscribe(UniOnItemTransformToUni.java:25)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.groups.UniSubscribe.withSubscriber(UniSubscribe.java:52)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.groups.UniSubscribe.with(UniSubscribe.java:112)
15:14:45,975 INFO  [app]        at io.smallrye.mutiny.groups.UniSubscribe.with(UniSubscribe.java:89)
15:14:45,975 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpAuthorizer.doPermissionCheck(HttpAuthorizer.java:123)
15:14:45,975 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpAuthorizer.checkPermission(HttpAuthorizer.java:100)
15:14:45,975 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpSecurityRecorder$3.handle(HttpSecurityRecorder.java:227)
15:14:45,975 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpSecurityRecorder$3.handle(HttpSecurityRecorder.java:219)
15:14:45,975 INFO  [app]        at io.vertx.ext.web.impl.RouteState.handleContext(RouteState.java:1284)
15:14:45,975 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImplBase.iterateNext(RoutingContextImplBase.java:173)
15:14:45,975 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImpl.next(RoutingContextImpl.java:140)
15:14:45,975 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpSecurityRecorder$2$2.onItem(HttpSecurityRecorder.java:152)
15:14:45,976 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpSecurityRecorder$2$2.onItem(HttpSecurityRecorder.java:113)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniMemoizeOp.drain(UniMemoizeOp.java:160)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniMemoizeOp.onItem(UniMemoizeOp.java:180)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:60)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:60)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.onItem(UniOnItemOrFailureFlatMap.java:56)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.onItem(UniOnItemOrFailureFlatMap.java:56)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.onItem(UniOnItemOrFailureFlatMap.java:56)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.performInnerSubscription(UniOnItemOrFailureFlatMap.java:99)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.onItem(UniOnItemOrFailureFlatMap.java:54)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,976 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap.subscribe(UniOnItemOrFailureFlatMap.java:27)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.performInnerSubscription(UniOnItemOrFailureFlatMap.java:99)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.onItem(UniOnItemOrFailureFlatMap.java:54)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap.subscribe(UniOnItemOrFailureFlatMap.java:27)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.performInnerSubscription(UniOnItemOrFailureFlatMap.java:99)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap$UniOnItemOrFailureFlatMapProcessor.onItem(UniOnItemOrFailureFlatMap.java:54)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemOrFailureFlatMap.subscribe(UniOnItemOrFailureFlatMap.java:27)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromDeferredSupplier.subscribe(UniCreateFromDeferredSupplier.java:36)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.performInnerSubscription(UniOnItemTransformToUni.java:81)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:57)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:60)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.performInnerSubscription(UniOnItemTransformToUni.java:81)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:57)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:60)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:45,977 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.performInnerSubscription(UniOnItemTransformToUni.java:81)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:57)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni.subscribe(UniOnItemTransformToUni.java:25)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni.subscribe(UniOnItemTransformToUni.java:25)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni.subscribe(UniOnItemTransformToUni.java:25)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.performInnerSubscription(UniOnItemTransformToUni.java:81)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni$UniOnItemTransformToUniProcessor.onItem(UniOnItemTransformToUni.java:57)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransform$UniOnItemTransformProcessor.onItem(UniOnItemTransform.java:43)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransform$UniOnItemTransformProcessor.onItem(UniOnItemTransform.java:43)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.forward(UniCreateFromKnownItem.java:38)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem$KnownItemSubscription.access$100(UniCreateFromKnownItem.java:26)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.builders.UniCreateFromKnownItem.subscribe(UniCreateFromKnownItem.java:23)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransform.subscribe(UniOnItemTransform.java:22)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransform.subscribe(UniOnItemTransform.java:22)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniOnItemTransformToUni.subscribe(UniOnItemTransformToUni.java:25)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.uni.UniMemoizeOp.subscribe(UniMemoizeOp.java:84)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.operators.AbstractUni.subscribe(AbstractUni.java:36)
15:14:45,978 INFO  [app]        at io.smallrye.mutiny.groups.UniSubscribe.withSubscriber(UniSubscribe.java:52)
15:14:45,978 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpSecurityRecorder$2.handle(HttpSecurityRecorder.java:113)
15:14:45,978 INFO  [app]        at io.quarkus.vertx.http.runtime.security.HttpSecurityRecorder$2.handle(HttpSecurityRecorder.java:60)
15:14:45,978 INFO  [app]        at io.vertx.ext.web.impl.RouteState.handleContext(RouteState.java:1284)
15:14:45,978 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImplBase.iterateNext(RoutingContextImplBase.java:173)
15:14:45,978 INFO  [app]        at io.vertx.ext.web.impl.RoutingContextImpl.next(RoutingContextImpl.java:140)
15:14:45,978 INFO  [app]        at io.vertx.ext.web.impl.RouterImpl.handle(RouterImpl.java:68)
15:14:45,978 INFO  [app]        at io.vertx.ext.web.impl.RouterImpl.handle(RouterImpl.java:37)
15:14:45,978 INFO  [app]        at io.quarkus.vertx.http.runtime.VertxHttpRecorder$15.handle(VertxHttpRecorder.java:606)
15:14:45,978 INFO  [app]        at io.quarkus.vertx.http.runtime.VertxHttpRecorder$15.handle(VertxHttpRecorder.java:589)
15:14:45,978 INFO  [app]        at io.quarkus.vertx.http.runtime.VertxHttpRecorder$1.handle(VertxHttpRecorder.java:185)
15:14:45,978 INFO  [app]        at io.quarkus.vertx.http.runtime.VertxHttpRecorder$1.handle(VertxHttpRecorder.java:160)
15:14:45,978 INFO  [app]        at io.vertx.core.http.impl.Http1xServerRequestHandler.handle(Http1xServerRequestHandler.java:67)
15:14:45,978 INFO  [app]        at io.vertx.core.http.impl.Http1xServerRequestHandler.handle(Http1xServerRequestHandler.java:30)
15:14:45,978 INFO  [app]        at io.vertx.core.impl.EventLoopContext.emit(EventLoopContext.java:55)
15:14:45,978 INFO  [app]        at io.vertx.core.impl.DuplicatedContext.emit(DuplicatedContext.java:158)
15:14:45,978 INFO  [app]        at io.vertx.core.http.impl.Http1xServerConnection.handleMessage(Http1xServerConnection.java:145)
15:14:45,978 INFO  [app]        at io.vertx.core.net.impl.ConnectionBase.read(ConnectionBase.java:157)
15:14:45,978 INFO  [app]        at io.vertx.core.net.impl.VertxHandler.channelRead(VertxHandler.java:153)
15:14:45,978 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:45,978 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:45,978 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:45,978 INFO  [app]        at io.netty.channel.ChannelInboundHandlerAdapter.channelRead(ChannelInboundHandlerAdapter.java:93)
15:14:45,978 INFO  [app]        at io.netty.handler.codec.http.websocketx.extensions.WebSocketServerExtensionHandler.channelRead(WebSocketServerExtensionHandler.java:99)
15:14:45,978 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:45,978 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:45,978 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:45,978 INFO  [app]        at io.vertx.core.http.impl.Http1xUpgradeToH2CHandler.channelRead(Http1xUpgradeToH2CHandler.java:116)
15:14:45,978 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:45,978 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:45,978 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:45,979 INFO  [app]        at io.netty.handler.timeout.IdleStateHandler.channelRead(IdleStateHandler.java:286)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:45,979 INFO  [app]        at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:327)
15:14:45,979 INFO  [app]        at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:299)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:45,979 INFO  [app]        at io.vertx.core.http.impl.Http1xOrH2CHandler.end(Http1xOrH2CHandler.java:61)
15:14:45,979 INFO  [app]        at io.vertx.core.http.impl.Http1xOrH2CHandler.channelRead(Http1xOrH2CHandler.java:38)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:45,979 INFO  [app]        at io.netty.handler.timeout.IdleStateHandler.channelRead(IdleStateHandler.java:286)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
15:14:45,979 INFO  [app]        at io.netty.channel.DefaultChannelPipeline$HeadContext.channelRead(DefaultChannelPipeline.java:1410)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
15:14:45,979 INFO  [app]        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
15:14:45,979 INFO  [app]        at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:919)
15:14:45,979 INFO  [app]        at io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe.read(AbstractNioByteChannel.java:166)
15:14:45,979 INFO  [app]        at io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEventLoop.java:722)
15:14:45,979 INFO  [app]        at io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimized(NioEventLoop.java:658)
15:14:45,979 INFO  [app]        at io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEventLoop.java:584)
15:14:45,979 INFO  [app]        at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:496)
15:14:45,979 INFO  [app]        at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:997)
15:14:45,979 INFO  [app]        at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74)
15:14:45,979 INFO  [app]        at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
15:14:45,979 INFO  [app]        at java.base/java.lang.Thread.run(Thread.java:829)
15:14:45,979 INFO  [app] 15:14:44,964 Custom exception mapper invoked.
15:14:49,416 INFO  [app] Service stopped (Quarkus JVM mode)

@sberyozkin
Copy link
Member

Looks like the address used by lookupAuth is not correct and causes 404 ?

@geoand
Copy link
Contributor

geoand commented Sep 15, 2022

@sberyozkin not sure, but there seems to be something very wrong in the generated implementation of io.quarkus.rest.client.reactive.HeaderFiller.
I'm looking into that now.

@geoand
Copy link
Contributor

geoand commented Sep 15, 2022

It might be a combination of issues. Once I've addressed the one I mentioned above, I'll know more.

geoand added a commit to geoand/quarkus that referenced this issue Sep 15, 2022
@geoand
Ensure that @ClientHeaderParam works when the rest client contains a …
555e142 
…method with a primitive return type

Relates to: quarkusio#27959
@geoand geoand mentioned this issue Sep 15, 2022
Merged
@geoand
Copy link
Contributor

geoand commented Sep 15, 2022

It indeed seems to be a combination. #27961 fixes the first part, so @sberyozkin if you want to take a look at the 404 part, that would be great.

@sberyozkin
Copy link
Member

@geoand Thanks, but OIDC never reports 404. So not sure it is related at all

@geoand
Copy link
Contributor

geoand commented Sep 15, 2022 •
edited

Actually, disregard my previous comment please, with #27961 the previously failing tests in the QE testsuite now pass.

@geoand geoand self-assigned this Sep 15, 2022
geoand added a commit to geoand/quarkus that referenced this issue Sep 15, 2022
@geoand
Ensure that @ClientHeaderParam works when the rest client contains a …
0932079 
…method with a primitive return type

Relates to: quarkusio#27959
gastaldi added a commit that referenced this issue Sep 16, 2022
@gastaldi
Merge pull request #27961 from geoand/#27959
06944a5
@quarkus-bot quarkus-bot bot added this to the 2.14 - main milestone Sep 16, 2022
@rsvoboda rsvoboda mentioned this issue Sep 16, 2022
Closed
@gsmet gsmet modified the milestones: 2.14 - main, 2.13.0.Final Sep 20, 2022
gsmet pushed a commit to gsmet/quarkus that referenced this issue Sep 20, 2022
@geoand @gsmet
Ensure that @ClientHeaderParam works when the rest client contains a …
5891752 
…method with a primitive return type

Relates to: quarkusio#27959

(cherry picked from commit 0932079)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@geoand geoand

Labels
area/oidc kind/bug Something isn't working
Projects
None yet
Milestone
2.13.0.Final
4 participants
@sberyozkin @rsvoboda @gsmet @geoand