I'm having serious problems with the latest maven snapshot. I've spent a while trying to figure out what could be going on. Any suggestions on where to look would be appreciated.
Once a user is logged In to my application, all additional requests are AJAX requests. In many situations, multiple AJAX calls occur at the same time. This was working perfectly with a Shiro release from late 2009, but ever since updating to the latest Shiro snapshot, I've been unable to get it working. The problem is that some requests find the current user and return valid data, while other requests cannot locate the current user. It occurs randomly with no consistency that I can determine. A request might not work one time, but the next time the same request will work. The following are the the logs when two concurrent AJAX requests successfully locate the current user and return valid data. One request is "Getting Games Managed By Member", and the other request is "Getting Recommended Officiators": TRACE - OncePerRequestFilter - Filter 'null' not yet executed. Executing now. TRACE - DefaultSecurityManager - Context already contains a SecurityManager instance. Returning. TRACE - DefaultSecurityManager - No session found in context. Looking for a session id to resolve in to a session. DEBUG - SimpleCookie - Found string value [f752d00d-7da2-451f-b813-0c36554461a9] from Cookie [JSESSIONID] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - DelegatingSubject - attempting to get session; create = false; session is null = false; session has id = true TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - AbstractShiroFilter - No FilterChain configured for the current request. Using the default. TRACE - DelegatingSubject - attempting to get session; create = false; session is null = false; session has id = true TRACE - DelegatingSubject - attempting to get session; create = false; session is null = false; session has id = true TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ShiroFilterFactoryBean - Ignoring non-Filter bean 'assignorsResource' DEBUG - GameJsonServiceImpl - ----------------------------------------------------------------------------- DEBUG - GameJsonServiceImpl - Getting Games Managed By Member DEBUG - MemberServiceImpl - Getting current member DEBUG - MemberServiceImpl - Get member by id: 2 DEBUG - MemberServiceImpl - Returning member: com.sprtz.model.mem...@3796fcd1[id=2,Name=beck] DEBUG - GameJsonServiceImpl - Get Games managed by member: com.sprtz.model.mem...@3796fcd1[id=2,Name=beck] TRACE - OncePerRequestFilter - Filter 'null' not yet executed. Executing now. TRACE - DefaultSecurityManager - Context already contains a SecurityManager instance. Returning. TRACE - DefaultSecurityManager - No session found in context. Looking for a session id to resolve in to a session. DEBUG - SimpleCookie - Found string value [f752d00d-7da2-451f-b813-0c36554461a9] from Cookie [JSESSIONID] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - DelegatingSubject - attempting to get session; create = false; session is null = false; session has id = true TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - AbstractShiroFilter - No FilterChain configured for the current request. Using the default. TRACE - DelegatingSubject - attempting to get session; create = false; session is null = false; session has id = true TRACE - DelegatingSubject - attempting to get session; create = false; session is null = false; session has id = true TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ShiroFilterFactoryBean - Ignoring non-Filter bean 'assignorsResource' DEBUG - GameJsonServiceImpl - ----------------------------------------------------------------------------- DEBUG - GameJsonServiceImpl - Getting Recommened Officiators DEBUG - MemberServiceImpl - Getting current member DEBUG - MemberServiceImpl - Get member by id: 2 DEBUG - MemberServiceImpl - Returning member: com.sprtz.model.mem...@1afb3ad9[id=2,Name=beck] The following logs show when "Getting Games Managed By Member" has failed to find the current user, but "Getting Recommeded Officiators" has found the current user. TRACE - OncePerRequestFilter - Filter 'null' not yet executed. Executing now. TRACE - DefaultSecurityManager - Context already contains a SecurityManager instance. Returning. TRACE - DefaultSecurityManager - No session found in context. Looking for a session id to resolve in to a session. DEBUG - SimpleCookie - Found string value [f752d00d-7da2-451f-b813-0c36554461a9] from Cookie [JSESSIONID] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - DelegatingSubject - attempting to get session; create = false; session is null = false; session has id = true TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - AbstractShiroFilter - No FilterChain configured for the current request. Using the default. TRACE - DelegatingSubject - attempting to get session; create = false; session is null = false; session has id = true TRACE - DelegatingSubject - attempting to get session; create = false; session is null = false; session has id = true TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ShiroFilterFactoryBean - Ignoring non-Filter bean 'assignorsResource' TRACE - OncePerRequestFilter - Filter 'null' not yet executed. Executing now. TRACE - DefaultSecurityManager - Context already contains a SecurityManager instance. Returning. TRACE - DefaultSecurityManager - No session found in context. Looking for a session id to resolve in to a session. DEBUG - SimpleCookie - Found string value [f752d00d-7da2-451f-b813-0c36554461a9] from Cookie [JSESSIONID] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - DelegatingSubject - attempting to get session; create = false; session is null = false; session has id = true TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - AbstractShiroFilter - No FilterChain configured for the current request. Using the default. TRACE - DelegatingSubject - attempting to get session; create = false; session is null = false; session has id = true TRACE - DelegatingSubject - attempting to get session; create = false; session is null = false; session has id = true TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ctValidatingSessionManager - Attempting to retrieve session with id [f752d00d-7da2-451f-b813-0c36554461a9] TRACE - ShiroFilterFactoryBean - Ignoring non-Filter bean 'assignorsResource' DEBUG - GameJsonServiceImpl - ----------------------------------------------------------------------------- DEBUG - GameJsonServiceImpl - Getting Recommened Officiators DEBUG - MemberServiceImpl - Getting current member DEBUG - MemberServiceImpl - Get member by id: 2 DEBUG - MemberServiceImpl - Returning member: com.sprtz.model.mem...@6390403a[id=2,Name=beck] DEBUG - GameJsonServiceImpl - ----------------------------------------------------------------------------- DEBUG - GameJsonServiceImpl - Getting Games Managed By Member DEBUG - MemberServiceImpl - Getting current member TRACE - DefaultSecurityManager - Context already contains a SecurityManager instance. Returning. TRACE - DefaultSecurityManager - No session found in context. Looking for a session id to resolve in to a session. TRACE - DefaultSecurityManager - No identity (PrincipalCollection) found in the context. Looking for a remembered identity. DEBUG - CookieRememberMeManager - SubjectContext argument is not an HTTP-aware instance. This is required to obtain a servlet request and response in order to retrieve the rememberMe cookie. Returning immediately and ignoring rememberMe operation. TRACE - DefaultSecurityManager - No remembered identity found. Returning original context. DEBUG - MemberServiceImpl - No current member: SecurityUtils.getSubject().getPrincipal() returned null I'd really appreciate any pointers here. I'm stuck until I can get past this and may end up reverting back to a much older version of Shiro and http sessions. Also, I'm having troubles whether I use http sessions or native sessions, but the logs above are using native sessions. Tauren
