By: Sved Devs user 31 Jul 2020 at 2:48 p.m. CDT

11 Responses
Sved Devs gravatar
POSTing to SCIM User creation API is returning 500 error with the following body, but when I try to look for the error in the logs, no log seems to get generated for it (I checked oxauth.log, oxtrust.log, scim.log and others in identity/logs/ folder). What would be the best place to look to understand what the error is? ``` HTTP ERROR 500 org.jboss.resteasy.spi.UnhandledException: java.lang.NullPointerException URI: /scim/restv1/scim/v2/Users STATUS: 500 MESSAGE: org.jboss.resteasy.spi.UnhandledException: java.lang.NullPointerException SERVLET: org.gluu.oxtrust.service.init.RSInitializer CAUSED BY: org.jboss.resteasy.spi.UnhandledException: java.lang.NullPointerException CAUSED BY: java.lang.NullPointerException Caused by: org.jboss.resteasy.spi.UnhandledException: java.lang.NullPointerException at org.jboss.resteasy.core.ExceptionHandler.handleApplicationException(ExceptionHandler.java:82) at org.jboss.resteasy.core.ExceptionHandler.handleException(ExceptionHandler.java:346) at org.jboss.resteasy.core.SynchronousDispatcher.writeException(SynchronousDispatcher.java:193) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:457) at org.jboss.resteasy.core.SynchronousDispatcher.lambda$invoke$4(SynchronousDispatcher.java:229) at org.jboss.resteasy.core.SynchronousDispatcher.lambda$preprocess$0(SynchronousDispatcher.java:135) at org.jboss.resteasy.core.interception.PreMatchContainerRequestContext.filter(PreMatchContainerRequestContext.java:356) at org.jboss.resteasy.core.SynchronousDispatcher.preprocess(SynchronousDispatcher.java:138) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:215) at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:227) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:56) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:51) at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:755) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:547) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:590) 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:1607) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:221) 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:500) at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383) at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117) 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) Caused by: java.lang.NullPointerException at org.gluu.oxtrust.ws.rs.scim2.BaseScimWebService.executeValidation(BaseScimWebService.java:160) at org.gluu.oxtrust.ws.rs.scim2.BaseScimWebService.executeDefaultValidation(BaseScimWebService.java:155) at org.gluu.oxtrust.service.scim2.interceptor.UserWebServiceDecorator.createUser(UserWebServiceDecorator.java:79) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at org.jboss.weld.annotated.runtime.InvokableAnnotatedMethod.invokeOnInstance(InvokableAnnotatedMethod.java:86) at org.jboss.weld.bean.proxy.DecoratorProxyMethodHandler.doInvoke(DecoratorProxyMethodHandler.java:78) at org.jboss.weld.bean.proxy.DecoratorProxyMethodHandler.doInvoke(DecoratorProxyMethodHandler.java:67) at org.jboss.weld.interceptor.util.proxy.TargetInstanceProxyMethodHandler.invoke(TargetInstanceProxyMethodHandler.java:33) at org.jboss.weld.bean.proxy.TargetBeanInstance.invoke(TargetBeanInstance.java:91) at org.jboss.weld.bean.proxy.ProxyMethodHandler.invoke(ProxyMethodHandler.java:106) at org.gluu.oxtrust.ws.rs.scim2.UserWebService$Proxy$_$$_Weld$Proxy$.createUser(Unknown Source) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at org.jboss.weld.interceptor.proxy.TerminalAroundInvokeInvocationContext.proceedInternal(TerminalAroundInvokeInvocationContext.java:51) at org.jboss.weld.interceptor.proxy.AroundInvokeInvocationContext.proceed(AroundInvokeInvocationContext.java:78) at org.gluu.oxtrust.service.scim2.interceptor.ReferenceURIInterceptor.manage(ReferenceURIInterceptor.java:70) at jdk.internal.reflect.GeneratedMethodAccessor1272.invoke(Unknown Source) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at org.jboss.weld.interceptor.reader.SimpleInterceptorInvocation$SimpleMethodInvocation.invoke(SimpleInterceptorInvocation.java:73) at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.executeAroundInvoke(InterceptorMethodHandler.java:84) at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.executeInterception(InterceptorMethodHandler.java:72) at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.invoke(InterceptorMethodHandler.java:56) at org.jboss.weld.bean.proxy.CombinedInterceptorAndDecoratorStackMethodHandler.invoke(CombinedInterceptorAndDecoratorStackMethodHandler.java:81) at org.jboss.weld.bean.proxy.CombinedInterceptorAndDecoratorStackMethodHandler.invoke(CombinedInterceptorAndDecoratorStackMethodHandler.java:68) at org.gluu.oxtrust.ws.rs.scim2.UserWebService$Proxy$_$$_WeldSubclass.createUser(Unknown Source) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:138) at org.jboss.resteasy.core.ResourceMethodInvoker.internalInvokeOnTarget(ResourceMethodInvoker.java:535) at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTargetAfterFilter(ResourceMethodInvoker.java:424) at org.jboss.resteasy.core.ResourceMethodInvoker.lambda$invokeOnTarget$0(ResourceMethodInvoker.java:385) at org.jboss.resteasy.core.interception.PreMatchContainerRequestContext.filter(PreMatchContainerRequestContext.java:356) at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTarget(ResourceMethodInvoker.java:387) at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:356) at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:329) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:440) ... 38 more ```

By Sved Devs user 31 Jul 2020 at 3:24 p.m. CDT

Sved Devs gravatar
Ok. I see this same error in /opt/gluu/jetty/scim/logs/2020_07_31.jetty.log But, it still doesn't solve the issue. Any pointers on where I can look? Where is it hitting a NULL pointer exception?

