dd-trace-java icon indicating copy to clipboard operation
dd-trace-java copied to clipboard
verified publisher icon DataDog

Keycloak resource names are no longer useful with dd-java-agent-1.6.0

Open froque opened this issue 2 years ago • 7 comments

We are using Datadog to trace Keycloak. After upgrading dd-trace-java from 0.98.1 to 1.6.0, the resource names changed. Déjà vu from #3257

keycloak_datadog

This can be replicated with

export VERSION="0.98.1" # OK 
#export VERSION="1.6.0"  # BAD

wget -nc https://github.com/DataDog/dd-trace-java/releases/download/v$VERSION/dd-java-agent-$VERSION.jar

docker run \
    -d \
    --rm \
    --name keycloak  \
    --network host \
    -e KEYCLOAK_ADMIN=admin \
    -e KEYCLOAK_ADMIN_PASSWORD=admin \
    -e "KC_HTTP_RELATIVE_PATH=/auth" \
    -e DD_SERVICE=keycloak \
    -e DD_WRITER_TYPE=LoggingWriter \
    -e JAVA_TOOL_OPTIONS="-javaagent:/opt/dd-java-agent.jar" \
    -v $(pwd)/dd-java-agent-$VERSION.jar:/opt/dd-java-agent.jar:ro \
    quay.io/keycloak/keycloak \
        start-dev 

# login into http://localhost:8080/auth/admin/master/console with user:admin and pass:admin

docker logs keycloak >& dd-java-agent-$VERSION.log

docker stop keycloak

0.98.1 logs

 grep "POST /" dd-java-agent-0.98.1.log       
