Jetty log (trace level):
```
2021-03-11 10:43:25,037 DEBUG [qtp790067787-200154] [org.gluu.service.ExternalResourceHandler] (ExternalResourceHandler.java:68) - Found overriden resource: /casa/login.xhtml
2021-03-11 10:43:25,038 DEBUG [qtp790067787-200154] [org.gluu.service.ExternalResourceHandler] (ExternalResourceHandler.java:68) - Found overriden resource: /casa/login.xhtml
2021-03-11 10:43:25,038 DEBUG [qtp790067787-200154] [org.gluu.service.ExternalResourceHandler] (ExternalResourceHandler.java:68) - Found overriden resource: /casa/login-template.xhtml
2021-03-11 10:43:25,040 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.CookieService] (CookieService.java:141) - Found cookie: '6369f5fd-924c-4f85-95ec-23006d6a5173'
2021-03-11 10:43:25,044 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:744) - Try to get session by id: 6369f5fd-924c-4f85-95ec-23006d6a5173 ...
2021-03-11 10:43:25,044 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:746) - Session dn: oxId=6369f5fd-924c-4f85-95ec-23006d6a5173,ou=sessions,o=gluu
2021-03-11 10:43:25,044 TRACE [qtp790067787-200154] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:188) - Authenticating ... (interactive: true, skipPassword: false, credentials.username: testuser123)
2021-03-11 10:43:25,044 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.CookieService] (CookieService.java:141) - Found cookie: '6369f5fd-924c-4f85-95ec-23006d6a5173'
2021-03-11 10:43:25,047 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:744) - Try to get session by id: 6369f5fd-924c-4f85-95ec-23006d6a5173 ...
2021-03-11 10:43:25,047 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:746) - Session dn: oxId=6369f5fd-924c-4f85-95ec-23006d6a5173,ou=sessions,o=gluu
2021-03-11 10:43:25,049 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.common.UserService] (UserService.java:172) - Getting user information from LDAP: attributeName = 'uid', attributeValue = 'testuser123'
2021-03-11 10:43:25,051 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.common.UserService] (UserService.java:187) - Found '1' entries
2021-03-11 10:43:25,052 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:123) - Authenticating user with LDAP: username: 'testuser123', credentials: '1669335800'
2021-03-11 10:43:25,052 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:393) - Attempting to find userDN by primary key: 'samAccountName' and key value: 'testuser123', credentials: '1669335800'
2021-03-11 10:43:25,052 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:496) - Getting user information from LDAP: attributeName = 'samAccountName', attributeValue = 'testuser123'
2021-03-11 10:43:25,052 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:511) - Searching user by attributes: '[Attribute [name=samAccountName, values=[testuser123]]]', baseDn: 'OU=People,DC=dmawi,DC=de'
2021-03-11 10:43:25,070 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:513) - Found '1' entries
2021-03-11 10:43:25,078 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:416) - Attempting to authenticate userDN: CN=testuser123,OU=People,DC=dmawi,DC=de
2021-03-11 10:43:25,081 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:418) - User authenticated: CN=testuser123,OU=People,DC=dmawi,DC=de
2021-03-11 10:43:25,081 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:420) - Attempting to find userDN by local primary key: uid
2021-03-11 10:43:25,081 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.common.UserService] (UserService.java:172) - Getting user information from LDAP: attributeName = 'uid', attributeValue = 'testuser123'
2021-03-11 10:43:25,084 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.common.UserService] (UserService.java:187) - Found '1' entries
2021-03-11 10:43:25,085 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:430) - authenticate_external: credentials: '1669335800', credentials.userName: 'testuser123', authenticatedUser.userId: 'testuser123'
2021-03-11 10:43:25,085 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.CookieService] (CookieService.java:141) - Found cookie: '6369f5fd-924c-4f85-95ec-23006d6a5173'
2021-03-11 10:43:25,087 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:744) - Try to get session by id: 6369f5fd-924c-4f85-95ec-23006d6a5173 ...
2021-03-11 10:43:25,088 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:746) - Session dn: oxId=6369f5fd-924c-4f85-95ec-23006d6a5173,ou=sessions,o=gluu
2021-03-11 10:43:25,094 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.CookieService] (CookieService.java:141) - Found cookie: '6369f5fd-924c-4f85-95ec-23006d6a5173'
2021-03-11 10:43:25,096 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:744) - Try to get session by id: 6369f5fd-924c-4f85-95ec-23006d6a5173 ...
2021-03-11 10:43:25,096 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:746) - Session dn: oxId=6369f5fd-924c-4f85-95ec-23006d6a5173,ou=sessions,o=gluu
2021-03-11 10:43:25,100 TRACE [qtp790067787-200154] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:336) - #########################################################################
2021-03-11 10:43:25,100 TRACE [qtp790067787-200154] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:337) - ++++++++++++++++++++++++++++++++++++++++++CURRENT ACR:casa
2021-03-11 10:43:25,100 TRACE [qtp790067787-200154] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:338) - ++++++++++++++++++++++++++++++++++++++++++CURRENT STEP:1
2021-03-11 10:43:25,100 TRACE [qtp790067787-200154] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:341) - According to API version script supports steps overriding
2021-03-11 10:43:25,100 DEBUG [qtp790067787-200154] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:344) - Get next step from script: '-1'
2021-03-11 10:43:25,101 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:748) - Attempting to store extraParameters: [ACR, methods, trustedDevicesInfo, casa_contextPath, casa_prefix, casa_faviconUrl, casa_extraCss, casa_logoUrl]
2021-03-11 10:43:25,101 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:767) - Storing sessionIdAttributes: {auth_external_attributes=[{"casa_logoUrl":"java.lang.String"},{"externalProviders":"java.lang.String"},{"casa_faviconUrl":"java.lang.String"},{"casa_prefix":"java.lang.String"},{"casa_contextPath":"java.lang.String"}], opbs=1ccc70f4-1b05-49b8-8ffe-d8584fff47b9, externalProviders={"helmholtzsaml": {"displayName": "(supports DFN / GEANT / eduGAIN)", "logo_img": "../../ext/resources/img/passport/2017_H_Logo_RGB_EN.png", "saml": true}}, response_type=code, nonce=p1mck1ftbmcos1agfsd1a972gp, client_id=2c71bef7-3035-416c-8649-eccf61138926, auth_step=1, acr=casa, casa_logoUrl=/casa/images/logo.png, remote_ip=172.26.1.220, scope=openid profile user_name clientinfo oxd, acr_values=casa, casa_faviconUrl=/casa/images/favicon.ico, redirect_uri=https://login.mydomain.com/casa, state=2q6rlvj96ucjrfjk85bhgf2uum, casa_prefix=, casa_contextPath=/casa, casa_extraCss=null}
2021-03-11 10:43:25,101 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:768) - Storing authExternalAttributes: {casa_logoUrl=java.lang.String, externalProviders=java.lang.String, casa_faviconUrl=java.lang.String, casa_prefix=java.lang.String, casa_contextPath=java.lang.String}
2021-03-11 10:43:25,102 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.CookieService] (CookieService.java:141) - Found cookie: '6369f5fd-924c-4f85-95ec-23006d6a5173'
2021-03-11 10:43:25,104 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:744) - Try to get session by id: 6369f5fd-924c-4f85-95ec-23006d6a5173 ...
2021-03-11 10:43:25,104 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:746) - Session dn: oxId=6369f5fd-924c-4f85-95ec-23006d6a5173,ou=sessions,o=gluu
2021-03-11 10:43:25,104 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:748) - Attempting to store extraParameters: [ACR, methods, trustedDevicesInfo, casa_contextPath, casa_prefix, casa_faviconUrl, casa_extraCss, casa_logoUrl]
2021-03-11 10:43:25,104 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:767) - Storing sessionIdAttributes: {auth_external_attributes=[{"casa_logoUrl":"java.lang.String"},{"externalProviders":"java.lang.String"},{"casa_faviconUrl":"java.lang.String"},{"casa_prefix":"java.lang.String"},{"casa_contextPath":"java.lang.String"}], opbs=1ccc70f4-1b05-49b8-8ffe-d8584fff47b9, externalProviders={"helmholtzsaml": {"displayName": "(supports DFN / GEANT / eduGAIN)", "logo_img": "../../ext/resources/img/passport/2017_H_Logo_RGB_EN.png", "saml": true}}, response_type=code, nonce=p1mck1ftbmcos1agfsd1a972gp, client_id=2c71bef7-3035-416c-8649-eccf61138926, auth_step=1, acr=casa, casa_logoUrl=/casa/images/logo.png, remote_ip=172.26.1.220, scope=openid profile user_name clientinfo oxd, acr_values=casa, casa_faviconUrl=/casa/images/favicon.ico, redirect_uri=https://login.mydomain.com/casa, state=2q6rlvj96ucjrfjk85bhgf2uum, casa_prefix=, casa_contextPath=/casa, casa_extraCss=null, auth_user=testuser123}
2021-03-11 10:43:25,104 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:768) - Storing authExternalAttributes: {casa_logoUrl=java.lang.String, externalProviders=java.lang.String, casa_faviconUrl=java.lang.String, casa_prefix=java.lang.String, casa_contextPath=java.lang.String}
2021-03-11 10:43:25,104 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:572) - configureSessionUser: credentials: '1669335800', sessionId: 'SessionId {dn='oxId=6369f5fd-924c-4f85-95ec-23006d6a5173,ou=sessions,o=gluu', id='6369f5fd-924c-4f85-95ec-23006d6a5173', lastUsedAt=Thu Mar 11 10:43:25 UTC 2021, userDn='null', authenticationTime=Thu Mar 11 10:43:04 UTC 2021, state=unauthenticated, sessionState='2cf0f721d61a92e1e2678f1416d8b8935be708e2df662dbcca030b3fe50834f2.916c955d-e8b1-47a8-ba00-d147323bb384', permissionGranted=null, isJwt=false, jwt=null, permissionGrantedMap=SessionIdAccessMap{permissionGranted={2c71bef7-3035-416c-8649-eccf61138926=false}}, sessionAttributes={auth_external_attributes=[{"casa_logoUrl":"java.lang.String"},{"externalProviders":"java.lang.String"},{"casa_faviconUrl":"java.lang.String"},{"casa_prefix":"java.lang.String"},{"casa_contextPath":"java.lang.String"}], opbs=1ccc70f4-1b05-49b8-8ffe-d8584fff47b9, externalProviders={"helmholtzsaml": {"displayName": "(supports DFN / GEANT / eduGAIN)", "logo_img": "../../ext/resources/img/passport/2017_H_Logo_RGB_EN.png", "saml": true}}, response_type=code, nonce=p1mck1ftbmcos1agfsd1a972gp, client_id=2c71bef7-3035-416c-8649-eccf61138926, auth_step=1, acr=casa, casa_logoUrl=/casa/images/logo.png, remote_ip=172.26.1.220, scope=openid profile user_name clientinfo oxd, acr_values=casa, casa_faviconUrl=/casa/images/favicon.ico, redirect_uri=https://login.mydomain.com/casa, state=2q6rlvj96ucjrfjk85bhgf2uum, casa_prefix=, casa_contextPath=/casa, casa_extraCss=null, auth_user=testuser123}, persisted=false}', credentials.userName: 'testuser123', authenticatedUser.userId: 'testuser123'
2021-03-11 10:43:25,105 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:578) - configureSessionUser sessionId: 'SessionId {dn='oxId=6369f5fd-924c-4f85-95ec-23006d6a5173,ou=sessions,o=gluu', id='6369f5fd-924c-4f85-95ec-23006d6a5173', lastUsedAt=Thu Mar 11 10:43:25 UTC 2021, userDn='null', authenticationTime=Thu Mar 11 10:43:04 UTC 2021, state=unauthenticated, sessionState='2cf0f721d61a92e1e2678f1416d8b8935be708e2df662dbcca030b3fe50834f2.916c955d-e8b1-47a8-ba00-d147323bb384', permissionGranted=null, isJwt=false, jwt=null, permissionGrantedMap=SessionIdAccessMap{permissionGranted={2c71bef7-3035-416c-8649-eccf61138926=false}}, sessionAttributes={auth_external_attributes=[{"casa_logoUrl":"java.lang.String"},{"externalProviders":"java.lang.String"},{"casa_faviconUrl":"java.lang.String"},{"casa_prefix":"java.lang.String"},{"casa_contextPath":"java.lang.String"}], opbs=1ccc70f4-1b05-49b8-8ffe-d8584fff47b9, externalProviders={"helmholtzsaml": {"displayName": "(supports DFN / GEANT / eduGAIN)", "logo_img": "../../ext/resources/img/passport/2017_H_Logo_RGB_EN.png", "saml": true}}, response_type=code, nonce=p1mck1ftbmcos1agfsd1a972gp, client_id=2c71bef7-3035-416c-8649-eccf61138926, auth_step=1, acr=casa, casa_logoUrl=/casa/images/logo.png, remote_ip=172.26.1.220, scope=openid profile user_name clientinfo oxd, acr_values=casa, casa_faviconUrl=/casa/images/favicon.ico, redirect_uri=https://login.mydomain.com/casa, state=2q6rlvj96ucjrfjk85bhgf2uum, casa_prefix=, casa_contextPath=/casa, casa_extraCss=null, auth_user=testuser123}, persisted=false}', sessionId.auth_user: 'testuser123'
2021-03-11 10:43:25,105 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:491) - Changing session id from 6369f5fd-924c-4f85-95ec-23006d6a5173 to 989684cf-c26a-47a3-9e50-36e184ec78f9 ...
2021-03-11 10:43:25,107 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:541) - sessionIdAttributes: SessionIdAccessMap{permissionGranted={2c71bef7-3035-416c-8649-eccf61138926=false}}
2021-03-11 10:43:25,110 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.CookieService] (CookieService.java:141) - Found cookie: '["6369f5fd-924c-4f85-95ec-23006d6a5173"]'
2021-03-11 10:43:25,111 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:744) - Try to get session by id: 6369f5fd-924c-4f85-95ec-23006d6a5173 ...
2021-03-11 10:43:25,112 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:758) - Failed to get session by id: 6369f5fd-924c-4f85-95ec-23006d6a5173
2021-03-11 10:43:25,112 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:502) - Session identifier changed from 6369f5fd-924c-4f85-95ec-23006d6a5173 to 989684cf-c26a-47a3-9e50-36e184ec78f9 .
2021-03-11 10:43:25,112 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:508) - Authenticated session, id = '989684cf-c26a-47a3-9e50-36e184ec78f9', state = 'authenticated', persisted = 'true'
2021-03-11 10:43:25,112 DEBUG [qtp790067787-200154] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:429) - Sending event to trigger user redirection: 'testuser123'
2021-03-11 10:43:25,112 INFO [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:684) - Attempting to redirect user: SessionUser: SessionId {dn='oxId=989684cf-c26a-47a3-9e50-36e184ec78f9,ou=sessions,o=gluu', id='989684cf-c26a-47a3-9e50-36e184ec78f9', lastUsedAt=Thu Mar 11 10:43:25 UTC 2021, userDn='inum=0000!4084.40DF,ou=people,o=gluu', authenticationTime=Thu Mar 11 10:43:25 UTC 2021, state=authenticated, sessionState='2cf0f721d61a92e1e2678f1416d8b8935be708e2df662dbcca030b3fe50834f2.916c955d-e8b1-47a8-ba00-d147323bb384', permissionGranted=null, isJwt=false, jwt=null, permissionGrantedMap=SessionIdAccessMap{permissionGranted={2c71bef7-3035-416c-8649-eccf61138926=false}}, sessionAttributes={auth_external_attributes=[{"casa_logoUrl":"java.lang.String"},{"externalProviders":"java.lang.String"},{"casa_faviconUrl":"java.lang.String"},{"casa_prefix":"java.lang.String"},{"casa_contextPath":"java.lang.String"}], opbs=1ccc70f4-1b05-49b8-8ffe-d8584fff47b9, externalProviders={"helmholtzsaml": {"displayName": "(supports DFN / GEANT / eduGAIN)", "logo_img": "../../ext/resources/img/passport/2017_H_Logo_RGB_EN.png", "saml": true}}, response_type=code, nonce=p1mck1ftbmcos1agfsd1a972gp, client_id=2c71bef7-3035-416c-8649-eccf61138926, auth_step=1, acr=casa, casa_logoUrl=/casa/images/logo.png, remote_ip=172.26.1.220, scope=openid profile user_name clientinfo oxd, acr_values=casa, casa_faviconUrl=/casa/images/favicon.ico, redirect_uri=https://login.mydomain.com/casa, state=2q6rlvj96ucjrfjk85bhgf2uum, casa_prefix=, casa_contextPath=/casa, casa_extraCss=null, auth_user=testuser123}, persisted=true}
2021-03-11 10:43:25,112 INFO [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:692) - Attempting to redirect user: User: org.gluu.oxauth.model.common.User@2960d725
2021-03-11 10:43:25,112 TRACE [qtp790067787-200154] [org.gluu.oxauth.service.AuthenticationService] (AuthenticationService.java:703) - Logged in successfully! User: org.gluu.oxauth.model.common.User@2960d725, page: /authorize.xhtml, map: {scope=openid profile user_name clientinfo oxd, acr_values=casa, response_type=code, redirect_uri=https://login.mydomain.com/casa, state=2q6rlvj96ucjrfjk85bhgf2uum, nonce=p1mck1ftbmcos1agfsd1a972gp, client_id=2c71bef7-3035-416c-8649-eccf61138926}
2021-03-11 10:43:25,112 INFO [qtp790067787-200154] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:432) - Authentication success for User: 'testuser123'
2021-03-11 10:43:25,113 TRACE [qtp790067787-200154] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:219) - Authentication successfully for 'testuser123'
2021-03-11 10:43:25,183 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=2c71bef7-3035-416c-8649-eccf61138926,ou=clients,o=gluu'
2021-03-11 10:43:25,183 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=2c71bef7-3035-416c-8649-eccf61138926,ou=clients,o=gluu': 'DeletableEntity{expirationDate=null, deletable=false} BaseEntry [dn=null]'
2021-03-11 10:43:25,183 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=2c71bef7-3035-416c-8649-eccf61138926,ou=clients,o=gluu'
2021-03-11 10:43:25,184 DEBUG [qtp790067787-202520] [org.gluu.oxauth.service.ClientService] (ClientService.java:135) - Found 1 entries for client id = 2c71bef7-3035-416c-8649-eccf61138926
2021-03-11 10:43:25,184 DEBUG [qtp790067787-202520] [org.gluu.oxauth.model.authorize.ScopeChecker] (ScopeChecker.java:58) - Checking scopes policy for: [openid, profile, user_name, clientinfo, oxd]
2021-03-11 10:43:25,184 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=6D90,ou=scopes,o=gluu'
2021-03-11 10:43:25,184 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=6D90,ou=scopes,o=gluu': 'Scope{dn='inum=6D90,ou=scopes,o=gluu', inum='6D90', displayName='oxd', id='oxd', iconUrl='null', description='oxd scope which is required to call oxd API', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,184 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=6D90,ou=scopes,o=gluu'
2021-03-11 10:43:25,185 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'oxd': 'Scope{dn='inum=6D90,ou=scopes,o=gluu', inum='6D90', displayName='oxd', id='oxd', iconUrl='null', description='oxd scope which is required to call oxd API', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,185 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=F0C4,ou=scopes,o=gluu'
2021-03-11 10:43:25,185 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=F0C4,ou=scopes,o=gluu': 'Scope{dn='inum=F0C4,ou=scopes,o=gluu', inum='F0C4', displayName='null', id='openid', iconUrl='null', description='Authenticate using OpenID Connect.', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,185 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=F0C4,ou=scopes,o=gluu'
2021-03-11 10:43:25,185 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'openid': 'Scope{dn='inum=F0C4,ou=scopes,o=gluu', inum='F0C4', displayName='null', id='openid', iconUrl='null', description='Authenticate using OpenID Connect.', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,185 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=43F1,ou=scopes,o=gluu'
2021-03-11 10:43:25,186 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=43F1,ou=scopes,o=gluu': 'Scope{dn='inum=43F1,ou=scopes,o=gluu', inum='43F1', displayName='profile', id='profile', iconUrl='null', description='View your basic profile info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=0C85,ou=attributes,o=gluu, inum=B4B0,ou=attributes,o=gluu, inum=A0E8,ou=attributes,o=gluu, inum=5EC6,ou=attributes,o=gluu, inum=B52A,ou=attributes,o=gluu, inum=64A0,ou=attributes,o=gluu, inum=EC3A,ou=attributes,o=gluu, inum=3B47,ou=attributes,o=gluu, inum=3692,ou=attributes,o=gluu, inum=98FC,ou=attributes,o=gluu, inum=A901,ou=attributes,o=gluu, inum=36D9,ou=attributes,o=gluu, inum=BE64,ou=attributes,o=gluu, inum=6493,ou=attributes,o=gluu], defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=ScopeAttributes{spontaneousClientId='null'spontaneousClientScopes='null'notShowInDiscovery='false'}}'
2021-03-11 10:43:25,186 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=43F1,ou=scopes,o=gluu'
2021-03-11 10:43:25,186 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'profile': 'Scope{dn='inum=43F1,ou=scopes,o=gluu', inum='43F1', displayName='profile', id='profile', iconUrl='null', description='View your basic profile info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=0C85,ou=attributes,o=gluu, inum=B4B0,ou=attributes,o=gluu, inum=A0E8,ou=attributes,o=gluu, inum=5EC6,ou=attributes,o=gluu, inum=B52A,ou=attributes,o=gluu, inum=64A0,ou=attributes,o=gluu, inum=EC3A,ou=attributes,o=gluu, inum=3B47,ou=attributes,o=gluu, inum=3692,ou=attributes,o=gluu, inum=98FC,ou=attributes,o=gluu, inum=A901,ou=attributes,o=gluu, inum=36D9,ou=attributes,o=gluu, inum=BE64,ou=attributes,o=gluu, inum=6493,ou=attributes,o=gluu], defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=ScopeAttributes{spontaneousClientId='null'spontaneousClientScopes='null'notShowInDiscovery='false'}}'
2021-03-11 10:43:25,186 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=10B2,ou=scopes,o=gluu'
2021-03-11 10:43:25,186 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=10B2,ou=scopes,o=gluu': 'Scope{dn='inum=10B2,ou=scopes,o=gluu', inum='10B2', displayName='null', id='user_name', iconUrl='null', description='View your local username in the Gluu Server.', scopeType=openid, oxAuthClaims=[inum=42E0,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,187 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=10B2,ou=scopes,o=gluu'
2021-03-11 10:43:25,187 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'user_name': 'Scope{dn='inum=10B2,ou=scopes,o=gluu', inum='10B2', displayName='null', id='user_name', iconUrl='null', description='View your local username in the Gluu Server.', scopeType=openid, oxAuthClaims=[inum=42E0,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,187 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=341A,ou=scopes,o=gluu'
2021-03-11 10:43:25,187 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=341A,ou=scopes,o=gluu': 'Scope{dn='inum=341A,ou=scopes,o=gluu', inum='341A', displayName='null', id='clientinfo', iconUrl='null', description='View the client info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=29DA,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,187 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=341A,ou=scopes,o=gluu'
2021-03-11 10:43:25,187 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'clientinfo': 'Scope{dn='inum=341A,ou=scopes,o=gluu', inum='341A', displayName='null', id='clientinfo', iconUrl='null', description='View the client info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=29DA,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=6D90,ou=scopes,o=gluu'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=6D90,ou=scopes,o=gluu': 'Scope{dn='inum=6D90,ou=scopes,o=gluu', inum='6D90', displayName='oxd', id='oxd', iconUrl='null', description='oxd scope which is required to call oxd API', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=6D90,ou=scopes,o=gluu'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'oxd': 'Scope{dn='inum=6D90,ou=scopes,o=gluu', inum='6D90', displayName='oxd', id='oxd', iconUrl='null', description='oxd scope which is required to call oxd API', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=F0C4,ou=scopes,o=gluu'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=F0C4,ou=scopes,o=gluu': 'Scope{dn='inum=F0C4,ou=scopes,o=gluu', inum='F0C4', displayName='null', id='openid', iconUrl='null', description='Authenticate using OpenID Connect.', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=F0C4,ou=scopes,o=gluu'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'openid': 'Scope{dn='inum=F0C4,ou=scopes,o=gluu', inum='F0C4', displayName='null', id='openid', iconUrl='null', description='Authenticate using OpenID Connect.', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=43F1,ou=scopes,o=gluu'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=43F1,ou=scopes,o=gluu': 'Scope{dn='inum=43F1,ou=scopes,o=gluu', inum='43F1', displayName='profile', id='profile', iconUrl='null', description='View your basic profile info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=0C85,ou=attributes,o=gluu, inum=B4B0,ou=attributes,o=gluu, inum=A0E8,ou=attributes,o=gluu, inum=5EC6,ou=attributes,o=gluu, inum=B52A,ou=attributes,o=gluu, inum=64A0,ou=attributes,o=gluu, inum=EC3A,ou=attributes,o=gluu, inum=3B47,ou=attributes,o=gluu, inum=3692,ou=attributes,o=gluu, inum=98FC,ou=attributes,o=gluu, inum=A901,ou=attributes,o=gluu, inum=36D9,ou=attributes,o=gluu, inum=BE64,ou=attributes,o=gluu, inum=6493,ou=attributes,o=gluu], defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=ScopeAttributes{spontaneousClientId='null'spontaneousClientScopes='null'notShowInDiscovery='false'}}'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=43F1,ou=scopes,o=gluu'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'profile': 'Scope{dn='inum=43F1,ou=scopes,o=gluu', inum='43F1', displayName='profile', id='profile', iconUrl='null', description='View your basic profile info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=0C85,ou=attributes,o=gluu, inum=B4B0,ou=attributes,o=gluu, inum=A0E8,ou=attributes,o=gluu, inum=5EC6,ou=attributes,o=gluu, inum=B52A,ou=attributes,o=gluu, inum=64A0,ou=attributes,o=gluu, inum=EC3A,ou=attributes,o=gluu, inum=3B47,ou=attributes,o=gluu, inum=3692,ou=attributes,o=gluu, inum=98FC,ou=attributes,o=gluu, inum=A901,ou=attributes,o=gluu, inum=36D9,ou=attributes,o=gluu, inum=BE64,ou=attributes,o=gluu, inum=6493,ou=attributes,o=gluu], defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=ScopeAttributes{spontaneousClientId='null'spontaneousClientScopes='null'notShowInDiscovery='false'}}'
2021-03-11 10:43:25,188 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=10B2,ou=scopes,o=gluu'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=10B2,ou=scopes,o=gluu': 'Scope{dn='inum=10B2,ou=scopes,o=gluu', inum='10B2', displayName='null', id='user_name', iconUrl='null', description='View your local username in the Gluu Server.', scopeType=openid, oxAuthClaims=[inum=42E0,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=10B2,ou=scopes,o=gluu'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'user_name': 'Scope{dn='inum=10B2,ou=scopes,o=gluu', inum='10B2', displayName='null', id='user_name', iconUrl='null', description='View your local username in the Gluu Server.', scopeType=openid, oxAuthClaims=[inum=42E0,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=341A,ou=scopes,o=gluu'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=341A,ou=scopes,o=gluu': 'Scope{dn='inum=341A,ou=scopes,o=gluu', inum='341A', displayName='null', id='clientinfo', iconUrl='null', description='View the client info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=29DA,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=341A,ou=scopes,o=gluu'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'clientinfo': 'Scope{dn='inum=341A,ou=scopes,o=gluu', inum='341A', displayName='null', id='clientinfo', iconUrl='null', description='View the client info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=29DA,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=6D90,ou=scopes,o=gluu'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=6D90,ou=scopes,o=gluu': 'Scope{dn='inum=6D90,ou=scopes,o=gluu', inum='6D90', displayName='oxd', id='oxd', iconUrl='null', description='oxd scope which is required to call oxd API', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=6D90,ou=scopes,o=gluu'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'oxd': 'Scope{dn='inum=6D90,ou=scopes,o=gluu', inum='6D90', displayName='oxd', id='oxd', iconUrl='null', description='oxd scope which is required to call oxd API', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=F0C4,ou=scopes,o=gluu'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=F0C4,ou=scopes,o=gluu': 'Scope{dn='inum=F0C4,ou=scopes,o=gluu', inum='F0C4', displayName='null', id='openid', iconUrl='null', description='Authenticate using OpenID Connect.', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,189 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=F0C4,ou=scopes,o=gluu'
2021-03-11 10:43:25,190 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'openid': 'Scope{dn='inum=F0C4,ou=scopes,o=gluu', inum='F0C4', displayName='null', id='openid', iconUrl='null', description='Authenticate using OpenID Connect.', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,190 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=43F1,ou=scopes,o=gluu'
2021-03-11 10:43:25,190 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=43F1,ou=scopes,o=gluu': 'Scope{dn='inum=43F1,ou=scopes,o=gluu', inum='43F1', displayName='profile', id='profile', iconUrl='null', description='View your basic profile info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=0C85,ou=attributes,o=gluu, inum=B4B0,ou=attributes,o=gluu, inum=A0E8,ou=attributes,o=gluu, inum=5EC6,ou=attributes,o=gluu, inum=B52A,ou=attributes,o=gluu, inum=64A0,ou=attributes,o=gluu, inum=EC3A,ou=attributes,o=gluu, inum=3B47,ou=attributes,o=gluu, inum=3692,ou=attributes,o=gluu, inum=98FC,ou=attributes,o=gluu, inum=A901,ou=attributes,o=gluu, inum=36D9,ou=attributes,o=gluu, inum=BE64,ou=attributes,o=gluu, inum=6493,ou=attributes,o=gluu], defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=ScopeAttributes{spontaneousClientId='null'spontaneousClientScopes='null'notShowInDiscovery='false'}}'
2021-03-11 10:43:25,190 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=43F1,ou=scopes,o=gluu'
2021-03-11 10:43:25,190 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'profile': 'Scope{dn='inum=43F1,ou=scopes,o=gluu', inum='43F1', displayName='profile', id='profile', iconUrl='null', description='View your basic profile info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=0C85,ou=attributes,o=gluu, inum=B4B0,ou=attributes,o=gluu, inum=A0E8,ou=attributes,o=gluu, inum=5EC6,ou=attributes,o=gluu, inum=B52A,ou=attributes,o=gluu, inum=64A0,ou=attributes,o=gluu, inum=EC3A,ou=attributes,o=gluu, inum=3B47,ou=attributes,o=gluu, inum=3692,ou=attributes,o=gluu, inum=98FC,ou=attributes,o=gluu, inum=A901,ou=attributes,o=gluu, inum=36D9,ou=attributes,o=gluu, inum=BE64,ou=attributes,o=gluu, inum=6493,ou=attributes,o=gluu], defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=ScopeAttributes{spontaneousClientId='null'spontaneousClientScopes='null'notShowInDiscovery='false'}}'
2021-03-11 10:43:25,190 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=10B2,ou=scopes,o=gluu'
2021-03-11 10:43:25,190 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=10B2,ou=scopes,o=gluu': 'Scope{dn='inum=10B2,ou=scopes,o=gluu', inum='10B2', displayName='null', id='user_name', iconUrl='null', description='View your local username in the Gluu Server.', scopeType=openid, oxAuthClaims=[inum=42E0,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,190 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=10B2,ou=scopes,o=gluu'
2021-03-11 10:43:25,190 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'user_name': 'Scope{dn='inum=10B2,ou=scopes,o=gluu', inum='10B2', displayName='null', id='user_name', iconUrl='null', description='View your local username in the Gluu Server.', scopeType=openid, oxAuthClaims=[inum=42E0,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,190 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=341A,ou=scopes,o=gluu'
2021-03-11 10:43:25,190 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=341A,ou=scopes,o=gluu': 'Scope{dn='inum=341A,ou=scopes,o=gluu', inum='341A', displayName='null', id='clientinfo', iconUrl='null', description='View the client info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=29DA,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,190 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=341A,ou=scopes,o=gluu'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'clientinfo': 'Scope{dn='inum=341A,ou=scopes,o=gluu', inum='341A', displayName='null', id='clientinfo', iconUrl='null', description='View the client info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=29DA,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=6D90,ou=scopes,o=gluu'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=6D90,ou=scopes,o=gluu': 'Scope{dn='inum=6D90,ou=scopes,o=gluu', inum='6D90', displayName='oxd', id='oxd', iconUrl='null', description='oxd scope which is required to call oxd API', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=6D90,ou=scopes,o=gluu'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'oxd': 'Scope{dn='inum=6D90,ou=scopes,o=gluu', inum='6D90', displayName='oxd', id='oxd', iconUrl='null', description='oxd scope which is required to call oxd API', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=F0C4,ou=scopes,o=gluu'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=F0C4,ou=scopes,o=gluu': 'Scope{dn='inum=F0C4,ou=scopes,o=gluu', inum='F0C4', displayName='null', id='openid', iconUrl='null', description='Authenticate using OpenID Connect.', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=F0C4,ou=scopes,o=gluu'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'openid': 'Scope{dn='inum=F0C4,ou=scopes,o=gluu', inum='F0C4', displayName='null', id='openid', iconUrl='null', description='Authenticate using OpenID Connect.', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=43F1,ou=scopes,o=gluu'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=43F1,ou=scopes,o=gluu': 'Scope{dn='inum=43F1,ou=scopes,o=gluu', inum='43F1', displayName='profile', id='profile', iconUrl='null', description='View your basic profile info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=0C85,ou=attributes,o=gluu, inum=B4B0,ou=attributes,o=gluu, inum=A0E8,ou=attributes,o=gluu, inum=5EC6,ou=attributes,o=gluu, inum=B52A,ou=attributes,o=gluu, inum=64A0,ou=attributes,o=gluu, inum=EC3A,ou=attributes,o=gluu, inum=3B47,ou=attributes,o=gluu, inum=3692,ou=attributes,o=gluu, inum=98FC,ou=attributes,o=gluu, inum=A901,ou=attributes,o=gluu, inum=36D9,ou=attributes,o=gluu, inum=BE64,ou=attributes,o=gluu, inum=6493,ou=attributes,o=gluu], defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=ScopeAttributes{spontaneousClientId='null'spontaneousClientScopes='null'notShowInDiscovery='false'}}'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=43F1,ou=scopes,o=gluu'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'profile': 'Scope{dn='inum=43F1,ou=scopes,o=gluu', inum='43F1', displayName='profile', id='profile', iconUrl='null', description='View your basic profile info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=0C85,ou=attributes,o=gluu, inum=B4B0,ou=attributes,o=gluu, inum=A0E8,ou=attributes,o=gluu, inum=5EC6,ou=attributes,o=gluu, inum=B52A,ou=attributes,o=gluu, inum=64A0,ou=attributes,o=gluu, inum=EC3A,ou=attributes,o=gluu, inum=3B47,ou=attributes,o=gluu, inum=3692,ou=attributes,o=gluu, inum=98FC,ou=attributes,o=gluu, inum=A901,ou=attributes,o=gluu, inum=36D9,ou=attributes,o=gluu, inum=BE64,ou=attributes,o=gluu, inum=6493,ou=attributes,o=gluu], defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=ScopeAttributes{spontaneousClientId='null'spontaneousClientScopes='null'notShowInDiscovery='false'}}'
2021-03-11 10:43:25,191 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=10B2,ou=scopes,o=gluu'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=10B2,ou=scopes,o=gluu': 'Scope{dn='inum=10B2,ou=scopes,o=gluu', inum='10B2', displayName='null', id='user_name', iconUrl='null', description='View your local username in the Gluu Server.', scopeType=openid, oxAuthClaims=[inum=42E0,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=10B2,ou=scopes,o=gluu'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'user_name': 'Scope{dn='inum=10B2,ou=scopes,o=gluu', inum='10B2', displayName='null', id='user_name', iconUrl='null', description='View your local username in the Gluu Server.', scopeType=openid, oxAuthClaims=[inum=42E0,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=341A,ou=scopes,o=gluu'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=341A,ou=scopes,o=gluu': 'Scope{dn='inum=341A,ou=scopes,o=gluu', inum='341A', displayName='null', id='clientinfo', iconUrl='null', description='View the client info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=29DA,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=341A,ou=scopes,o=gluu'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'clientinfo': 'Scope{dn='inum=341A,ou=scopes,o=gluu', inum='341A', displayName='null', id='clientinfo', iconUrl='null', description='View the client info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=29DA,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=6D90,ou=scopes,o=gluu'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=6D90,ou=scopes,o=gluu': 'Scope{dn='inum=6D90,ou=scopes,o=gluu', inum='6D90', displayName='oxd', id='oxd', iconUrl='null', description='oxd scope which is required to call oxd API', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=6D90,ou=scopes,o=gluu'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'oxd': 'Scope{dn='inum=6D90,ou=scopes,o=gluu', inum='6D90', displayName='oxd', id='oxd', iconUrl='null', description='oxd scope which is required to call oxd API', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=F0C4,ou=scopes,o=gluu'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=F0C4,ou=scopes,o=gluu': 'Scope{dn='inum=F0C4,ou=scopes,o=gluu', inum='F0C4', displayName='null', id='openid', iconUrl='null', description='Authenticate using OpenID Connect.', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=F0C4,ou=scopes,o=gluu'
2021-03-11 10:43:25,192 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'openid': 'Scope{dn='inum=F0C4,ou=scopes,o=gluu', inum='F0C4', displayName='null', id='openid', iconUrl='null', description='Authenticate using OpenID Connect.', scopeType=openid, oxAuthClaims=null, defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,193 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=43F1,ou=scopes,o=gluu'
2021-03-11 10:43:25,193 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=43F1,ou=scopes,o=gluu': 'Scope{dn='inum=43F1,ou=scopes,o=gluu', inum='43F1', displayName='profile', id='profile', iconUrl='null', description='View your basic profile info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=0C85,ou=attributes,o=gluu, inum=B4B0,ou=attributes,o=gluu, inum=A0E8,ou=attributes,o=gluu, inum=5EC6,ou=attributes,o=gluu, inum=B52A,ou=attributes,o=gluu, inum=64A0,ou=attributes,o=gluu, inum=EC3A,ou=attributes,o=gluu, inum=3B47,ou=attributes,o=gluu, inum=3692,ou=attributes,o=gluu, inum=98FC,ou=attributes,o=gluu, inum=A901,ou=attributes,o=gluu, inum=36D9,ou=attributes,o=gluu, inum=BE64,ou=attributes,o=gluu, inum=6493,ou=attributes,o=gluu], defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=ScopeAttributes{spontaneousClientId='null'spontaneousClientScopes='null'notShowInDiscovery='false'}}'
2021-03-11 10:43:25,193 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=43F1,ou=scopes,o=gluu'
2021-03-11 10:43:25,193 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'profile': 'Scope{dn='inum=43F1,ou=scopes,o=gluu', inum='43F1', displayName='profile', id='profile', iconUrl='null', description='View your basic profile info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=0C85,ou=attributes,o=gluu, inum=B4B0,ou=attributes,o=gluu, inum=A0E8,ou=attributes,o=gluu, inum=5EC6,ou=attributes,o=gluu, inum=B52A,ou=attributes,o=gluu, inum=64A0,ou=attributes,o=gluu, inum=EC3A,ou=attributes,o=gluu, inum=3B47,ou=attributes,o=gluu, inum=3692,ou=attributes,o=gluu, inum=98FC,ou=attributes,o=gluu, inum=A901,ou=attributes,o=gluu, inum=36D9,ou=attributes,o=gluu, inum=BE64,ou=attributes,o=gluu, inum=6493,ou=attributes,o=gluu], defaultScope=true, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=ScopeAttributes{spontaneousClientId='null'spontaneousClientScopes='null'notShowInDiscovery='false'}}'
2021-03-11 10:43:25,193 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=10B2,ou=scopes,o=gluu'
2021-03-11 10:43:25,193 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=10B2,ou=scopes,o=gluu': 'Scope{dn='inum=10B2,ou=scopes,o=gluu', inum='10B2', displayName='null', id='user_name', iconUrl='null', description='View your local username in the Gluu Server.', scopeType=openid, oxAuthClaims=[inum=42E0,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,193 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=10B2,ou=scopes,o=gluu'
2021-03-11 10:43:25,193 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'user_name': 'Scope{dn='inum=10B2,ou=scopes,o=gluu', inum='10B2', displayName='null', id='user_name', iconUrl='null', description='View your local username in the Gluu Server.', scopeType=openid, oxAuthClaims=[inum=42E0,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,193 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=341A,ou=scopes,o=gluu'
2021-03-11 10:43:25,193 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=341A,ou=scopes,o=gluu': 'Scope{dn='inum=341A,ou=scopes,o=gluu', inum='341A', displayName='null', id='clientinfo', iconUrl='null', description='View the client info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=29DA,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,193 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=341A,ou=scopes,o=gluu'
2021-03-11 10:43:25,193 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'clientinfo': 'Scope{dn='inum=341A,ou=scopes,o=gluu', inum='341A', displayName='null', id='clientinfo', iconUrl='null', description='View the client info.', scopeType=openid, oxAuthClaims=[inum=2B29,ou=attributes,o=gluu, inum=29DA,ou=attributes,o=gluu], defaultScope=false, oxAuthGroupClaims=null, dynamicScopeScripts=null, umaAuthorizationPolicies=null, deletable=null, expirationDate=null, attributes=null}'
2021-03-11 10:43:25,193 DEBUG [qtp790067787-202520] [org.gluu.oxauth.model.authorize.ScopeChecker] (ScopeChecker.java:90) - Granted scopes: [openid, user_name, clientinfo, profile, oxd]
2021-03-11 10:43:25,194 TRACE [qtp790067787-202520] [org.gluu.oxauth.service.CookieService] (CookieService.java:141) - Found cookie: '989684cf-c26a-47a3-9e50-36e184ec78f9'
2021-03-11 10:43:25,197 TRACE [qtp790067787-202520] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:744) - Try to get session by id: 989684cf-c26a-47a3-9e50-36e184ec78f9 ...
2021-03-11 10:43:25,197 TRACE [qtp790067787-202520] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:746) - Session dn: oxId=989684cf-c26a-47a3-9e50-36e184ec78f9,ou=sessions,o=gluu
2021-03-11 10:43:25,197 TRACE [qtp790067787-202520] [org.gluu.oxauth.auth.Authenticator] (Authenticator.java:704) - authenticateBySessionId, sessionId = '989684cf-c26a-47a3-9e50-36e184ec78f9', session = 'SessionId {dn='oxId=989684cf-c26a-47a3-9e50-36e184ec78f9,ou=sessions,o=gluu', id='989684cf-c26a-47a3-9e50-36e184ec78f9', lastUsedAt=Thu Mar 11 10:43:25 UTC 2021, userDn='inum=0000!4084.40DF,ou=people,o=gluu', authenticationTime=Thu Mar 11 10:43:25 UTC 2021, state=authenticated, sessionState='2cf0f721d61a92e1e2678f1416d8b8935be708e2df662dbcca030b3fe50834f2.916c955d-e8b1-47a8-ba00-d147323bb384', permissionGranted=null, isJwt=false, jwt=null, permissionGrantedMap=SessionIdAccessMap{permissionGranted={2c71bef7-3035-416c-8649-eccf61138926=false}}, sessionAttributes={auth_external_attributes=[{"casa_logoUrl":"java.lang.String"},{"externalProviders":"java.lang.String"},{"casa_faviconUrl":"java.lang.String"},{"casa_prefix":"java.lang.String"},{"casa_contextPath":"java.lang.String"}], opbs=1ccc70f4-1b05-49b8-8ffe-d8584fff47b9, externalProviders={"helmholtzsaml": {"displayName": "(supports DFN / GEANT / eduGAIN)", "logo_img": "../../ext/resources/img/passport/2017_H_Logo_RGB_EN.png", "saml": true}}, response_type=code, nonce=p1mck1ftbmcos1agfsd1a972gp, client_id=2c71bef7-3035-416c-8649-eccf61138926, auth_step=1, acr=casa, casa_logoUrl=/casa/images/logo.png, remote_ip=172.26.1.220, scope=openid profile user_name clientinfo oxd, acr_values=casa, casa_faviconUrl=/casa/images/favicon.ico, redirect_uri=https://login.mydomain.com/casa, state=2q6rlvj96ucjrfjk85bhgf2uum, casa_prefix=, casa_contextPath=/casa, casa_extraCss=null, auth_user=testuser123}, persisted=false}', state= 'authenticated'
2021-03-11 10:43:25,203 TRACE [qtp790067787-202520] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:744) - Try to get session by id: 989684cf-c26a-47a3-9e50-36e184ec78f9 ...
2021-03-11 10:43:25,203 TRACE [qtp790067787-202520] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:746) - Session dn: oxId=989684cf-c26a-47a3-9e50-36e184ec78f9,ou=sessions,o=gluu
2021-03-11 10:43:25,204 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=2c71bef7-3035-416c-8649-eccf61138926,ou=clients,o=gluu'
2021-03-11 10:43:25,204 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=2c71bef7-3035-416c-8649-eccf61138926,ou=clients,o=gluu': 'DeletableEntity{expirationDate=null, deletable=false} BaseEntry [dn=null]'
2021-03-11 10:43:25,204 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=2c71bef7-3035-416c-8649-eccf61138926,ou=clients,o=gluu'
2021-03-11 10:43:25,204 DEBUG [qtp790067787-202520] [org.gluu.oxauth.service.ClientService] (ClientService.java:135) - Found 1 entries for client id = 2c71bef7-3035-416c-8649-eccf61138926
2021-03-11 10:43:25,204 DEBUG [qtp790067787-202520] [org.gluu.oxauth.service.RedirectionUriService] (RedirectionUriService.java:87) - Validating redirection URI: clientIdentifier = 2c71bef7-3035-416c-8649-eccf61138926, redirectionUri = https://login.mydomain.com/casa, found = 1
2021-03-11 10:43:25,204 DEBUG [qtp790067787-202520] [org.gluu.oxauth.service.RedirectionUriService] (RedirectionUriService.java:109) - Comparing https://login.mydomain.com/casa == https://login.mydomain.com/casa
2021-03-11 10:43:25,205 TRACE [qtp790067787-202520] [gluu.oxauth.authorize.ws.rs.AuthorizeAction] (AuthorizeAction.java:376) - checkPermissionGranted, user = org.gluu.oxauth.model.common.User@2f74d06e
2021-03-11 10:43:25,206 TRACE [qtp790067787-202520] [org.gluu.oxauth.service.AuthorizeService] (AuthorizeService.java:138) - permissionGranted
2021-03-11 10:43:25,206 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=2c71bef7-3035-416c-8649-eccf61138926,ou=clients,o=gluu'
2021-03-11 10:43:25,206 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=2c71bef7-3035-416c-8649-eccf61138926,ou=clients,o=gluu': 'DeletableEntity{expirationDate=null, deletable=false} BaseEntry [dn=null]'
2021-03-11 10:43:25,206 TRACE [qtp790067787-202520] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=2c71bef7-3035-416c-8649-eccf61138926,ou=clients,o=gluu'
2021-03-11 10:43:25,206 DEBUG [qtp790067787-202520] [org.gluu.oxauth.service.ClientService] (ClientService.java:135) - Found 1 entries for client id = 2c71bef7-3035-416c-8649-eccf61138926
2021-03-11 10:43:25,210 TRACE [qtp790067787-202520] [org.gluu.oxauth.service.CookieService] (CookieService.java:141) - Found cookie: '["989684cf-c26a-47a3-9e50-36e184ec78f9"]'
2021-03-11 10:43:25,211 TRACE [qtp790067787-202520] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:744) - Try to get session by id: 989684cf-c26a-47a3-9e50-36e184ec78f9 ...
2021-03-11 10:43:25,212 TRACE [qtp790067787-202520] [org.gluu.oxauth.service.SessionIdService] (SessionIdService.java:746) - Session dn: oxId=989684cf-c26a-47a3-9e50-36e184ec78f9,ou=sessions,o=gluu
2021-03-11 10:43:25,212 TRACE [qtp790067787-202520] [org.gluu.oxauth.service.AuthorizeService] (AuthorizeService.java:176) - permissionGranted, redirectTo: /oxauth/restv1/authorize?scope=openid+profile+user_name+clientinfo+oxd&acr_values=casa&response_type=code&redirect_uri=https%3A%2F%2Flogin.mydomain.com%2Fcasa&state=2q6rlvj96ucjrfjk85bhgf2uum&nonce=p1mck1ftbmcos1agfsd1a972gp&client_id=2c71bef7-3035-416c-8649-eccf61138926
2021-03-11 10:43:25,265 TRACE [qtp790067787-200154] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=2c71bef7-3035-416c-8649-eccf61138926,ou=clients,o=gluu'
2021-03-11 10:43:25,265 TRACE [qtp790067787-200154] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=2c71bef7-3035-416c-8649-eccf61138926,ou=clients,o=gluu': 'DeletableEntity{expirationDate=null, deletable=false} BaseEntry [dn=null]'
2021-03-11 10:43:25,265 TRACE [qtp790067787-200154] [org.gluu.service.BaseCacheService] (BaseCacheService.java:58) - Loaded from cache, key: 'inum=2c71bef7-3035-416c-8649-eccf61138926,ou=clients,o=gluu'
2021-03-11 10:43:25,265 DEBUG [qtp790067787-200154] [org.gluu.oxauth.service.ClientService] (ClientService.java:135) - Found 1 entries for client id = 2c71bef7-3035-416c-8649-eccf61138926
2021-03-11 10:43:25.265:WARN:oejs.HttpChannel:qtp790067787-200154: /oxauth/restv1/authorize
java.lang.NullPointerException
at org.gluu.server.filters.AbstractCorsFilter.isOriginAllowed(AbstractCorsFilter.java:596)
at org.gluu.server.filters.AbstractCorsFilter.handleSimpleCORS(AbstractCorsFilter.java:181)
at org.gluu.server.filters.AbstractCorsFilter.doFilter(AbstractCorsFilter.java:127)
at org.gluu.oxauth.filter.CorsFilter.doFilter(CorsFilter.java:118)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1638)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:567)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:602)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:235)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1610)
at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1377)
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:507)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1580)
at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1292)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:234)
at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:146)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
at org.eclipse.jetty.server.Server.handle(Server.java:501)
at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:556)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105)
at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104)
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:336)
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:313)
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:129)
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:375)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
at java.base/java.lang.Thread.run(Thread.java:834)
2021-03-11 10:43:31,225 DEBUG [oxAuthScheduler_Worker-1] [org.gluu.service.timer.RequestJobListener] (RequestJobListener.java:53) - Bound request started
2021-03-11 10:43:31,225 DEBUG [oxAuthScheduler_Worker-1] [org.gluu.service.timer.TimerJob] (TimerJob.java:36) - Fire timer event [org.gluu.service.cdi.event.LoggerUpdateEvent] with qualifiers [@org.gluu.service.cdi.event.Scheduled()] from instance 2060058117
2021-03-11 10:43:31,226 DEBUG [oxAuthScheduler_Worker-1] [org.gluu.service.timer.RequestJobListener] (RequestJobListener.java:63) - Bound request ended
2021-03-11 10:43:31,352 INFO [ForkJoinPool.commonPool-worker-11] [org.gluu.service.logger.LoggerService] (LoggerService.java:165) - Updated log level of '138' loggers to TRACE
2021-03-11 10:43:31,788 TRACE [qtp790067787-200652] [org.gluu.oxauth.uma.service.UmaValidationService] (UmaValidationService.java:110) - Validate authorization: Bearer 25ae1033-1558-4e0e-b6ca-396749b4ab53
2021-03-11 10:43:31,789 TRACE [qtp790067787-200652] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key '4d006afa1bbc6b04ae708ae8db6b85069e2db85259b81c82655055b3b1c262af'
2021-03-11 10:43:31,790 TRACE [qtp790067787-200652] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key '4d006afa1bbc6b04ae708ae8db6b85069e2db85259b81c82655055b3b1c262af': 'null'
2021-03-11 10:43:31,794 DEBUG [qtp790067787-200652] [org.gluu.oxauth.service.common.UserService] (UserService.java:78) - Getting user information from LDAP: userId = null
2021-03-11 10:43:31,794 TRACE [qtp790067787-200652] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=1501.313afb3b-c67e-4a2e-8d7b-1b4283c75b1e,ou=clients,o=gluu'
2021-03-11 10:43:31,794 TRACE [qtp790067787-200652] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=1501.313afb3b-c67e-4a2e-8d7b-1b4283c75b1e,ou=clients,o=gluu': 'null'
2021-03-11 10:43:31,794 TRACE [qtp790067787-200652] [org.gluu.service.BaseCacheService] (BaseCacheService.java:61) - Key not in cache. Searching value via load function, key: 'inum=1501.313afb3b-c67e-4a2e-8d7b-1b4283c75b1e,ou=clients,o=gluu'
2021-03-11 10:43:31,798 TRACE [qtp790067787-200652] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'inum=1501.313afb3b-c67e-4a2e-8d7b-1b4283c75b1e,ou=clients,o=gluu': 'DeletableEntity{expirationDate=null, deletable=null} BaseEntry [dn=null]'
2021-03-11 10:43:31,798 DEBUG [qtp790067787-200652] [org.gluu.oxauth.service.ClientService] (ClientService.java:135) - Found 1 entries for client id = 1501.313afb3b-c67e-4a2e-8d7b-1b4283c75b1e
2021-03-11 10:43:31,805 TRACE [qtp790067787-200652] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'inum=1502.1a6dfcf7-603b-43ed-acde-abe579c269f4,ou=clients,o=gluu'
2021-03-11 10:43:31,806 TRACE [qtp790067787-200652] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'inum=1502.1a6dfcf7-603b-43ed-acde-abe579c269f4,ou=clients,o=gluu': 'null'
2021-03-11 10:43:31,806 TRACE [qtp790067787-200652] [org.gluu.service.BaseCacheService] (BaseCacheService.java:61) - Key not in cache. Searching value via load function, key: 'inum=1502.1a6dfcf7-603b-43ed-acde-abe579c269f4,ou=clients,o=gluu'
2021-03-11 10:43:31,807 TRACE [qtp790067787-200652] [org.gluu.service.BaseCacheService] (BaseCacheService.java:84) - Put data, key 'inum=1502.1a6dfcf7-603b-43ed-acde-abe579c269f4,ou=clients,o=gluu': 'DeletableEntity{expirationDate=null, deletable=null} BaseEntry [dn=null]'
2021-03-11 10:43:31,808 DEBUG [qtp790067787-200652] [org.gluu.oxauth.service.ClientService] (ClientService.java:135) - Found 1 entries for client id = 1502.1a6dfcf7-603b-43ed-acde-abe579c269f4
2021-03-11 10:43:31,808 TRACE [qtp790067787-200652] [gluu.oxauth.uma.ws.rs.UmaRptIntrospectionWS] (UmaRptIntrospectionWS.java:133) - Canceled changes made by external RPT Claims script since method returned `false`.
```