By Jose Gonzalez staff 31 Jul 2020 at 3:32 p.m. CDT

Jose Gonzalez gravatar
Gluu SCIM implementation is fairly polished and stable. It is surprising you are getting errors. Please, set the logging level to TRACE for oxtrust. Wait 1 minute, and retry. Then attach/paste here what you see coming in scim.log file Also share the payload you are posting.

By Sved Devs user 31 Jul 2020 at 4:34 p.m. CDT

Sved Devs gravatar
Here is the same log (after changing the logging level): ``` 31-07 21:19:37.192 DEBUG oxtrust.service.filter.AuthorizationProcessingFilter AuthorizationProcessingFilter.java:82- REST call to '/scim/v2/Users' intercepted 31-07 21:19:37.192 DEBUG oxtrust.service.filter.AuthorizationProcessingFilter AuthorizationProcessingFilter.java:95- Path is protected, proceeding with authorization processing... 31-07 21:19:37.192 INFO oxtrust.auth.uma.ScimUmaProtectionService ScimUmaProtectionService.java:104- ==== SCIM Service call intercepted ==== 31-07 21:19:37.192 INFO oxtrust.auth.uma.ScimUmaProtectionService ScimUmaProtectionService.java:105- Authorization header found 31-07 21:19:37.194 INFO oxtrust.auth.uma.ScimUmaProtectionService ScimUmaProtectionService.java:110- SCIM Test Mode is ACTIVE 31-07 21:19:37.194 DEBUG oxtrust.auth.uma.ScimUmaProtectionService ScimUmaProtectionService.java:137- Validating token 182bf596-5c50-4fe3-9744-ba5b8526cf61 31-07 21:19:37.211 DEBUG oxtrust.service.filter.AuthorizationProcessingFilter AuthorizationProcessingFilter.java:98- Authorization passed 31-07 21:19:37.212 TRACE service.scim2.interceptor.ReferenceURIInterceptor ReferenceURIInterceptor.java:55- Removing '$' char (if any) from attributes param 31-07 21:19:37.212 TRACE service.scim2.interceptor.ReferenceURIInterceptor ReferenceURIInterceptor.java:55- Removing '$' char (if any) from excludedAttributes param 31-07 21:19:37.212 DEBUG service.scim2.interceptor.ReferenceURIInterceptor ReferenceURIInterceptor.java:68- ReferenceURIInterceptor. manage exit 2020-07-31 21:19:37.213:WARN:oejs.HttpChannel:qtp407697359-22: /scim/restv1/scim/v2/Users org.jboss.resteasy.spi.UnhandledException: java.lang.NullPointerException at org.jboss.resteasy.core.ExceptionHandler.handleApplicationException(ExceptionHandler.java:82) at org.jboss.resteasy.core.ExceptionHandler.handleException(ExceptionHandler.java:346) at org.jboss.resteasy.core.SynchronousDispatcher.writeException(SynchronousDispatcher.java:193) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:457) at org.jboss.resteasy.core.SynchronousDispatcher.lambda$invoke$4(SynchronousDispatcher.java:229) at org.jboss.resteasy.core.SynchronousDispatcher.lambda$preprocess$0(SynchronousDispatcher.java:135) at org.jboss.resteasy.core.interception.PreMatchContainerRequestContext.filter(PreMatchContainerRequestContext.java:356) at org.jboss.resteasy.core.SynchronousDispatcher.preprocess(SynchronousDispatcher.java:138) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:215) at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:227) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:56) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:51) at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:755) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:547) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:590) 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:1607) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:221) 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:500) at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383) at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117) 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) Caused by: java.lang.NullPointerException at org.gluu.oxtrust.ws.rs.scim2.BaseScimWebService.executeValidation(BaseScimWebService.java:160) at org.gluu.oxtrust.ws.rs.scim2.BaseScimWebService.executeDefaultValidation(BaseScimWebService.java:155) at org.gluu.oxtrust.service.scim2.interceptor.UserWebServiceDecorator.createUser(UserWebServiceDecorator.java:79) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at org.jboss.weld.annotated.runtime.InvokableAnnotatedMethod.invokeOnInstance(InvokableAnnotatedMethod.java:86) at org.jboss.weld.bean.proxy.DecoratorProxyMethodHandler.doInvoke(DecoratorProxyMethodHandler.java:78) at org.jboss.weld.bean.proxy.DecoratorProxyMethodHandler.doInvoke(DecoratorProxyMethodHandler.java:67) at org.jboss.weld.interceptor.util.proxy.TargetInstanceProxyMethodHandler.invoke(TargetInstanceProxyMethodHandler.java:33) at org.jboss.weld.bean.proxy.TargetBeanInstance.invoke(TargetBeanInstance.java:91) at org.jboss.weld.bean.proxy.ProxyMethodHandler.invoke(ProxyMethodHandler.java:106) at org.gluu.oxtrust.ws.rs.scim2.UserWebService$Proxy$_$$_Weld$Proxy$.createUser(Unknown Source) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at org.jboss.weld.interceptor.proxy.TerminalAroundInvokeInvocationContext.proceedInternal(TerminalAroundInvokeInvocationContext.java:51) at org.jboss.weld.interceptor.proxy.AroundInvokeInvocationContext.proceed(AroundInvokeInvocationContext.java:78) at org.gluu.oxtrust.service.scim2.interceptor.ReferenceURIInterceptor.manage(ReferenceURIInterceptor.java:70) at jdk.internal.reflect.GeneratedMethodAccessor1272.invoke(Unknown Source) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at org.jboss.weld.interceptor.reader.SimpleInterceptorInvocation$SimpleMethodInvocation.invoke(SimpleInterceptorInvocation.java:73) at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.executeAroundInvoke(InterceptorMethodHandler.java:84) at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.executeInterception(InterceptorMethodHandler.java:72) at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.invoke(InterceptorMethodHandler.java:56) at org.jboss.weld.bean.proxy.CombinedInterceptorAndDecoratorStackMethodHandler.invoke(CombinedInterceptorAndDecoratorStackMethodHandler.java:81) at org.jboss.weld.bean.proxy.CombinedInterceptorAndDecoratorStackMethodHandler.invoke(CombinedInterceptorAndDecoratorStackMethodHandler.java:68) at org.gluu.oxtrust.ws.rs.scim2.UserWebService$Proxy$_$$_WeldSubclass.createUser(Unknown Source) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:138) at org.jboss.resteasy.core.ResourceMethodInvoker.internalInvokeOnTarget(ResourceMethodInvoker.java:535) at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTargetAfterFilter(ResourceMethodInvoker.java:424) at org.jboss.resteasy.core.ResourceMethodInvoker.lambda$invokeOnTarget$0(ResourceMethodInvoker.java:385) at org.jboss.resteasy.core.interception.PreMatchContainerRequestContext.filter(PreMatchContainerRequestContext.java:356) at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTarget(ResourceMethodInvoker.java:387) at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:356) at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:329) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:440) at org.jboss.resteasy.core.SynchronousDispatcher.lambda$invoke$4(SynchronousDispatcher.java:229) at org.jboss.resteasy.core.SynchronousDispatcher.lambda$preprocess$0(SynchronousDispatcher.java:135) at org.jboss.resteasy.core.interception.PreMatchContainerRequestContext.filter(PreMatchContainerRequestContext.java:356) at org.jboss.resteasy.core.SynchronousDispatcher.preprocess(SynchronousDispatcher.java:138) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:215) at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:227) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:56) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:51) at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:755) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:547) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:590) 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:1607) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:221) 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:500) at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383) at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117) 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) root@idp:/opt/gluu/jetty/scim/logs# date Fri Jul 31 21:19:44 UTC 2020 ``` Here is the payload: ``` { "schemas": [ "urn:ietf:params:scim:schemas:extension:gluu:2.0:User", "urn:ietf:params:scim:schemas:core:2.0:User" ], "userName": "o1d1g1u2@domain.com", "name": { "familyName": "G1 U2", "givenName": "O1 D1", "formatted": "O1D1 G1U2" }, "displayName": "O1D1G1U2", "emails": [ { "value": "o1d1g1u2@domain.com", "primary": true } ], "password":"TestPassw0rd", "active": true, "urn:ietf:params:scim:schemas:extension:gluu:2.0:User": { "o": "o1", "departmentNumber": "o1d1", "volGroup": "o1d1g1", "volAdmin": false, "volDataMiner": true, "volMonitoring": true, "volUserEdit": true } } ``` Added Headers: ``` Authorization: Bearer <access_token> Content-Type: application/json ``` Strange thing is this was the similar body as what we use for our production server on 3.1.5 (which works). The only difference being the password field which was originally in extensions schema and is now in core schema. (I even tried it both ways just to rule out).