[dd.trace 2023-03-13 10:53:43:413 +0000] [executor-thread-6] INFO datadog.trace.agent.common.writer.LoggingWriter - write(trace): [{"service":"keycloak","name":"jax-rs.request","resource":"POST /authenticate","trace_id":7832103471825085198,"span_id":8288587368661603633,"parent_id":0,"start":1678704823095280762,"duration":318431249,"type":"web","error":0,"metrics":{"_dd.agent_psr":1.0,"_sample_rate":1,"thread.id":72},"meta":{"component":"jax-rs-controller","http.route":"/authenticate","language":"jvm","runtime-id":"5e65b0dd-9534-4933-b2d7-906136a0c390","thread.name":"executor-thread-6"}},{"service":"keycloak","name":"jax-rs.request","resource":"LoginActionsService.authenticate","trace_id":7832103471825085198,"span_id":152790230354035776,"parent_id":8288587368661603633,"start":1678704823095456284,"duration":318245180,"type":"web","error":0,"metrics":{"thread.id":72},"meta":{"thread.name":"executor-thread-6","component":"jax-rs-controller"}},{"service":"h2","name":"h2.query","resource":"select requiredac0_.USER_ID as user_id2_78_1_, requiredac0_.REQUIRED_ACTION as required1_78_1_, requiredac0_.REQUIRED_ACTION as required1_78_0_, requiredac0_.USER_ID as user_id2_78_0_ from USER_REQUIRED_ACTION requiredac0_ where requiredac0_.USER_ID=?","trace_id":7832103471825085198,"span_id":6369079568183209212,"parent_id":152790230354035776,"start":1678704823284984911,"duration":73129,"type":"sql","error":0,"metrics":{"thread.id":72},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-6"}},{"service":"h2","name":"h2.query","resource":"select attributes0_.USER_ID as user_id4_69_1_, attributes0_.ID as id1_69_1_, attributes0_.ID as id1_69_0_, attributes0_.NAME as name2_69_0_, attributes0_.USER_ID as user_id4_69_0_, attributes0_.VALUE as value3_69_0_ from USER_ATTRIBUTE attributes0_ where attributes0_.USER_ID=?","trace_id":7832103471825085198,"span_id":2068672021756611333,"parent_id":152790230354035776,"start":1678704823280854241,"duration":80672,"type":"sql","error":0,"metrics":{"thread.id":72},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-6"}},{"service":"h2","name":"h2.query","resource":"select credential0_.ID as id1_19_, credential0_.CREATED_DATE as created_2_19_, credential0_.CREDENTIAL_DATA as credenti3_19_, credential0_.PRIORITY as priority4_19_, credential0_.SALT as salt5_19_, credential0_.SECRET_DATA as secret_d6_19_, credential0_.TYPE as type7_19_, credential0_.USER_ID as user_id9_19_, credential0_.USER_LABEL as user_lab8_19_ from CREDENTIAL credential0_ where credential0_.USER_ID=? order by credential0_.PRIORITY","trace_id":7832103471825085198,"span_id":5120124257476286998,"parent_id":152790230354035776,"start":1678704823243533976,"duration":109937,"type":"sql","error":0,"metrics":{"thread.id":72},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-6"}},{"service":"h2","name":"h2.query","resource":"select userentity0_.ID as id1_72_, userentity0_.CREATED_TIMESTAMP as created_2_72_, userentity0_.EMAIL as email3_72_, userentity0_.EMAIL_CONSTRAINT as email_co4_72_, userentity0_.EMAIL_VERIFIED as email_ve5_72_, userentity0_.ENABLED as enabled6_72_, userentity0_.FEDERATION_LINK as federati7_72_, userentity0_.FIRST_NAME as first_na8_72_, userentity0_.LAST_NAME as last_nam9_72_, userentity0_.NOT_BEFORE as not_bef10_72_, userentity0_.REALM_ID as realm_i11_72_, userentity0_.SERVICE_ACCOUNT_CLIENT_LINK as service12_72_, userentity0_.USERNAME as usernam13_72_ from USER_ENTITY userentity0_ where userentity0_.USERNAME=? and userentity0_.REALM_ID=?","trace_id":7832103471825085198,"span_id":6851524073557780392,"parent_id":152790230354035776,"start":1678704823126141983,"duration":110077,"type":"sql","error":0,"metrics":{"thread.id":72},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-6"}}]
[dd.trace 2023-03-13 10:53:43:414 +0000] [vert.x-eventloop-thread-0] INFO datadog.trace.agent.common.writer.LoggingWriter - write(trace): [{"service":"keycloak","name":"netty.request","resource":"POST /auth/realms/master/login-actions/authenticate","trace_id":4038594933169944688,"span_id":1452165209945436647,"parent_id":0,"start":1678704823080658161,"duration":333826971,"type":"web","error":0,"metrics":{"_dd.agent_psr":1.0,"peer.port":42366,"http.status_code":302,"_sample_rate":1,"thread.id":50},"meta":{"http.url":"http://localhost:8080/auth/realms/master/login-actions/authenticate","language":"jvm","thread.name":"vert.x-eventloop-thread-0","peer.ipv4":"127.0.0.1","http.hostname":"localhost","component":"netty","span.kind":"server","runtime-id":"5e65b0dd-9534-4933-b2d7-906136a0c390","http.method":"POST"}}]
[dd.trace 2023-03-13 10:53:44:013 +0000] [vert.x-eventloop-thread-10] INFO datadog.trace.agent.common.writer.LoggingWriter - write(trace): [{"service":"keycloak","name":"netty.request","resource":"POST /auth/realms/master/protocol/openid-connect/token","trace_id":6365487195423545543,"span_id":9010086964963784330,"parent_id":0,"start":1678704823868780237,"duration":144875898,"type":"web","error":0,"metrics":{"_dd.agent_psr":1.0,"peer.port":42346,"http.status_code":200,"_sample_rate":1,"thread.id":60},"meta":{"http.url":"http://localhost:8080/auth/realms/master/protocol/openid-connect/token","language":"jvm","thread.name":"vert.x-eventloop-thread-10","peer.ipv4":"127.0.0.1","http.hostname":"localhost","component":"netty","span.kind":"server","runtime-id":"5e65b0dd-9534-4933-b2d7-906136a0c390","http.method":"POST"}}]

1.6.0 logs

