Uploaded image for project: 'Dev - Nexus Repo'
  1. Dev - Nexus Repo
  2. NEXUS-6244

Regression: Crowd plugin does not support nested group role mapping user privileges

    Details

    • Type: Bug
    • Status: Closed
    • Priority: Major
    • Resolution: Fixed
    • Affects Version/s: 2.7, 2.7.1
    • Fix Version/s: 2.7.2, 2.8
    • Component/s: Crowd
    • Labels:
      None
    • Sprint:
      Sprint 11

      Description

      Crowd Configuration:

      • Startup Atlassian Crowd 'demo" application.
      • Enable "Nested Groups" on the demo application Directory inside Crowd.
      • Create a "parent" group in the default directory.
      • Create a "child" group in the default directory.
      • Make the child group a parent group group member.
      • Add a "child-user" user which is a member of the "child" group only.

      Nexus Configuration:

      • Configure Nexus to connect to the Crowd Server.
      • Add an external Crowd Role (Group) mapping to the Crowd "parent" group only. Give the parent group Nexus Administrator Role.
      • Enable Crowd Realm in Nexus Server.
      • Try to login as 'child-user'. Login fails.

      Repeat the above with Nexus 2.6.4-02 and old Crowd plugin. Login succeeds. Old plugin apparently supported nested group role mappings.


      Nexus 2.7 uses direct group mappings.

      jvm 1    | 2014-02-03 10:48:49 DEBUG [qtp1211033288-71] child-user com.atlassian.crowd.integration.rest.service.RestExecutor - Constructed http://localhost:8095/crowd/rest/usermanagement/1/user/group/direct?username=child-user&start-index=0&max-results=2147483647
      jvm 1    | 2014-02-03 10:48:49 DEBUG [qtp1211033288-71] child-user org.sonatype.nexus.apachehttpclient.Hc4ProviderImpl$1 - Connection request: [route: {}->http://localhost:8095][total kept alive: 1; route allocated: 1 of 20; total allocated: 1 of 200]
      jvm 1    | 2014-02-03 10:48:49 DEBUG [qtp1211033288-71] child-user org.sonatype.nexus.apachehttpclient.Hc4ProviderImpl$1 - Connection leased: [id: 6][route: {}->http://localhost:8095][total kept alive: 0; route allocated: 1 of 20; total allocated: 1 of 200]
      jvm 1    | 2014-02-03 10:48:49 DEBUG [qtp1211033288-71] child-user org.sonatype.nexus.apachehttpclient.Hc4ProviderBase$DefaultHttpClientImpl - Attempt 1 to execute request
      jvm 1    | 2014-02-03 10:48:49 DEBUG [qtp1211033288-71] child-user org.sonatype.nexus.apachehttpclient.Hc4ProviderBase$DefaultHttpClientImpl - Connection can be kept alive for 30000 MILLISECONDS
      jvm 1    | 2014-02-03 10:48:49 DEBUG [qtp1211033288-71] child-user org.sonatype.nexus.apachehttpclient.Hc4ProviderImpl$1 - Connection [id: 6][route: {}->http://localhost:8095] can be kept alive for 30000 MILLISECONDS
      jvm 1    | 2014-02-03 10:48:49 DEBUG [qtp1211033288-71] child-user org.sonatype.nexus.apachehttpclient.Hc4ProviderImpl$1 - Connection released: [id: 6][route: {}->http://localhost:8095][total kept alive: 1; route allocated: 1 of 20; total allocated: 1 of 200]
      jvm 1    | 2014-02-03 10:48:49 DEBUG [qtp1211033288-71] child-user org.sonatype.sisu.goodies.eventbus.internal.DefaultEventBus - Event 'org.sonatype.nexus.auth.NexusAuthorizationEvent@1795f2a7' fired
      jvm 1    | 2014-02-03 10:48:49 DEBUG [esh-1-thread-7] child-user org.sonatype.nexus.feeds.record.NexusAuthorizationEventInspector - Unable to authorize user [child-user] for read(HTTP method "GET") to /nexus/service/local/authentication/login from IP Address 127.0.0.1, user agent:"n/a"
      jvm 1    | 2014-02-03 10:48:49 DEBUG [qtp1211033288-71] child-user org.sonatype.nexus.security.filter.authc.NexusAuthenticationFilter - Request processing is rejected because user "child-user" lacks permissions.
      

      Hint: Possibly should use group nested resource instead:

      > curl -u demo:admin123 "http://localhost:8095/crowd/rest/usermanagement/1/user/group/direct?username=child-user&start-index=0&max-results=2147483647"
      <?xml version="1.0" encoding="UTF-8" standalone="yes"?><groups expand="group"><group name="child"><link href="http://localhost:8095/crowd/rest/usermanagement/1/group?groupname=child" rel="self"/></group></groups>
      
      > curl -u demo:admin123 "http://localhost:8095/crowd/rest/usermanagement/1/user/group/nested?username=child-user&start-index=0&max-results=2147483647"
      <?xml version="1.0" encoding="UTF-8" standalone="yes"?><groups expand="group"><group name="child"><link href="http://localhost:8095/crowd/rest/usermanagement/1/group?groupname=child" rel="self"/></group><group name="parent"><link href="http://localhost:8095/crowd/rest/usermanagement/1/group?groupname=parent" rel="self"/></group></groups>
      

      Nexus 2.6.4-02 using same crowd setup authenticates and allows the user to login to Nexus using only the parent group mapping:

      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.web.servlet.SimpleCookie - Found 'JSESSIONID' cookie value [f0abb406-7f90-4127-9d81-94eeb7ca06c3]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.mgt.DefaultSecurityManager - Resolved SubjectContext context session is invalid.  Ignoring and creating an anonymous (session-less) Subject instance.
      jvm 1    | org.apache.shiro.session.UnknownSessionException: There is no session with id [f0abb406-7f90-4127-9d81-94eeb7ca06c3]
      jvm 1    | 	at org.apache.shiro.session.mgt.eis.AbstractSessionDAO.readSession(AbstractSessionDAO.java:170) ~[shiro-core-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.session.mgt.eis.CachingSessionDAO.readSession(CachingSessionDAO.java:261) ~[shiro-core-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.session.mgt.DefaultSessionManager.retrieveSessionFromDataSource(DefaultSessionManager.java:236) ~[shiro-core-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.session.mgt.DefaultSessionManager.retrieveSession(DefaultSessionManager.java:222) ~[shiro-core-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.session.mgt.AbstractValidatingSessionManager.doGetSession(AbstractValidatingSessionManager.java:118) ~[shiro-core-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.session.mgt.AbstractNativeSessionManager.lookupSession(AbstractNativeSessionManager.java:108) ~[shiro-core-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.session.mgt.AbstractNativeSessionManager.getSession(AbstractNativeSessionManager.java:100) ~[shiro-core-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.mgt.SessionsSecurityManager.getSession(SessionsSecurityManager.java:125) ~[shiro-core-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.mgt.DefaultSecurityManager.resolveContextSession(DefaultSecurityManager.java:456) [shiro-core-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.mgt.DefaultSecurityManager.resolveSession(DefaultSecurityManager.java:442) [shiro-core-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.mgt.DefaultSecurityManager.createSubject(DefaultSecurityManager.java:338) [shiro-core-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.subject.Subject$Builder.buildSubject(Subject.java:846) [shiro-core-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.web.subject.WebSubject$Builder.buildWebSubject(WebSubject.java:148) [shiro-web-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.web.servlet.AbstractShiroFilter.createSubject(AbstractShiroFilter.java:292) [shiro-web-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.web.servlet.AbstractShiroFilter.doFilterInternal(AbstractShiroFilter.java:359) [shiro-web-1.2.2.jar:1.2.2]
      jvm 1    | 	at org.apache.shiro.web.servlet.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:125) [shiro-web-1.2.2.jar:1.2.2]
      jvm 1    | 	at com.google.inject.servlet.FilterChainInvocation.doFilter(FilterChainInvocation.java:82) [guice-servlet-3.1.4.jar:3.1.4]
      jvm 1    | 	at com.google.inject.servlet.ManagedFilterPipeline.dispatch(ManagedFilterPipeline.java:120) [guice-servlet-3.1.4.jar:3.1.4]
      jvm 1    | 	at org.sonatype.nexus.web.NexusGuiceFilter$MultiFilterChain.doFilter(NexusGuiceFilter.java:88) [nexus-web-utils-2.6.4-02.jar:2.6.4-02]
      jvm 1    | 	at com.google.inject.servlet.FilterChainInvocation.doFilter(FilterChainInvocation.java:89) [guice-servlet-3.1.4.jar:3.1.4]
      jvm 1    | 	at com.yammer.metrics.web.WebappMetricsFilter.doFilter(WebappMetricsFilter.java:76) [metrics-web-2.2.0.jar:na]
      jvm 1    | 	at com.google.inject.servlet.FilterChainInvocation.doFilter(FilterChainInvocation.java:82) [guice-servlet-3.1.4.jar:3.1.4]
      jvm 1    | 	at com.google.inject.servlet.ManagedFilterPipeline.dispatch(ManagedFilterPipeline.java:120) [guice-servlet-3.1.4.jar:3.1.4]
      jvm 1    | 	at org.sonatype.nexus.web.NexusGuiceFilter$MultiFilterChain.doFilter(NexusGuiceFilter.java:88) [nexus-web-utils-2.6.4-02.jar:2.6.4-02]
      jvm 1    | 	at com.google.inject.servlet.FilterChainInvocation.doFilter(FilterChainInvocation.java:89) [guice-servlet-3.1.4.jar:3.1.4]
      jvm 1    | 	at com.google.inject.servlet.ManagedFilterPipeline.dispatch(ManagedFilterPipeline.java:120) [guice-servlet-3.1.4.jar:3.1.4]
      jvm 1    | 	at org.sonatype.nexus.web.NexusGuiceFilter$MultiFilterChain.doFilter(NexusGuiceFilter.java:88) [nexus-web-utils-2.6.4-02.jar:2.6.4-02]
      jvm 1    | 	at org.sonatype.nexus.web.NexusGuiceFilter$MultiFilterPipeline.dispatch(NexusGuiceFilter.java:58) [nexus-web-utils-2.6.4-02.jar:2.6.4-02]
      jvm 1    | 	at com.google.inject.servlet.GuiceFilter$1.call(GuiceFilter.java:132) [guice-servlet-3.1.4.jar:3.1.4]
      jvm 1    | 	at com.google.inject.servlet.GuiceFilter$1.call(GuiceFilter.java:129) [guice-servlet-3.1.4.jar:3.1.4]
      jvm 1    | 	at com.google.inject.servlet.GuiceFilter$Context.call(GuiceFilter.java:206) [guice-servlet-3.1.4.jar:3.1.4]
      jvm 1    | 	at com.google.inject.servlet.GuiceFilter.doFilter(GuiceFilter.java:129) [guice-servlet-3.1.4.jar:3.1.4]
      jvm 1    | 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419) [jetty-servlet-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:455) [jetty-servlet-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:557) [jetty-security-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1075) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:384) [jetty-servlet-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1009) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:255) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.Server.handle(Server.java:370) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:949) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:1011) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:644) [jetty-http-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235) [jetty-http-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82) [jetty-server-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:668) [jetty-io-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:52) [jetty-io-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608) [jetty-util-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543) [jetty-util-8.1.11.v20130520.jar:8.1.11.v20130520]
      jvm 1    | 	at java.lang.Thread.run(Thread.java:744) [na:1.7.0_51]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.sonatype.nexus.security.filter.authc.NexusSecureHttpAuthenticationFilter - Using authorization header from request
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.sonatype.nexus.security.filter.authc.NexusSecureHttpAuthenticationFilter - Using authorization header from request
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.sonatype.nexus.security.filter.authc.NexusSecureHttpAuthenticationFilter - Using authorization header from request
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.sonatype.nexus.security.filter.authc.NexusSecureHttpAuthenticationFilter - Using authorization header from request
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  com.atlassian.crowd.integration.service.soap.client.SecurityServerClientImpl - Connection URL: http://localhost:8095/crowd/services/SecurityServer
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  com.atlassian.crowd.integration.service.soap.client.SecurityServerClientImpl - Using existing token: bZxdBqXDFFbLvqVg8h5XdQ00
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.transport.http.HttpTransport - Creating new channel for uri: urn:xfire:transport:http:139143983011310827534615
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.handler.OutMessageSender@6a180a8e to phase send
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapActionOutHandler@4aa5d885 to phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapSerializerHandler@4e2a2a0c to phase post-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase post-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapSerializerHandler in phase post-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase policy
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase user
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapActionOutHandler in phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase send
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.handler.OutMessageSender in phase send
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /com/atlassian/crowd/integration/authentication/AuthenticatedToken.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /java/lang/String.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /com/atlassian/crowd/integration/authentication/AuthenticatedToken.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /java/lang/String.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.Client - Received message to http://localhost:8095/crowd/services/SecurityServer
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.client.CorrelatorHandler@574d906 to phase pre-dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.ReadHeadersHandler@78163159 to phase parse
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.ValidateHeadersHandler@790207a6 to phase pre-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.handler.LocateBindingHandler@7444615a to phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapActionInHandler@35539758 to phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapBodyHandler@2f52dc2 to phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase parse
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.ReadHeadersHandler in phase parse
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase pre-dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.client.CorrelatorHandler in phase pre-dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.Client - Correlating context with ID 139143983011311-754143493
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.Client - Found correlated context with ID 139143983011311-754143493
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.client.ClientReceiveHandler@3a541bb6 to phase service
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.handler.LocateBindingHandler in phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapBodyHandler in phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapActionInHandler in phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase policy
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase user
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase pre-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.ValidateHeadersHandler in phase pre-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase service
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.client.ClientReceiveHandler in phase service
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.XFireProxy - Result [YYXfDbcyJtPH08TdOKz0nQ00]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  com.atlassian.crowd.integration.service.soap.client.SecurityServerClientImpl - Connection URL: http://localhost:8095/crowd/services/SecurityServer
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  com.atlassian.crowd.integration.service.soap.client.SecurityServerClientImpl - Using existing token: bZxdBqXDFFbLvqVg8h5XdQ00
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.transport.http.HttpTransport - Creating new channel for uri: urn:xfire:transport:http:1391439830203121860127842
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.handler.OutMessageSender@7187b0e4 to phase send
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapActionOutHandler@4aa5d885 to phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapSerializerHandler@4e2a2a0c to phase post-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase post-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapSerializerHandler in phase post-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase policy
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase user
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapActionOutHandler in phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase send
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.handler.OutMessageSender in phase send
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /com/atlassian/crowd/integration/authentication/AuthenticatedToken.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /java/lang/String.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /com/atlassian/crowd/integration/authentication/AuthenticatedToken.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /java/lang/String.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.Client - Received message to http://localhost:8095/crowd/services/SecurityServer
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.client.CorrelatorHandler@69d3c639 to phase pre-dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.ReadHeadersHandler@78163159 to phase parse
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.ValidateHeadersHandler@790207a6 to phase pre-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.handler.LocateBindingHandler@7444615a to phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapActionInHandler@35539758 to phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapBodyHandler@2f52dc2 to phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase parse
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.ReadHeadersHandler in phase parse
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase pre-dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.client.CorrelatorHandler in phase pre-dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.Client - Correlating context with ID 139143983020313848732040
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.Client - Found correlated context with ID 139143983020313848732040
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.client.ClientReceiveHandler@4e7afe76 to phase service
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.handler.LocateBindingHandler in phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapBodyHandler in phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /com/atlassian/crowd/integration/soap/SOAPEntity.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /long.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /com/atlassian/crowd/integration/soap/SOAPEntity.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /boolean.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /com/atlassian/crowd/integration/soap/SOAPEntity.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /com/atlassian/crowd/integration/soap/SOAPAttribute.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /java/lang/String.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /com/atlassian/crowd/integration/soap/SOAPAttribute.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /com/atlassian/crowd/integration/soap/SOAPEntity.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /java/lang/String.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /com/atlassian/crowd/integration/soap/SOAPEntity.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /long.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /com/atlassian/crowd/integration/soap/SOAPEntity.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.aegis.XMLClassMetaInfoManager - Mapping file : /java/lang/String.aegis.xml not found.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapActionInHandler in phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase policy
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase user
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase pre-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.ValidateHeadersHandler in phase pre-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase service
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.client.ClientReceiveHandler in phase service
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.XFireProxy - Result [com.atlassian.crowd.integration.soap.SOAPPrincipal@799a061c[ID=-1,name=child-user,directoryID=32769,active=true,conception=<null>,lastModified=<null>,attributes={com.atlassian.crowd.integration.soap.SOAPAttribute@6f0756a2[name=givenName,values={child}],com.atlassian.crowd.integration.soap.SOAPAttribute@4ac8dea0[name=sn,values={user}],com.atlassian.crowd.integration.soap.SOAPAttribute@499000bb[name=mail,values={fake@sonatype.com}],com.atlassian.crowd.integration.soap.SOAPAttribute@d201ab8[name=displayName,values={child user}]}]]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.realm.AuthenticatingRealm - Looked up AuthenticationInfo [child-user] from doGetAuthenticationInfo
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.realm.AuthenticatingRealm - AuthenticationInfo caching is disabled for info [child-user].  Submitted token: [org.apache.shiro.authc.UsernamePasswordToken - child-user, rememberMe=false (127.0.0.1)].
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.authc.credential.SimpleCredentialsMatcher - Performing credentials equality check for tokenCredentials of type [[C and accountCredentials of type [[C]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.authc.credential.SimpleCredentialsMatcher - Both credentials arguments can be easily converted to byte arrays.  Performing array equals comparison
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.authc.AbstractAuthenticator - Authentication successful for token [org.apache.shiro.authc.UsernamePasswordToken - child-user, rememberMe=false (127.0.0.1)].  Returned account [child-user]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.subject.support.DefaultSubjectContext - No SecurityManager available in subject context map.  Falling back to SecurityUtils.getSecurityManager() lookup.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.subject.support.DefaultSubjectContext - No SecurityManager available in subject context map.  Falling back to SecurityUtils.getSecurityManager() lookup.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.session.mgt.DefaultSessionManager - Creating new EIS record for new session instance [org.apache.shiro.session.mgt.SimpleSession,id=null]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  net.sf.ehcache.store.disk.Segment - put added 0 on heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  net.sf.ehcache.store.disk.Segment - put added 0 on heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  net.sf.ehcache.store.disk.Segment - put updated, deleted 0 on heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault removed 0 from heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.web.servlet.SimpleCookie - Added HttpServletResponse Cookie [JSESSIONID=33bdd299-7d4c-47d5-83af-92693338704b; Path=/nexus; HttpOnly]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault added 0 on disk
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault installation failed, deleted 0 from heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  net.sf.ehcache.store.disk.Segment - put added 0 on heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault installation failed deleted 0 from disk
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  net.sf.ehcache.store.disk.Segment - put updated, deleted 0 on heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  net.sf.ehcache.store.disk.Segment - put added 0 on heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  net.sf.ehcache.store.disk.Segment - put updated, deleted 0 on heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.web.servlet.SimpleCookie - Added HttpServletResponse Cookie [rememberMe=deleteMe; Path=/nexus; Max-Age=0; Expires=Sun, 02-Feb-2014 15:03:50 GMT]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.apache.shiro.mgt.AbstractRememberMeManager - AuthenticationToken did not indicate RememberMe is requested.  RememberMe functionality will not be executed for corresponding account.
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault removed 0 from heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.sonatype.sisu.goodies.eventbus.internal.DefaultEventBus - Event 'NexusAuthenticationEvent{userId='child-user',remoteIp='127.0.0.1',successful=true}' fired
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault added 0 on disk
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault installation failed, deleted 0 from heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault installation failed deleted 0 from disk
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault removed 0 from heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault added 0 on disk
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault installation failed, deleted 0 from heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [nxevthost-1-thread-5] child-user org.sonatype.nexus.feeds.record.NexusAuthenticationEventInspector - Successfully authenticated user [child-user] from IP address 127.0.0.1
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault installation failed deleted 0 from disk
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.sonatype.security.usermanagement.xml.SecurityXmlUserManager - No user role mapping found for user: child-user
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  com.sonatype.security.crowd.client.DefaultCrowdRoleManager - Looking up role list for username: child-user
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault removed 0 from heap
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  com.atlassian.crowd.integration.service.soap.client.SecurityServerClientImpl - Connection URL: http://localhost:8095/crowd/services/SecurityServer
      jvm 1    | 2014-02-03 11:03:50 DEBUG [shiro-activeSessionCache.data]  net.sf.ehcache.store.disk.Segment - fault added 0 on disk
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  com.atlassian.crowd.integration.service.soap.client.SecurityServerClientImpl - Using existing token: bZxdBqXDFFbLvqVg8h5XdQ00
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.transport.http.HttpTransport - Creating new channel for uri: urn:xfire:transport:http:1391439830246141534270986
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.handler.OutMessageSender@1df0ca1a to phase send
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapActionOutHandler@4aa5d885 to phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapSerializerHandler@4e2a2a0c to phase post-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase post-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapSerializerHandler in phase post-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase policy
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase user
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapActionOutHandler in phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase send
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.handler.OutMessageSender in phase send
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.Client - Received message to http://localhost:8095/crowd/services/SecurityServer
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.client.CorrelatorHandler@917d52e to phase pre-dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.ReadHeadersHandler@78163159 to phase parse
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.ValidateHeadersHandler@790207a6 to phase pre-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.handler.LocateBindingHandler@7444615a to phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapActionInHandler@35539758 to phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapBodyHandler@2f52dc2 to phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase parse
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.ReadHeadersHandler in phase parse
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase pre-dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.client.CorrelatorHandler in phase pre-dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.Client - Correlating context with ID 1391439830246151440575786
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.Client - Found correlated context with ID 1391439830246151440575786
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.client.ClientReceiveHandler@7bacc3ab to phase service
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.handler.LocateBindingHandler in phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapBodyHandler in phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapActionInHandler in phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase policy
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase user
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase pre-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.ValidateHeadersHandler in phase pre-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase service
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.client.ClientReceiveHandler in phase service
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.XFireProxy - Result [[Ljava.lang.String;@632f883a]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  com.atlassian.crowd.integration.service.soap.client.SecurityServerClientImpl - Connection URL: http://localhost:8095/crowd/services/SecurityServer
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  com.atlassian.crowd.integration.service.soap.client.SecurityServerClientImpl - Using existing token: bZxdBqXDFFbLvqVg8h5XdQ00
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.transport.http.HttpTransport - Creating new channel for uri: urn:xfire:transport:http:139143983027516-140179385
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.handler.OutMessageSender@6f396b3a to phase send
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapActionOutHandler@4aa5d885 to phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapSerializerHandler@4e2a2a0c to phase post-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase post-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapSerializerHandler in phase post-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase policy
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase user
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapActionOutHandler in phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase send
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.handler.OutMessageSender in phase send
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.Client - Received message to http://localhost:8095/crowd/services/SecurityServer
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.client.CorrelatorHandler@1777a5de to phase pre-dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.ReadHeadersHandler@78163159 to phase parse
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.ValidateHeadersHandler@790207a6 to phase pre-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.handler.LocateBindingHandler@7444615a to phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapActionInHandler@35539758 to phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.soap.handler.SoapBodyHandler@2f52dc2 to phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase transport
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase parse
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.ReadHeadersHandler in phase parse
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase pre-dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.client.CorrelatorHandler in phase pre-dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.Client - Correlating context with ID 1391439830275171916966652
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.Client - Found correlated context with ID 1391439830275171916966652
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - adding handler org.codehaus.xfire.client.ClientReceiveHandler@302a9ddb to phase service
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.handler.LocateBindingHandler in phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapBodyHandler in phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.SoapActionInHandler in phase dispatch
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase policy
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase user
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase pre-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.soap.handler.ValidateHeadersHandler in phase pre-invoke
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking phase service
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.handler.HandlerPipeline - Invoking handler org.codehaus.xfire.client.ClientReceiveHandler in phase service
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  org.codehaus.xfire.client.XFireProxy - Result [[Lcom.atlassian.crowd.integration.soap.SOAPNestableGroup;@2b4a2a54]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77]  com.sonatype.security.crowd.client.DefaultCrowdRoleManager - Obtained role list: [child, parent]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77] child-user org.sonatype.nexus.web.NexusRestletServlet - Processing: GET /nexus/service/local/authentication/login?_dc=1391439830107 (http://localhost:8264/nexus/service/local/authentication/login)
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77] child-user org.sonatype.security.DefaultSecuritySystem - User: 'child-user' was not found in: 'default' 
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77] child-user com.sonatype.security.crowd.client.DefaultCrowdRoleManager - Looking up role list for username: child-user
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77] child-user com.sonatype.security.crowd.client.DefaultCrowdRoleManager - Obtained role list: [child, parent]
      jvm 1    | 2014-02-03 11:03:50 DEBUG [qtp253747277-77] child-user org.sonatype.security.usermanagement.xml.SecurityXmlUserManager - No user role mapping found for user: child-user
      
      

        Attachments

          Activity

            People

            Assignee:
            plynch Peter Lynch
            Reporter:
            plynch Peter Lynch
            Last Updated By:
            Peter Lynch Peter Lynch
            Votes:
            1 Vote for this issue
            Watchers:
            3 Start watching this issue

              Dates

              Created:
              Updated:
              Resolved:
              Date of First Response:

                tigCommentSecurity.panel-title