By Sved Devs user 31 Jul 2020 at 6:11 p.m. CDT

Sved Devs gravatar
And, here is the oxtrust.log ``` 2020-07-31 21:19:53,601 DEBUG [oxTrustScheduler_Worker-5] [org.gluu.service.timer.RequestJobListener] (RequestJobListener.java:53) - Bound request started 2020-07-31 21:19:53,601 DEBUG [oxTrustScheduler_Worker-5] [org.gluu.service.timer.TimerJob] (TimerJob.java:36) - Fire timer event [org.gluu.service.cdi.event.UpdateScriptEvent] with qualifiers [@org.gluu.service.cdi.event.Scheduled()] from instance 2022765892 2020-07-31 21:19:53,604 DEBUG [oxTrustScheduler_Worker-5] [org.gluu.service.timer.RequestJobListener] (RequestJobListener.java:63) - Bound request ended 2020-07-31 21:20:05,635 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:05,640 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:05,641 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:05,641 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:05,642 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,642 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:05,642 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:05,643 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,643 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,643 DEBUG [qtp296347592-21] [org.gluu.oxtrust.action.JsonConfigurationAction] (JsonConfigurationAction.java:161) - Saving oxtrust-config.json:{"baseDN":"o=gluu","orgSupportEmail":"itadmin@dcmobility.com","applicationUrl":"https://idp.domain.com","baseEndpoint":"https://idp.domain.com/identity/restv1","personObjectClassTypes":["gluuCustomPerson","gluuPerson","eduPerson"],"personCustomObjectClass":"gluuCustomPerson","personObjectClassDisplayNames":["gluuCustomPerson","gluuPerson","eduPerson"],"contactObjectClassTypes":[],"contactObjectClassDisplayNames":[],"authMode":"","ldifStore":"/var/gluu/identity/removed","pokenApplicationSecret":"","updateStatus":true,"keystorePath":"/etc/certs/shibIDP.jks","keystorePassword":"hidden","allowPersonModification":true,"idpUrl":"https://idp.domain.com","spMetadataPath":"","idpSecurityKey":"/etc/certs/shibIDP.key","idpSecurityKeyPassword":"hidden","idpSecurityCert":"/etc/certs/shibIDP.crt","gluuSpAttributes":[],"configGeneration":false,"idpLdapProtocol":"ldaps","idpLdapServer":"localhost:1636","idpBindDn":"cn=Directory Manager","idpBindPassword":"hidden","idpUserFields":"","gluuSpCert":"/etc/certs/shibIDP.crt","shibboleth3FederationRootDir":"/opt/shibboleth-federation","cacheRefreshEnabled":false,"cacheRefreshIntervalMinutes":0,"caCertsLocation":"/usr/java/latest/jre/lib/security/cacerts","caCertsPassphrase":"hidden","tempCertDir":"/etc/certs/temp","certDir":"/etc/certs/","servicesRestartTrigger":"/opt/gluu/essential_files/trigger_restart_of_services_delete_me_to_do_so","oxAuthSectorIdentifierUrl":"https://idp.domain.com/oxauth/sectoridentifier","oxAuthClientId":"1001.1c48200f-e7a9-463d-8569-24eaa6d513c0","oxAuthClientPassword":"hidden","oxAuthClientScope":"openid+profile+email+user_name","loginRedirectUrl":"https://idp.domain.com/identity/authcode.htm","logoutRedirectUrl":"https://idp.domain.com/identity/finishlogout.htm","clusteredInums":[],"clientAssociationAttribute":"inum","oxAuthIssuer":"https://idp.domain.com","ignoreValidation":false,"umaIssuer":"https://idp.domain.com","scimUmaClientId":"1201.9b2dfe8a-a5ed-4c08-bf04-f2dfe0473754","scimUmaClientKeyId":"","scimUmaResourceId":"1203.28de89e5-ec5f-4840-8a6a-b90bd995f327","scimUmaScope":"https://idp.domain.com/oxauth/restv1/uma/scopes/scim_access","scimUmaClientKeyStoreFile":"/etc/certs/scim-rs.jks","scimUmaClientKeyStorePassword":"RcYgvfyQMAPU+vdHRSni/A==","apiUmaClientId":"1401.fffd7dd9-1610-4115-94d6-4e17dc33718d","apiUmaClientKeyId":"","apiUmaResourceId":"1403.ab3c3134-63b2-4cf6-947a-b8bf898e3972","apiUmaScopes":[],"apiUmaClientKeyStoreFile":"/etc/certs/api-rs.jks","apiUmaClientKeyStorePassword":"G9T/U6s7Ip4=","passportUmaClientId":"","passportUmaClientKeyId":"","passportUmaResourceId":"","passportUmaScope":"","passportUmaClientKeyStoreFile":"","passportUmaClientKeyStorePassword":"","recaptchaSiteKey":"","recaptchaSecretKey":"","cssLocation":"","jsLocation":"","metricReporterInterval":0,"metricReporterKeepDataDays":0,"metricReporterEnabled":true,"rptConnectionPoolUseConnectionPooling":true,"rptConnectionPoolMaxTotal":200,"rptConnectionPoolDefaultMaxPerRoute":20,"rptConnectionPoolValidateAfterInactivity":10,"rptConnectionPoolCustomKeepAliveTimeout":5,"scimTestMode":true,"oxTrustApiTestMode":false,"shibbolethVersion":"v3","shibboleth3IdpRootDir":"/opt/shibboleth-idp","shibboleth3SpConfDir":"/opt/shibboleth-idp/sp","organizationName":"DCmobility","idp3SigningCert":"/etc/certs/idp-signing.crt","idp3EncryptionCert":"/etc/certs/idp-encryption.crt","clientWhiteList":["*"],"clientBlackList":["*.attacker.com/*"],"oxIncommonFlag":false,"loggingLevel":"INFO","loggingLayout":"text","ScimProperties":{"maxCount":200},"disableJdkLogger":true,"passwordResetRequestExpirationTime":600,"cleanServiceInterval":300,"authenticationRecaptchaEnabled":false,"enforceEmailUniqueness":true,"useLocalCache":true,"enableUpdateNotification":false,"supportedUserStatus":["active","inactive"]} 2020-07-31 21:20:05,674 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:05,674 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:05,674 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:05,674 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:05,675 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:05,675 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:05,675 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:05,675 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:05,675 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:05,675 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:05,678 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:05,678 TRACE [qtp296347592-21] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:05,680 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,680 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,681 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,681 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,681 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,682 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,682 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,682 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,682 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,682 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,682 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,682 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,683 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,683 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,683 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,683 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,683 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,683 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,683 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,683 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,684 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,684 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,684 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,684 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:05,684 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,684 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,684 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,684 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,684 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,685 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,685 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,685 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,685 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,685 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,685 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,685 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,685 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,685 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,685 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,685 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,686 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,686 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,686 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,686 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,686 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,686 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,686 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,687 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,687 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,687 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,687 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,687 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,687 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:05,687 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:05,687 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:05,687 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:05,687 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:05,687 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:05,688 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:05,688 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,688 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,688 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,688 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,688 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,688 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,688 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,688 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,688 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,688 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,689 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,689 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,689 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,689 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,689 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:05,689 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:05,689 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:05,689 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:05,689 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:05,689 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:05,689 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:05,690 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,690 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,690 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,690 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,690 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,690 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,690 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,690 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:05,690 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:05,690 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:05,690 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:05,690 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:05,691 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:05,691 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:05,691 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,691 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:05,691 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:05,691 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'oxauth' an 'action'. Identity: access 2020-07-31 21:20:05,691 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'oxauth' an 'action'. Identity: access 2020-07-31 21:20:05,691 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:05,692 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:05,692 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:05,692 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:05,692 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:05,692 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:05,692 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:05,692 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:05,692 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:05,692 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:05,692 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:05,692 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:05,693 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:05,693 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:05,693 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:05,693 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:05,693 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:05,693 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:05,694 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:05,694 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:05,694 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:05,694 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'oxauth' an 'action'. Identity: access 2020-07-31 21:20:05,694 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,694 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,694 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,694 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,694 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,694 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,694 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,695 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,695 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,695 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,695 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,695 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,695 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,695 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,695 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,695 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,695 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:05,695 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:05,695 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:05,696 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:05,696 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:05,696 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:05,696 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:05,696 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:05,696 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:05,696 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:05,696 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,696 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,696 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,696 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,697 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,697 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,697 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,697 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,697 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,697 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,697 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,697 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,697 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,697 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:05,698 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:05,698 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:05,698 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:05,698 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:05,698 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:05,698 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:05,698 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:05,698 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:05,698 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'radius' an 'action'. Identity: access 2020-07-31 21:20:05,698 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:05,698 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:05,699 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:05,699 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:05,699 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:05,699 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:05,699 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:05,699 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:05,699 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:05,699 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:05,701 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,701 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,702 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,702 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,702 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,703 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,703 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,704 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,704 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,704 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,705 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,705 TRACE [qtp296347592-21] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:05,884 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:05,884 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:08,528 DEBUG [oxTrustScheduler_Worker-4] [org.gluu.service.timer.RequestJobListener] (RequestJobListener.java:53) - Bound request started 2020-07-31 21:20:08,528 DEBUG [oxTrustScheduler_Worker-4] [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 925191172 2020-07-31 21:20:08,528 DEBUG [oxTrustScheduler_Worker-4] [org.gluu.service.timer.RequestJobListener] (RequestJobListener.java:63) - Bound request ended 2020-07-31 21:20:08,538 INFO [ForkJoinPool.commonPool-worker-7] [org.gluu.service.logger.LoggerService] (LoggerService.java:165) - Updated log level of '116' loggers to TRACE 2020-07-31 21:20:13,339 TRACE [qtp296347592-14] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:13,339 TRACE [qtp296347592-14] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:13,339 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,339 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,339 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'oxauth' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:13,340 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'radius' an 'action'. Identity: access 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,341 TRACE [qtp296347592-14] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:13,342 TRACE [qtp296347592-14] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:13,342 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,342 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,342 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,342 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,342 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,342 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,342 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,342 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,342 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,342 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:13,343 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,343 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,343 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:13,343 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,343 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,343 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,343 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,343 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'oxauth' an 'action'. Identity: access 2020-07-31 21:20:13,343 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:13,343 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:13,343 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:13,344 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,344 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,344 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,344 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,344 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,344 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,344 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,344 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:13,344 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'radius' an 'action'. Identity: access 2020-07-31 21:20:13,344 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,344 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,345 TRACE [qtp296347592-14] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:13,345 TRACE [qtp296347592-14] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:13,345 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,345 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,345 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,345 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,345 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,345 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,345 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,345 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,345 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'oxauth' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:13,346 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,347 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,347 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,347 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,347 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,347 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,347 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,347 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:13,347 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'radius' an 'action'. Identity: access 2020-07-31 21:20:13,347 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,347 TRACE [qtp296347592-14] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,371 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,372 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,372 DEBUG [qtp296347592-18] [org.gluu.oxtrust.action.JsonConfigurationAction] (JsonConfigurationAction.java:109) - Loading oxauth-config.json and oxtrust-config.json 2020-07-31 21:20:13,397 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:13,397 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:13,397 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:13,397 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:13,398 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:13,398 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:13,398 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:13,398 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:13,398 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:13,398 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:13,399 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:37) - Request data, key 'o=gluu' 2020-07-31 21:20:13,399 TRACE [qtp296347592-18] [org.gluu.service.BaseCacheService] (BaseCacheService.java:39) - Loaded data, key 'o=gluu': 'Entry [dn=o=gluu]' 2020-07-31 21:20:13,399 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,399 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,400 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,401 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,402 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'attribute' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,403 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'log' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,404 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'trust' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'passport' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'oxauth' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'oxauth' an 'action'. Identity: access 2020-07-31 21:20:13,405 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'scope' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'client' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:13,406 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'sectorIdentifier' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'oxauth' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,407 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'uma' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,408 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: access 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'person' an 'action'. Identity: import 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'group' an 'action'. Identity: access 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'radius' an 'action'. Identity: access 2020-07-31 21:20:13,409 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,410 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,410 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,410 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,410 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,410 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,410 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,410 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,410 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,410 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'profile' an 'action'. Identity: access 2020-07-31 21:20:13,411 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,411 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,411 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,412 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,412 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,412 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,413 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,413 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,413 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,413 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,414 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:13,414 TRACE [qtp296347592-18] [org.gluu.oxtrust.service.PermissionService] (PermissionService.java:72) - Checking permissions for target 'configuration' an 'action'. Identity: access 2020-07-31 21:20:23,522 DEBUG [oxTrustScheduler_Worker-1] [org.gluu.service.timer.RequestJobListener] (RequestJobListener.java:53) - Bound request started 2020-07-31 21:20:23,522 DEBUG [oxTrustScheduler_Worker-1] [org.gluu.service.timer.TimerJob] (TimerJob.java:36) - Fire timer event [org.gluu.service.cdi.event.ConfigurationEvent] with qualifiers [@org.gluu.service.cdi.event.Scheduled()] from instance 863886935 2020-07-31 21:20:23,522 DEBUG [oxTrustScheduler_Worker-1] [org.gluu.service.timer.RequestJobListener] (RequestJobListener.java:63) - Bound request ended 2020-07-31 21:20:23,523 INFO [ForkJoinPool.commonPool-worker-7] [org.gluu.service.config.ConfigurationFactory] (ConfigurationFactory.java:289) - Loading configuration from 'ldap' DB... 2020-07-31 21:20:23,525 ERROR [ForkJoinPool.commonPool-worker-7] [org.gluu.service.config.ConfigurationFactory] (ConfigurationFactory.java:306) - WELD-001334: Unsatisfied dependencies for type CacheRefreshConfiguration with qualifiers @Default org.jboss.weld.exceptions.UnsatisfiedResolutionException: WELD-001334: Unsatisfied dependencies for type CacheRefreshConfiguration with qualifiers @Default at org.jboss.weld.bean.builtin.InstanceImpl.checkBeanResolved(InstanceImpl.java:241) ~[weld-core-impl-3.1.4.Final.jar:3.1.4.Final] at org.jboss.weld.bean.builtin.InstanceImpl.get(InstanceImpl.java:113) ~[weld-core-impl-3.1.4.Final.jar:3.1.4.Final] at org.gluu.service.config.ConfigurationFactory.destroy(ConfigurationFactory.java:314) ~[oxtrust-service-4.2.0.Final.jar:?] at org.gluu.oxtrust.service.config.ConfigurationFactory$Proxy$_$$_WeldSubclass.destroy(Unknown Source) ~[classes/:?] at org.gluu.oxtrust.service.config.ConfigurationFactory.destroryLoadedConfiguration(ConfigurationFactory.java:75) ~[classes/:?] at org.gluu.oxtrust.service.config.ConfigurationFactory$Proxy$_$$_WeldSubclass.destroryLoadedConfiguration(Unknown Source) ~[classes/:?] at org.gluu.service.config.ConfigurationFactory.createFromDb(ConfigurationFactory.java:297) [oxtrust-service-4.2.0.Final.jar:?] at org.gluu.service.config.ConfigurationFactory.reloadConfiguration(ConfigurationFactory.java:223) [oxtrust-service-4.2.0.Final.jar:?] at org.gluu.service.config.ConfigurationFactory.reloadConfigurationTimerEvent(ConfigurationFactory.java:175) [oxtrust-service-4.2.0.Final.jar:?] at org.gluu.oxtrust.service.config.ConfigurationFactory$Proxy$_$$_WeldSubclass.reloadConfigurationTimerEvent$$super(Unknown Source) [classes/:?] at jdk.internal.reflect.GeneratedMethodAccessor641.invoke(Unknown Source) ~[?:?] at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:?] at java.lang.reflect.Method.invoke(Method.java:566) ~[?:?] at org.jboss.weld.interceptor.proxy.TerminalAroundInvokeInvocationContext.proceedInternal(TerminalAroundInvokeInvocationContext.java:51) [weld-core-impl-3.1.4.Final.jar:3.1.4.Final] at org.jboss.weld.interceptor.proxy.AroundInvokeInvocationContext.proceed(AroundInvokeInvocationContext.java:78) [weld-core-impl-3.1.4.Final.jar:3.1.4.Final] at org.gluu.service.cdi.async.AsynchronousInterceptor$1.get(AsynchronousInterceptor.java:36) [oxcore-service-4.2.0.Final.jar:?] at java.util.concurrent.CompletableFuture$AsyncSupply.run(CompletableFuture.java:1700) [?:?] at java.util.concurrent.CompletableFuture$AsyncSupply.exec(CompletableFuture.java:1692) [?:?] at java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:290) [?:?] at java.util.concurrent.ForkJoinPool$WorkQueue.topLevelExec(ForkJoinPool.java:1020) [?:?] at java.util.concurrent.ForkJoinPool.scan(ForkJoinPool.java:1656) [?:?] at java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1594) [?:?] at java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:177) [?:?] 2020-07-31 21:20:23,527 DEBUG [oxTrustScheduler_Worker-3] [org.gluu.service.timer.RequestJobListener] (RequestJobListener.java:53) - Bound request started 2020-07-31 21:20:23,527 DEBUG [oxTrustScheduler_Worker-3] [org.gluu.service.timer.TimerJob] (TimerJob.java:36) - Fire timer event [org.gluu.service.cdi.event.LdapStatusEvent] with qualifiers [@org.gluu.service.cdi.event.Scheduled()] from instance 2124075035 2020-07-31 21:20:23,527 DEBUG [oxTrustScheduler_Worker-3] [org.gluu.service.timer.RequestJobListener] (RequestJobListener.java:63) - Bound request ended 2020-07-31 21:20:23,527 DEBUG [oxTrustScheduler_Worker-2] [org.gluu.service.timer.RequestJobListener] (RequestJobListener.java:53) - Bound request started 2020-07-31 21:20:23,527 DEBUG [oxTrustScheduler_Worker-2] [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 1225416799 2020-07-31 21:20:23,527 DEBUG [oxTrustScheduler_Worker-2] [org.gluu.service.timer.RequestJobListener] (RequestJobListener.java:63) - Bound request ended ```