❯ grep "POST /" dd-java-agent-1.6.0.log 
[dd.trace 2023-03-13 10:55:19:680 +0000] [vert.x-eventloop-thread-8] INFO datadog.trace.agent.common.writer.LoggingWriter - write(trace): [{"service":"keycloak","name":"netty.request","resource":"POST /auth/","trace_id":6696721909509371158,"span_id":6893953318045788263,"parent_id":0,"start":1678704919399781791,"duration":280115977,"type":"web","error":0,"metrics":{"process_id":1,"_dd.agent_psr":1.0,"peer.port":40252,"http.status_code":302,"_sample_rate":1,"thread.id":61},"meta":{"http.query.string":"session_code=Mzl94RSMjZLOavftafDi99J33q4E8UjfdMvs6mWYJpI&execution=a579e879-2e5d-4748-a2c4-766400d8d0ba&client_id=security-admin-console&tab_id=LeJnAucoQ14","http.url":"http://localhost:8080/auth/realms/master/login-actions/authenticate","language":"jvm","thread.name":"vert.x-eventloop-thread-8","peer.ipv4":"127.0.0.1","http.hostname":"localhost","component":"netty","span.kind":"server","http.route":"/auth/","runtime-id":"3cdde5b1-0dff-47cc-8a3e-520c673a0fe0","http.method":"POST","http.useragent":"Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:109.0) Gecko/20100101 Firefox/110.0"}},{"service":"keycloak","name":"vertx.route-handler","resource":"QuarkusRequestFilter","trace_id":6696721909509371158,"span_id":8859241529839289166,"parent_id":6893953318045788263,"start":1678704919400053630,"duration":279651015,"type":"web","error":0,"metrics":{"http.status_code":302,"thread.id":61},"meta":{"language":"jvm","component":"jax-rs","thread.name":"vert.x-eventloop-thread-8","span.kind":"server"}},{"service":"keycloak","name":"jax-rs.request","resource":"LoginActionsService.authenticateForm","trace_id":6696721909509371158,"span_id":9145008775652896569,"parent_id":8859241529839289166,"start":1678704919409408007,"duration":269814981,"type":"web","error":0,"metrics":{"thread.id":73},"meta":{"thread.name":"executor-thread-3","component":"jax-rs-controller"}},{"service":"keycloak","name":"jax-rs.request","resource":"LoginActionsService.authenticate","trace_id":6696721909509371158,"span_id":6974686908185183412,"parent_id":9145008775652896569,"start":1678704919409589746,"duration":269616130,"type":"web","error":0,"metrics":{"thread.id":73},"meta":{"thread.name":"executor-thread-3","component":"jax-rs-controller"}},{"service":"h2","name":"h2.query","resource":"select requiredac0_.USER_ID as user_id2_78_1_, requiredac0_.REQUIRED_ACTION as required1_78_1_, requiredac0_.REQUIRED_ACTION as required1_78_0_, requiredac0_.USER_ID as user_id2_78_0_ from USER_REQUIRED_ACTION requiredac0_ where requiredac0_.USER_ID=?","trace_id":6696721909509371158,"span_id":5635757974146132409,"parent_id":6974686908185183412,"start":1678704919556394000,"duration":72639,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select attributes0_.USER_ID as user_id4_69_1_, attributes0_.ID as id1_69_1_, attributes0_.ID as id1_69_0_, attributes0_.NAME as name2_69_0_, attributes0_.USER_ID as user_id4_69_0_, attributes0_.VALUE as value3_69_0_ from USER_ATTRIBUTE attributes0_ where attributes0_.USER_ID=?","trace_id":6696721909509371158,"span_id":7961300448017954977,"parent_id":6974686908185183412,"start":1678704919554292270,"duration":103861,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select credential0_.ID as id1_19_, credential0_.CREATED_DATE as created_2_19_, credential0_.CREDENTIAL_DATA as credenti3_19_, credential0_.PRIORITY as priority4_19_, credential0_.SALT as salt5_19_, credential0_.SECRET_DATA as secret_d6_19_, credential0_.TYPE as type7_19_, credential0_.USER_ID as user_id9_19_, credential0_.USER_LABEL as user_lab8_19_ from CREDENTIAL credential0_ where credential0_.USER_ID=? order by credential0_.PRIORITY","trace_id":6696721909509371158,"span_id":5491933965638896762,"parent_id":6974686908185183412,"start":1678704919511472192,"duration":107003,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select userentity0_.ID as id1_72_, userentity0_.CREATED_TIMESTAMP as created_2_72_, userentity0_.EMAIL as email3_72_, userentity0_.EMAIL_CONSTRAINT as email_co4_72_, userentity0_.EMAIL_VERIFIED as email_ve5_72_, userentity0_.ENABLED as enabled6_72_, userentity0_.FEDERATION_LINK as federati7_72_, userentity0_.FIRST_NAME as first_na8_72_, userentity0_.LAST_NAME as last_nam9_72_, userentity0_.NOT_BEFORE as not_bef10_72_, userentity0_.REALM_ID as realm_i11_72_, userentity0_.SERVICE_ACCOUNT_CLIENT_LINK as service12_72_, userentity0_.USERNAME as usernam13_72_ from USER_ENTITY userentity0_ where userentity0_.USERNAME=? and userentity0_.REALM_ID=?","trace_id":6696721909509371158,"span_id":1185809454532355940,"parent_id":6974686908185183412,"start":1678704919434593421,"duration":154010,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"keycloak","name":"jax-rs.request","resource":"RealmsResource.getLoginActionsService","trace_id":6696721909509371158,"span_id":3983186596848283739,"parent_id":8859241529839289166,"start":1678704919400986631,"duration":598787,"type":"web","error":0,"metrics":{"thread.id":73},"meta":{"thread.name":"executor-thread-3","component":"jax-rs-controller"}}]
[dd.trace 2023-03-13 10:55:20:324 +0000] [vert.x-eventloop-thread-14] INFO datadog.trace.agent.common.writer.LoggingWriter - write(trace): [{"service":"keycloak","name":"netty.request","resource":"POST /auth/","trace_id":5007121394031863016,"span_id":5640605317864911392,"parent_id":0,"start":1678704920176354026,"duration":147084059,"type":"web","error":0,"metrics":{"process_id":1,"_dd.agent_psr":1.0,"peer.port":40258,"http.status_code":200,"_sample_rate":1,"thread.id":67},"meta":{"http.url":"http://localhost:8080/auth/realms/master/protocol/openid-connect/token","language":"jvm","thread.name":"vert.x-eventloop-thread-14","peer.ipv4":"127.0.0.1","http.hostname":"localhost","component":"netty","span.kind":"server","http.route":"/auth/","runtime-id":"3cdde5b1-0dff-47cc-8a3e-520c673a0fe0","http.method":"POST","http.useragent":"Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:109.0) Gecko/20100101 Firefox/110.0"}},{"service":"keycloak","name":"vertx.route-handler","resource":"QuarkusRequestFilter","trace_id":5007121394031863016,"span_id":9073056985310823542,"parent_id":5640605317864911392,"start":1678704920176772961,"duration":146361155,"type":"web","error":0,"metrics":{"http.status_code":200,"thread.id":67},"meta":{"language":"jvm","component":"jax-rs","thread.name":"vert.x-eventloop-thread-14","span.kind":"server"}},{"service":"keycloak","name":"jax-rs.request","resource":"TokenEndpoint.processGrantRequest","trace_id":5007121394031863016,"span_id":2302231470320236465,"parent_id":9073056985310823542,"start":1678704920195667155,"duration":123027492,"type":"web","error":0,"metrics":{"thread.id":73},"meta":{"thread.name":"executor-thread-3","component":"jax-rs-controller"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_, roleentity0_.CLIENT as client2_38_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_, roleentity0_.CLIENT_ROLE as client_r4_38_, roleentity0_.DESCRIPTION as descript5_38_, roleentity0_.NAME as name6_38_, roleentity0_.REALM_ID as realm_id7_38_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.CLIENT=? order by roleentity0_.NAME","trace_id":5007121394031863016,"span_id":1795161634283300467,"parent_id":2302231470320236465,"start":1678704920289736932,"duration":129774,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":1957571433380028935,"parent_id":2302231470320236465,"start":1678704920286383147,"duration":26471,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":1609475928643617534,"parent_id":2302231470320236465,"start":1678704920286206996,"duration":31500,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":8392979171537746223,"parent_id":2302231470320236465,"start":1678704920285819701,"duration":26332,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":4554673350479184865,"parent_id":2302231470320236465,"start":1678704920285651023,"duration":29615,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":3105049476703227666,"parent_id":2302231470320236465,"start":1678704920285286428,"duration":30034,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":8639369462668686262,"parent_id":2302231470320236465,"start":1678704920285121802,"duration":30103,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":3435728040098549676,"parent_id":2302231470320236465,"start":1678704920284712296,"duration":32967,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":1224792251785734960,"parent_id":2302231470320236465,"start":1678704920284559892,"duration":27450,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":7462033863109772316,"parent_id":2302231470320236465,"start":1678704920284254107,"duration":24865,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":2622223432301154867,"parent_id":2302231470320236465,"start":1678704920284078794,"duration":33806,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":7957741878668117401,"parent_id":2302231470320236465,"start":1678704920283470647,"duration":104559,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":4051352885868457883,"parent_id":2302231470320236465,"start":1678704920283248049,"duration":70404,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":1112375580330464077,"parent_id":2302231470320236465,"start":1678704920282781199,"duration":26751,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":3900148408240000808,"parent_id":2302231470320236465,"start":1678704920282602115,"duration":31500,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":107761974299910943,"parent_id":2302231470320236465,"start":1678704920282199035,"duration":27589,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":6209293793378669090,"parent_id":2302231470320236465,"start":1678704920282006121,"duration":31500,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":2213907122814738640,"parent_id":2302231470320236465,"start":1678704920281670232,"duration":29056,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":6986769902605514542,"parent_id":2302231470320236465,"start":1678704920281492056,"duration":30592,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":2686637160829031673,"parent_id":2302231470320236465,"start":1678704920281111675,"duration":34085,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":7454336038543612871,"parent_id":2302231470320236465,"start":1678704920280845633,"duration":42955,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":8447182450373957369,"parent_id":2302231470320236465,"start":1678704920280190270,"duration":31919,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":6607774536953610301,"parent_id":2302231470320236465,"start":1678704920280006575,"duration":31012,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":8263023323382976999,"parent_id":2302231470320236465,"start":1678704920279617674,"duration":23957,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":523004904850036937,"parent_id":2302231470320236465,"start":1678704920279458565,"duration":28637,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":7729916523030471937,"parent_id":2302231470320236465,"start":1678704920279119045,"duration":43304,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":6783722454811765503,"parent_id":2302231470320236465,"start":1678704920278925782,"duration":47495,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":2673531565208392724,"parent_id":2302231470320236465,"start":1678704920278549872,"duration":27589,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":1456259264528546009,"parent_id":2302231470320236465,"start":1678704920278350671,"duration":51337,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":4047703321760670657,"parent_id":2302231470320236465,"start":1678704920277951992,"duration":69845,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":5307126606367017218,"parent_id":2302231470320236465,"start":1678704920277770951,"duration":30523,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":3622516699106743625,"parent_id":2302231470320236465,"start":1678704920277440301,"duration":35203,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":5839054657207207882,"parent_id":2302231470320236465,"start":1678704920277264988,"duration":31501,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":6609643642370306431,"parent_id":2302231470320236465,"start":1678704920276935735,"duration":26681,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":2023527479575370219,"parent_id":2302231470320236465,"start":1678704920276764404,"duration":31989,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":4623229488569014320,"parent_id":2302231470320236465,"start":1678704920276416572,"duration":27728,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":3469750478594964683,"parent_id":2302231470320236465,"start":1678704920276226940,"duration":33875,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":694911702101178426,"parent_id":2302231470320236465,"start":1678704920275847468,"duration":31710,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":2050586861845677993,"parent_id":2302231470320236465,"start":1678704920275605452,"duration":37088,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":7086992418225768035,"parent_id":2302231470320236465,"start":1678704920274783786,"duration":40302,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":456645671563208230,"parent_id":2302231470320236465,"start":1678704920273701177,"duration":31221,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":4592244406931934770,"parent_id":2302231470320236465,"start":1678704920273425006,"duration":45540,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":5851313596169035255,"parent_id":2302231470320236465,"start":1678704920272686457,"duration":45959,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":8633049062684361357,"parent_id":2302231470320236465,"start":1678704920272303074,"duration":78087,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select compositer0_.COMPOSITE as composit1_18_0_, compositer0_.CHILD_ROLE as child_ro2_18_0_, roleentity1_.ID as id1_38_1_, roleentity1_.CLIENT as client2_38_1_, roleentity1_.CLIENT_REALM_CONSTRAINT as client_r3_38_1_, roleentity1_.CLIENT_ROLE as client_r4_38_1_, roleentity1_.DESCRIPTION as descript5_38_1_, roleentity1_.NAME as name6_38_1_, roleentity1_.REALM_ID as realm_id7_38_1_ from COMPOSITE_ROLE compositer0_ inner join KEYCLOAK_ROLE roleentity1_ on compositer0_.CHILD_ROLE=roleentity1_.ID where compositer0_.COMPOSITE=?","trace_id":5007121394031863016,"span_id":6594047708601843602,"parent_id":2302231470320236465,"start":1678704920270968530,"duration":47844,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select roleentity0_.ID as id1_38_0_, roleentity0_.CLIENT as client2_38_0_, roleentity0_.CLIENT_REALM_CONSTRAINT as client_r3_38_0_, roleentity0_.CLIENT_ROLE as client_r4_38_0_, roleentity0_.DESCRIPTION as descript5_38_0_, roleentity0_.NAME as name6_38_0_, roleentity0_.REALM_ID as realm_id7_38_0_ from KEYCLOAK_ROLE roleentity0_ where roleentity0_.ID=?","trace_id":5007121394031863016,"span_id":3074336266161414372,"parent_id":2302231470320236465,"start":1678704920270206163,"duration":53432,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select userrolema0_.ROLE_ID as col_0_0_ from USER_ROLE_MAPPING userrolema0_ where userrolema0_.USER_ID=?","trace_id":5007121394031863016,"span_id":5953845621775667216,"parent_id":2302231470320236465,"start":1678704920269095266,"duration":82418,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select usergroupm0_.GROUP_ID as col_0_0_ from USER_GROUP_MEMBERSHIP usergroupm0_ where usergroupm0_.USER_ID=?","trace_id":5007121394031863016,"span_id":3287395236366024540,"parent_id":2302231470320236465,"start":1678704920260246084,"duration":124116,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select userentity0_.ID as id1_72_0_, userentity0_.CREATED_TIMESTAMP as created_2_72_0_, userentity0_.EMAIL as email3_72_0_, userentity0_.EMAIL_CONSTRAINT as email_co4_72_0_, userentity0_.EMAIL_VERIFIED as email_ve5_72_0_, userentity0_.ENABLED as enabled6_72_0_, userentity0_.FEDERATION_LINK as federati7_72_0_, userentity0_.FIRST_NAME as first_na8_72_0_, userentity0_.LAST_NAME as last_nam9_72_0_, userentity0_.NOT_BEFORE as not_bef10_72_0_, userentity0_.REALM_ID as realm_i11_72_0_, userentity0_.SERVICE_ACCOUNT_CLIENT_LINK as service12_72_0_, userentity0_.USERNAME as usernam13_72_0_ from USER_ENTITY userentity0_ where userentity0_.ID=?","trace_id":5007121394031863016,"span_id":7719103983117186283,"parent_id":2302231470320236465,"start":1678704920205615919,"duration":141368,"type":"sql","error":0,"metrics":{"thread.id":73},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"keycloak","name":"jax-rs.request","resource":"OIDCLoginProtocolService.token","trace_id":5007121394031863016,"span_id":1014445115980986953,"parent_id":9073056985310823542,"start":1678704920177958314,"duration":14675578,"type":"web","error":0,"metrics":{"thread.id":73},"meta":{"thread.name":"executor-thread-3","component":"jax-rs-controller"}},{"service":"keycloak","name":"jax-rs.request","resource":"RealmsResource.getProtocol","trace_id":5007121394031863016,"span_id":1672874459460155951,"parent_id":9073056985310823542,"start":1678704920177650573,"duration":236847,"type":"web","error":0,"metrics":{"thread.id":73},"meta":{"thread.name":"executor-thread-3","component":"jax-rs-controller"}}]

froque avatar Mar 13 '23 11:03 froque

I'm gonna build a smoke test for keycloak, what version of it are you running?

devinsba avatar Mar 13 '23 16:03 devinsba

we are running version 18

froque avatar Mar 13 '23 16:03 froque

Seeing the same issue on keycloak 20 with agent 1.10.1

pcasaes avatar Mar 30 '23 16:03 pcasaes

We were able to improve things a bit by enabling these flags https://github.com/DataDog/dd-trace-java/issues/5042

pcasaes avatar Apr 07 '23 22:04 pcasaes

@devinsba any news ? Is the method mentioned by @pcasaes the recommended solution ?

froque avatar Apr 10 '23 09:04 froque

Running against latest v1.20.1 is not yet fixed.

Testing with the flags in https://github.com/DataDog/dd-trace-java/issues/5042 produces a different output but not correct

export VERSION="1.20.1"

wget -nc https://github.com/DataDog/dd-trace-java/releases/download/v$VERSION/dd-java-agent-$VERSION.jar

docker run \
    -d \
    --rm \
    --name keycloak  \
    --network host \
    -e KEYCLOAK_ADMIN=admin \
    -e KEYCLOAK_ADMIN_PASSWORD=admin \
    -e "KC_HTTP_RELATIVE_PATH=/auth" \
    -e DD_SERVICE=keycloak \
    -e DD_WRITER_TYPE=LoggingWriter \
    -e DD_INTEGRATION_VERTX_ENABLED=false \
    -e DD_LEGACY_INSTALLER_ENABLED=true \
    -e DD_TRACE_EXECUTORS=org.jboss.threads.EnhancedQueueExecutor \
    -e JAVA_TOOL_OPTIONS="-javaagent:/opt/dd-java-agent.jar" \
    -v $(pwd)/dd-java-agent-$VERSION.jar:/opt/dd-java-agent.jar:ro \
    quay.io/keycloak/keycloak \
        start-dev 

# login into http://localhost:8080/auth/admin/master/console with user:admin and pass:admin

docker logs keycloak >& dd-java-agent-$VERSION.flags.log

docker stop keycloak

❯ grep "POST /" dd-java-agent-1.20.1.flags.log     
[dd.trace 2023-09-11 10:15:41:165 +0000] [vert.x-eventloop-thread-5] INFO datadog.trace.agent.common.writer.LoggingWriter - write(trace): [{"service":"keycloak","name":"netty.request","resource":"POST /authenticate","trace_id":4385698409063097819,"span_id":8031097394179352387,"parent_id":0,"start":1694427340627098611,"duration":537529273,"type":"web","error":0,"metrics":{"process_id":1,"_dd.profiling.enabled":0,"_dd.agent_psr":1.0,"peer.port":55480,"http.status_code":302,"_sample_rate":1,"_dd.trace_span_attribute_schema":0,"thread.id":59},"meta":{"http.query.string":"session_code=-KomEVG4zXvJVw6tEQv1rTE3nIQzSBzQelyi-ZG55V0&execution=34adc78a-4938-4b72-9b14-5ba1304a7b32&client_id=security-admin-console&tab_id=m6aRjsSNunA","http.url":"http://localhost:8080/auth/realms/master/login-actions/authenticate","language":"jvm","thread.name":"vert.x-eventloop-thread-5","peer.ipv4":"127.0.0.1","http.hostname":"localhost","component":"jakarta-rs","span.kind":"server","http.route":"/authenticate","runtime-id":"5e9d3be0-b70e-430f-a857-65ab194ed63f","http.method":"POST","http.useragent":"Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:109.0) Gecko/20100101 Firefox/117.0"}},{"service":"keycloak","name":"jakarta-rs.request","resource":"LoginActionsService.authenticateForm","trace_id":4385698409063097819,"span_id":7200345064318415739,"parent_id":8031097394179352387,"start":1694427340644813347,"duration":513966078,"type":"web","error":0,"metrics":{"thread.id":74},"meta":{"thread.name":"executor-thread-3","component":"jakarta-rs-controller"}},{"service":"keycloak","name":"jakarta-rs.request","resource":"LoginActionsService.authenticate","trace_id":4385698409063097819,"span_id":7125657829396392457,"parent_id":7200345064318415739,"start":1694427340645062798,"duration":513700056,"type":"web","error":0,"metrics":{"thread.id":74},"meta":{"thread.name":"executor-thread-3","component":"jakarta-rs-controller"}},{"service":"h2","name":"h2.query","resource":"select r1_0.USER_ID,r1_0.REQUIRED_ACTION from USER_REQUIRED_ACTION r1_0 where array_contains(?,r1_0.USER_ID)","trace_id":4385698409063097819,"span_id":7877303038787021837,"parent_id":7125657829396392457,"start":1694427340819504477,"duration":82255,"type":"sql","error":0,"metrics":{"thread.id":74},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select a1_0.USER_ID,a1_0.ID,a1_0.NAME,a1_0.VALUE from USER_ATTRIBUTE a1_0 where array_contains(?,a1_0.USER_ID)","trace_id":4385698409063097819,"span_id":7292595741431861973,"parent_id":7125657829396392457,"start":1694427340816605750,"duration":108124,"type":"sql","error":0,"metrics":{"thread.id":74},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select c1_0.ID,c1_0.CREATED_DATE,c1_0.CREDENTIAL_DATA,c1_0.PRIORITY,c1_0.SALT,c1_0.SECRET_DATA,c1_0.TYPE,c1_0.USER_ID,c1_0.USER_LABEL from CREDENTIAL c1_0 where c1_0.USER_ID=? order by c1_0.PRIORITY","trace_id":4385698409063097819,"span_id":7963773538053451998,"parent_id":7125657829396392457,"start":1694427340743938646,"duration":137109,"type":"sql","error":0,"metrics":{"thread.id":74},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"h2","name":"h2.query","resource":"select u1_0.ID,u1_0.CREATED_TIMESTAMP,u1_0.EMAIL,u1_0.EMAIL_CONSTRAINT,u1_0.EMAIL_VERIFIED,u1_0.ENABLED,u1_0.FEDERATION_LINK,u1_0.FIRST_NAME,u1_0.LAST_NAME,u1_0.NOT_BEFORE,u1_0.REALM_ID,u1_0.SERVICE_ACCOUNT_CLIENT_LINK,u1_0.USERNAME from USER_ENTITY u1_0 where u1_0.USERNAME=? and u1_0.REALM_ID=?","trace_id":4385698409063097819,"span_id":2860565777865748610,"parent_id":7125657829396392457,"start":1694427340661621895,"duration":205758,"type":"sql","error":0,"metrics":{"thread.id":74},"meta":{"db.instance":"/opt/keycloak/bin/../data/h2/keycloakdb","component":"java-jdbc-prepared_statement","db.type":"h2","span.kind":"client","db.operation":"select","thread.name":"executor-thread-3"}},{"service":"keycloak","name":"jakarta-rs.request","resource":"RealmsResource.getLoginActionsService","trace_id":4385698409063097819,"span_id":4996058654159983684,"parent_id":8031097394179352387,"start":1694427340628842139,"duration":451852,"type":"web","error":0,"metrics":{"thread.id":74},"meta":{"thread.name":"executor-thread-3","component":"jakarta-rs-controller"}}]

froque avatar Sep 11 '23 10:09 froque

Good afternoon. This is still happening. Any news?

Catarina-Lima avatar Mar 18 '24 17:03 Catarina-Lima

Setting these environment variable made the resource names same as full path groups.

ENV DD_HTTP_SERVER_ROUTE_BASED_NAMING="false" ENV DD_TRACE_EXECUTORS="org.jboss.threads.EnhancedQueueExecutor"

pnamburi-chwy avatar Jun 17 '24 15:06 pnamburi-chwy

@pnamburi-chwy thanks. that is very helpful.

This can now be closed.

froque avatar Jun 20 '24 08:06 froque