By Jose Gonzalez staff 01 Aug 2020 at 8:10 a.m. CDT

Jose Gonzalez gravatar
> Where is it hitting a NULL pointer exception? [Here](https://github.com/GluuFederation/scim/blob/version_4.2.0/scim-rest/src/main/java/org/gluu/oxtrust/ws/rs/scim2/BaseScimWebService.java#L160) And it means you are not passing user payload (ie. `resource` is null) or injected bean reference `extService` is null. In your oxtrust log I see abnormal weld errors (not related to scim though). Weld is the dependency injection framework we use at Gluu. If weld isn't injecting references properly in scim webapp, that might explain your NPE. I tried to replicate using your payload and it worked here, so I can suggest the following: - Try a different operation, eg. retrieving a user. Does it work? - Check `/etc/default/scim` in chroot and raise `Xmx` and `-XX:MaxMetaspaceSize` if values do not seem adequate. Save it and restart scim -

By Sved Devs user 01 Aug 2020 at 8:31 a.m. CDT

Sved Devs gravatar
Getting a user list (identity/restv1/scim/v2/Users) works. My currenty scim config is: ``` JAVA_HOME=/opt/jre JAVA=$JAVA_HOME/bin/java JAVA_OPTIONS="-server -Xms256m -Xmx627m -XX:MaxMetaspaceSize=128m -XX:+DisableExplicitGC -Dgluu.base=/etc/gluu -Dserver.base=/opt/gluu/jetty/scim -Dlog.base=/opt/gluu/jetty/scim -Dpython.home=/opt/jython" JETTY_HOME=/opt/jetty JETTY_BASE=/opt/gluu/jetty/scim JETTY_USER=jetty JETTY_ARGS="jetty.http.host=localhost jetty.http.port=8087" TMPDIR=/opt/jetty-9.4/temp export PYTHON_HOME=/opt/jython ``` I'll change the Xmx to 1024m and -XX:MaxMetaspaceSize to 512m. Let me know if I should try any other values. Will post the result shortly.

By Sved Devs user 01 Aug 2020 at 9:13 a.m. CDT

Sved Devs gravatar
Same result after the changes: ``` 01-08 14:10:06.514 DEBUG oxtrust.service.filter.AuthorizationProcessingFilter AuthorizationProcessingFilter.java:82- REST call to '/scim/v2/Users' intercepted 01-08 14:10:06.514 DEBUG oxtrust.service.filter.AuthorizationProcessingFilter AuthorizationProcessingFilter.java:95- Path is protected, proceeding with authorization processing... 01-08 14:10:06.514 INFO oxtrust.auth.uma.ScimUmaProtectionService ScimUmaProtectionService.java:104- ==== SCIM Service call intercepted ==== 01-08 14:10:06.515 INFO oxtrust.auth.uma.ScimUmaProtectionService ScimUmaProtectionService.java:105- Authorization header found 01-08 14:10:06.518 INFO oxtrust.auth.uma.ScimUmaProtectionService ScimUmaProtectionService.java:110- SCIM Test Mode is ACTIVE 01-08 14:10:06.518 DEBUG oxtrust.auth.uma.ScimUmaProtectionService ScimUmaProtectionService.java:137- Validating token ab155472-beaa-4fe6-bad9-4cf372d0dc7f 01-08 14:10:06.541 DEBUG oxtrust.service.filter.AuthorizationProcessingFilter AuthorizationProcessingFilter.java:98- Authorization passed 01-08 14:10:06.544 TRACE service.scim2.interceptor.ReferenceURIInterceptor ReferenceURIInterceptor.java:55- Removing '$' char (if any) from attributes param 01-08 14:10:06.544 TRACE service.scim2.interceptor.ReferenceURIInterceptor ReferenceURIInterceptor.java:55- Removing '$' char (if any) from excludedAttributes param 01-08 14:10:06.544 DEBUG service.scim2.interceptor.ReferenceURIInterceptor ReferenceURIInterceptor.java:68- ReferenceURIInterceptor. manage exit 2020-08-01 14:10:06.545:WARN:oejs.HttpChannel:qtp671467883-21: /scim/restv1/scim/v2/Users org.jboss.resteasy.spi.UnhandledException: java.lang.NullPointerException at org.jboss.resteasy.core.ExceptionHandler.handleApplicationException(ExceptionHandler.java:82) at org.jboss.resteasy.core.ExceptionHandler.handleException(ExceptionHandler.java:346) at org.jboss.resteasy.core.SynchronousDispatcher.writeException(SynchronousDispatcher.java:193) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:457) at org.jboss.resteasy.core.SynchronousDispatcher.lambda$invoke$4(SynchronousDispatcher.java:229) at org.jboss.resteasy.core.SynchronousDispatcher.lambda$preprocess$0(SynchronousDispatcher.java:135) at org.jboss.resteasy.core.interception.PreMatchContainerRequestContext.filter(PreMatchContainerRequestContext.java:356) at org.jboss.resteasy.core.SynchronousDispatcher.preprocess(SynchronousDispatcher.java:138) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:215) at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:227) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:56) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:51) at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:755) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:547) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:590) 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:1607) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:221) 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:500) at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383) at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117) 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.produce(EatWhatYouKill.java:135) 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) Caused by: java.lang.NullPointerException at org.gluu.oxtrust.ws.rs.scim2.BaseScimWebService.executeValidation(BaseScimWebService.java:160) at org.gluu.oxtrust.ws.rs.scim2.BaseScimWebService.executeDefaultValidation(BaseScimWebService.java:155) at org.gluu.oxtrust.service.scim2.interceptor.UserWebServiceDecorator.createUser(UserWebServiceDecorator.java:79) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at org.jboss.weld.annotated.runtime.InvokableAnnotatedMethod.invokeOnInstance(InvokableAnnotatedMethod.java:86) at org.jboss.weld.bean.proxy.DecoratorProxyMethodHandler.doInvoke(DecoratorProxyMethodHandler.java:78) at org.jboss.weld.bean.proxy.DecoratorProxyMethodHandler.doInvoke(DecoratorProxyMethodHandler.java:67) at org.jboss.weld.interceptor.util.proxy.TargetInstanceProxyMethodHandler.invoke(TargetInstanceProxyMethodHandler.java:33) at org.jboss.weld.bean.proxy.TargetBeanInstance.invoke(TargetBeanInstance.java:91) at org.jboss.weld.bean.proxy.ProxyMethodHandler.invoke(ProxyMethodHandler.java:106) at org.gluu.oxtrust.ws.rs.scim2.UserWebService$Proxy$_$$_Weld$Proxy$.createUser(Unknown Source) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at org.jboss.weld.interceptor.proxy.TerminalAroundInvokeInvocationContext.proceedInternal(TerminalAroundInvokeInvocationContext.java:51) at org.jboss.weld.interceptor.proxy.AroundInvokeInvocationContext.proceed(AroundInvokeInvocationContext.java:78) at org.gluu.oxtrust.service.scim2.interceptor.ReferenceURIInterceptor.manage(ReferenceURIInterceptor.java:70) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at org.jboss.weld.interceptor.reader.SimpleInterceptorInvocation$SimpleMethodInvocation.invoke(SimpleInterceptorInvocation.java:73) at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.executeAroundInvoke(InterceptorMethodHandler.java:84) at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.executeInterception(InterceptorMethodHandler.java:72) at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.invoke(InterceptorMethodHandler.java:56) at org.jboss.weld.bean.proxy.CombinedInterceptorAndDecoratorStackMethodHandler.invoke(CombinedInterceptorAndDecoratorStackMethodHandler.java:81) at org.jboss.weld.bean.proxy.CombinedInterceptorAndDecoratorStackMethodHandler.invoke(CombinedInterceptorAndDecoratorStackMethodHandler.java:68) at org.gluu.oxtrust.ws.rs.scim2.UserWebService$Proxy$_$$_WeldSubclass.createUser(Unknown Source) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:138) at org.jboss.resteasy.core.ResourceMethodInvoker.internalInvokeOnTarget(ResourceMethodInvoker.java:535) at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTargetAfterFilter(ResourceMethodInvoker.java:424) at org.jboss.resteasy.core.ResourceMethodInvoker.lambda$invokeOnTarget$0(ResourceMethodInvoker.java:385) at org.jboss.resteasy.core.interception.PreMatchContainerRequestContext.filter(PreMatchContainerRequestContext.java:356) at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTarget(ResourceMethodInvoker.java:387) at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:356) at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:329) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:440) at org.jboss.resteasy.core.SynchronousDispatcher.lambda$invoke$4(SynchronousDispatcher.java:229) at org.jboss.resteasy.core.SynchronousDispatcher.lambda$preprocess$0(SynchronousDispatcher.java:135) at org.jboss.resteasy.core.interception.PreMatchContainerRequestContext.filter(PreMatchContainerRequestContext.java:356) at org.jboss.resteasy.core.SynchronousDispatcher.preprocess(SynchronousDispatcher.java:138) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:215) at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:227) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:56) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:51) at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:755) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:547) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:590) 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:1607) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:221) 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:500) at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383) at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117) 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.produce(EatWhatYouKill.java:135) 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) 01-08 14:10:07.326 DEBUG gluu.service.timer.RequestJobListener RequestJobListener.java:53- Bound request started 01-08 14:10:07.326 DEBUG gluu.service.timer.TimerJob TimerJob.java:36- Fire timer event [org.gluu.service.cdi.event.ConfigurationEvent] with qualifiers [@org.gluu.service.cdi.event.Scheduled()] from instance 128526158 01-08 14:10:07.326 DEBUG gluu.service.timer.RequestJobListener RequestJobListener.java:63- Bound request ended 01-08 14:10:07.330 DEBUG gluu.service.timer.RequestJobListener RequestJobListener.java:53- Bound request started 01-08 14:10:07.330 DEBUG 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 1626449063 01-08 14:10:07.331 DEBUG gluu.service.timer.RequestJobListener RequestJobListener.java:63- Bound request ended 01-08 14:10:07.342 INFO gluu.service.logger.LoggerService LoggerService.java:165- Updated log level of '39' loggers to TRACE 01-08 14:10:07.370 DEBUG gluu.service.timer.RequestJobListener RequestJobListener.java:53- Bound request started 01-08 14:10:07.370 DEBUG gluu.service.timer.TimerJob TimerJob.java:36- Fire timer event [org.gluu.service.cdi.event.UpdateScriptEvent] with qualifiers [@org.gluu.service.cdi.event.Scheduled()] from instance 1282579893 01-08 14:10:07.372 DEBUG gluu.service.timer.RequestJobListener RequestJobListener.java:63- Bound request ended ```

By Sved Devs user 01 Aug 2020 at 9:16 a.m. CDT

Sved Devs gravatar
Strangely, I don't see any error/log in identity logs except for 3-4 lines of standard log.

By Jose Gonzalez staff 01 Aug 2020 at 11:11 a.m. CDT

Jose Gonzalez gravatar
Your default java memory settings for scim were fine. The line of code where it crashes is the very first thing that is executed when the creation (POST) request is received, so I vote for it is receiving no payload. Try to send a malformed json payload. If you get the same, then no payload is being received. Share how you are performing the actual POST.

By Sved Devs user 01 Aug 2020 at 1:10 p.m. CDT

Sved Devs gravatar
Spot on. I was using postman to send the request. To try out what you suggested, I exported the request as a curl command and ran it. This time it actually completed the request successfully. Will look into why Postman was not sending the payload (but the same curl command works fine). Again, thank you very much for looking into it. Starting now, I'll make sure I check with atleast 2 clients before posting a question.

By Sved Devs user 01 Aug 2020 at 8:18 p.m. CDT

Sved Devs gravatar
Found the issue. For some reason, the Content-Length header in the postman request headers (normally hidden) was unchecked. When I force-set it, the API started working again. Leaving this in there in case any one ever stumbles upon such an issue in future.