Les, Sorry for posting tons of logs to the JIRA issue, but I'm heading to bed and wanted to make sure you had enough information.
Also, I'm no maven expert, but I think I installed the branch properly. After checking out the branch, I did the following: mvn clean mvn install Then in my local maven repo, it looked like all the shiro snapshot jars had updated to the current time. So I rebuilt my project and ran it. I'm assuming it was using the 1.0-snapshot version from the branch, but I wasn't sure how to totally verify that it was. Thanks again for your help, Tauren On Mon, May 17, 2010 at 8:15 PM, Les Hazlewood <[email protected]> wrote: > Thanks Tauren! > > I'm working on it now... > > On Mon, May 17, 2010 at 8:11 PM, Tauren Mills <[email protected]> wrote: >> Les, >> >> I just created this JIRA: >> https://issues.apache.org/jira/browse/SHIRO-164 >> Thanks for getting right to it! >> Tauren >> >> On Mon, May 17, 2010 at 6:53 PM, Les Hazlewood <[email protected]> >> wrote: >>> >>> Hi Tauren, >>> >>> For web-initiated interaction, you should not be seeing these messages: >>> >>> DEBUG - DefaultWebSessionManager - No request or response bound to >>> the thread. Session ID cookie cannot be removed. This could occur in >>> a web application that also services non web clients (e.g. RMI >>> remoting). >>> DEBUG - DefaultWebSessionManager - Request or response object is not >>> bound to the thread. Assuming this session start activity is due to a >>> non web request (possible in a web application that also services non >>> web clients. >>> >>> The request/response pair should be available at all times to >>> web-related components. >>> >>> Please open a Jira issue and I'll get on it right away. I'm actually >>> working on a related bit of code that should clear this up today. >>> >>> Thanks! >>> >>> Les >>> >>> On Mon, May 17, 2010 at 6:40 PM, Tauren Mills <[email protected]> wrote: >>> > I am getting an UnknownSessionException, but things still seem to be >>> > working. At first I thought it was because I had stopped jetty and then >>> > started it back up. But I'm getting these same exceptions every time I >>> > click >>> > something that causes those same 2 AJAX requests to be made. Is this >>> > the >>> > expected behavior? Full logs: >>> > INFO - log - Started >>> > [email protected]:8080 >>> > INFO - log - Started >>> > [email protected]:8443 >>> > TRACE - OncePerRequestFilter - Filter 'null' not yet executed. >>> > Executing now. >>> > TRACE - OncePerRequestFilter - Filter 'null' not yet executed. >>> > Executing now. >>> > TRACE - DefaultSecurityManager - Context already contains a >>> > SecurityManager instance. Returning. >>> > DEBUG - SimpleCookie - Found string value >>> > [dc51b21d-5e34-4407-b2e2-74a2bebb7b19] from Cookie [JSESSIONID] >>> > DEBUG - ctValidatingSessionManager - No sessionValidationScheduler set. >>> > Attempting to create default instance. >>> > TRACE - ctValidatingSessionManager - Created default >>> > SessionValidationScheduler instance of type >>> > >>> > [org.apache.shiro.session.mgt.ExecutorServiceSessionValidationScheduler]. >>> > INFO - ctValidatingSessionManager - Enabling session validation >>> > scheduler... >>> > TRACE - DefaultSecurityManager - Context already contains a >>> > SecurityManager instance. Returning. >>> > DEBUG - SimpleCookie - Found string value >>> > [dc51b21d-5e34-4407-b2e2-74a2bebb7b19] from Cookie [JSESSIONID] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [dc51b21d-5e34-4407-b2e2-74a2bebb7b19] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [dc51b21d-5e34-4407-b2e2-74a2bebb7b19] >>> > DEBUG - DefaultWebSessionManager - No request or response bound to the >>> > thread. Session ID cookie cannot be removed. This could occur in a web >>> > application that also services non web clients (e.g. RMI remoting). >>> > DEBUG - DefaultSecurityManager - Resolved SubjectContext context >>> > session >>> > is invalid. Ignoring and creating an anonymous (session-less) Subject >>> > instance. >>> > org.apache.shiro.session.UnknownSessionException: There is no session >>> > with >>> > id [dc51b21d-5e34-4407-b2e2-74a2bebb7b19] >>> > at >>> > >>> > org.apache.shiro.session.mgt.eis.AbstractSessionDAO.readSession(AbstractSessionDAO.java:171) >>> > at >>> > >>> > org.apache.shiro.session.mgt.DefaultSessionManager.retrieveSessionFromDataSource(DefaultSessionManager.java:220) >>> > at >>> > >>> > org.apache.shiro.session.mgt.DefaultSessionManager.retrieveSession(DefaultSessionManager.java:216) >>> > at >>> > >>> > org.apache.shiro.session.mgt.AbstractValidatingSessionManager.doGetSession(AbstractValidatingSessionManager.java:122) >>> > at >>> > >>> > org.apache.shiro.session.mgt.AbstractSessionManager.getSession(AbstractSessionManager.java:238) >>> > at >>> > >>> > org.apache.shiro.web.session.DefaultWebSessionManager.getSession(DefaultWebSessionManager.java:178) >>> > at >>> > >>> > org.apache.shiro.web.DefaultWebSecurityManager.resolveContextSession(DefaultWebSecurityManager.java:153) >>> > at >>> > >>> > org.apache.shiro.mgt.DefaultSecurityManager.resolveSession(DefaultSecurityManager.java:385) >>> > at >>> > >>> > org.apache.shiro.mgt.DefaultSecurityManager.createSubject(DefaultSecurityManager.java:336) >>> > at >>> > org.apache.shiro.subject.Subject$Builder.buildSubject(Subject.java:819) >>> > at >>> > >>> > org.apache.shiro.web.subject.WebSubject$Builder.buildWebSubject(WebSubject.java:90) >>> > at >>> > >>> > org.apache.shiro.web.servlet.AbstractShiroFilter.createSubject(AbstractShiroFilter.java:202) >>> > at >>> > >>> > org.apache.shiro.web.servlet.AbstractShiroFilter.doFilterInternal(AbstractShiroFilter.java:269) >>> > at >>> > >>> > org.apache.shiro.web.servlet.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:83) >>> > at >>> > >>> > org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:237) >>> > at >>> > >>> > org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:167) >>> > at >>> > >>> > org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1088) >>> > at >>> > >>> > org.springframework.orm.hibernate3.support.OpenSessionInViewFilter.doFilterInternal(OpenSessionInViewFilter.java:198) >>> > at >>> > >>> > org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:76) >>> > at >>> > >>> > org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1088) >>> > at >>> > org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:360) >>> > at >>> > >>> > org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216) >>> > at >>> > org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181) >>> > at >>> > org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:729) >>> > at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:405) >>> > at >>> > org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) >>> > at org.mortbay.jetty.Server.handle(Server.java:324) >>> > at >>> > org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:505) >>> > at >>> > >>> > org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:843) >>> > at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:647) >>> > at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211) >>> > at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:380) >>> > at >>> > >>> > org.mortbay.jetty.bio.SocketConnector$Connection.run(SocketConnector.java:228) >>> > at >>> > >>> > org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:488) >>> > TRACE - DefaultSecurityManager - No identity (PrincipalCollection) >>> > found >>> > in the context. Looking for a remembered identity. >>> > DEBUG - SimpleCookie - Found string value >>> > >>> > [p9PNM4iDmrfPhCG7w+2rX1l3HtwrvkzNfF7JBrMfpVwo9VdlAFFu+WDrtvChLPv+PG6lb3NDO6a4WxOcjWG7YaWX2BsDAUXnzgFcXHTvWp9LlNiTdl4pF/EbekI60SYCon77WWNsSqxSO+QwuleKkCIHf7Jm5FpMc+RIb7UGZFN6/LFLtolNIp5jZ17pBDymYyKzDjYP88U7SXU3A59kJLQW6eJ5kAw5b7MyNZqsDblHGQh6/6NJ0nK7KfFS5nTgs2X05C3mbXE2jsuCtJwBb/+8tuFAqAiVVQNlMDV7az7vxR/2Uh230Fw7J9WD9x/HFiBlrttygFiy/F5jwevf8h5bMqPEugpUpOEo8JQ3FhYEZQCloNBBH2bQ0yJCIYaKF5hNgIC2j2fV0sXd5L9iB7zchFbCX07hTBgeC5tXeqrGR5qi2RvBXaWaGzqSml3eL87lFW4urZHC1M9tP3UCpaYQjM/ZQMp1T7Qu9pa/VzmcGQkDAQthNkCUYrgnYRpl4KUMyply/HVlys02x+krAPq7lRDgXZY4sFgGcZ+LL/Tjqmi1sLkvMN1HQ9v3Nl0DsEDBazr7w/Hc5a4D2hi7Uw==] >>> > from Cookie [rememberMe] >>> > TRACE - CookieRememberMeManager - Acquired Base64 encoded identity >>> > >>> > [p9PNM4iDmrfPhCG7w+2rX1l3HtwrvkzNfF7JBrMfpVwo9VdlAFFu+WDrtvChLPv+PG6lb3NDO6a4WxOcjWG7YaWX2BsDAUXnzgFcXHTvWp9LlNiTdl4pF/EbekI60SYCon77WWNsSqxSO+QwuleKkCIHf7Jm5FpMc+RIb7UGZFN6/LFLtolNIp5jZ17pBDymYyKzDjYP88U7SXU3A59kJLQW6eJ5kAw5b7MyNZqsDblHGQh6/6NJ0nK7KfFS5nTgs2X05C3mbXE2jsuCtJwBb/+8tuFAqAiVVQNlMDV7az7vxR/2Uh230Fw7J9WD9x/HFiBlrttygFiy/F5jwevf8h5bMqPEugpUpOEo8JQ3FhYEZQCloNBBH2bQ0yJCIYaKF5hNgIC2j2fV0sXd5L9iB7zchFbCX07hTBgeC5tXeqrGR5qi2RvBXaWaGzqSml3eL87lFW4urZHC1M9tP3UCpaYQjM/ZQMp1T7Qu9pa/VzmcGQkDAQthNkCUYrgnYRpl4KUMyply/HVlys02x+krAPq7lRDgXZY4sFgGcZ+LL/Tjqmi1sLkvMN1HQ9v3Nl0DsEDBazr7w/Hc5a4D2hi7Uw==] >>> > TRACE - CookieRememberMeManager - Base64 decoded byte array length: >>> > 448 >>> > bytes. >>> > TRACE - JcaCipherService - Attempting to decrypt incoming byte >>> > array of length 432 >>> > DEBUG - DefaultWebSessionManager - No request or response bound to the >>> > thread. Session ID cookie cannot be removed. This could occur in a web >>> > application that also services non web clients (e.g. RMI remoting). >>> > DEBUG - DefaultSecurityManager - Resolved SubjectContext context >>> > session >>> > is invalid. Ignoring and creating an anonymous (session-less) Subject >>> > instance. >>> > org.apache.shiro.session.UnknownSessionException: There is no session >>> > with >>> > id [dc51b21d-5e34-4407-b2e2-74a2bebb7b19] >>> > at >>> > >>> > org.apache.shiro.session.mgt.eis.AbstractSessionDAO.readSession(AbstractSessionDAO.java:171) >>> > at >>> > >>> > org.apache.shiro.session.mgt.DefaultSessionManager.retrieveSessionFromDataSource(DefaultSessionManager.java:220) >>> > at >>> > >>> > org.apache.shiro.session.mgt.DefaultSessionManager.retrieveSession(DefaultSessionManager.java:216) >>> > at >>> > >>> > org.apache.shiro.session.mgt.AbstractValidatingSessionManager.doGetSession(AbstractValidatingSessionManager.java:122) >>> > at >>> > >>> > org.apache.shiro.session.mgt.AbstractSessionManager.getSession(AbstractSessionManager.java:238) >>> > at >>> > >>> > org.apache.shiro.web.session.DefaultWebSessionManager.getSession(DefaultWebSessionManager.java:178) >>> > at >>> > >>> > org.apache.shiro.web.DefaultWebSecurityManager.resolveContextSession(DefaultWebSecurityManager.java:153) >>> > at >>> > >>> > org.apache.shiro.mgt.DefaultSecurityManager.resolveSession(DefaultSecurityManager.java:385) >>> > at >>> > >>> > org.apache.shiro.mgt.DefaultSecurityManager.createSubject(DefaultSecurityManager.java:336) >>> > at >>> > org.apache.shiro.subject.Subject$Builder.buildSubject(Subject.java:819) >>> > at >>> > >>> > org.apache.shiro.web.subject.WebSubject$Builder.buildWebSubject(WebSubject.java:90) >>> > at >>> > >>> > org.apache.shiro.web.servlet.AbstractShiroFilter.createSubject(AbstractShiroFilter.java:202) >>> > at >>> > >>> > org.apache.shiro.web.servlet.AbstractShiroFilter.doFilterInternal(AbstractShiroFilter.java:269) >>> > at >>> > >>> > org.apache.shiro.web.servlet.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:83) >>> > at >>> > >>> > org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:237) >>> > at >>> > >>> > org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:167) >>> > at >>> > >>> > org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1088) >>> > at >>> > >>> > org.springframework.orm.hibernate3.support.OpenSessionInViewFilter.doFilterInternal(OpenSessionInViewFilter.java:198) >>> > at >>> > >>> > org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:76) >>> > at >>> > >>> > org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1088) >>> > at >>> > org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:360) >>> > at >>> > >>> > org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216) >>> > at >>> > org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181) >>> > at >>> > org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:729) >>> > at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:405) >>> > at >>> > org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) >>> > at org.mortbay.jetty.Server.handle(Server.java:324) >>> > at >>> > org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:505) >>> > at >>> > >>> > org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:843) >>> > at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:647) >>> > at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211) >>> > at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:380) >>> > at >>> > >>> > org.mortbay.jetty.bio.SocketConnector$Connection.run(SocketConnector.java:228) >>> > at >>> > >>> > org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:488) >>> > TRACE - DefaultSecurityManager - No identity (PrincipalCollection) >>> > found >>> > in the context. Looking for a remembered identity. >>> > DEBUG - SimpleCookie - Found string value >>> > >>> > [p9PNM4iDmrfPhCG7w+2rX1l3HtwrvkzNfF7JBrMfpVwo9VdlAFFu+WDrtvChLPv+PG6lb3NDO6a4WxOcjWG7YaWX2BsDAUXnzgFcXHTvWp9LlNiTdl4pF/EbekI60SYCon77WWNsSqxSO+QwuleKkCIHf7Jm5FpMc+RIb7UGZFN6/LFLtolNIp5jZ17pBDymYyKzDjYP88U7SXU3A59kJLQW6eJ5kAw5b7MyNZqsDblHGQh6/6NJ0nK7KfFS5nTgs2X05C3mbXE2jsuCtJwBb/+8tuFAqAiVVQNlMDV7az7vxR/2Uh230Fw7J9WD9x/HFiBlrttygFiy/F5jwevf8h5bMqPEugpUpOEo8JQ3FhYEZQCloNBBH2bQ0yJCIYaKF5hNgIC2j2fV0sXd5L9iB7zchFbCX07hTBgeC5tXeqrGR5qi2RvBXaWaGzqSml3eL87lFW4urZHC1M9tP3UCpaYQjM/ZQMp1T7Qu9pa/VzmcGQkDAQthNkCUYrgnYRpl4KUMyply/HVlys02x+krAPq7lRDgXZY4sFgGcZ+LL/Tjqmi1sLkvMN1HQ9v3Nl0DsEDBazr7w/Hc5a4D2hi7Uw==] >>> > from Cookie [rememberMe] >>> > TRACE - CookieRememberMeManager - Acquired Base64 encoded identity >>> > >>> > [p9PNM4iDmrfPhCG7w+2rX1l3HtwrvkzNfF7JBrMfpVwo9VdlAFFu+WDrtvChLPv+PG6lb3NDO6a4WxOcjWG7YaWX2BsDAUXnzgFcXHTvWp9LlNiTdl4pF/EbekI60SYCon77WWNsSqxSO+QwuleKkCIHf7Jm5FpMc+RIb7UGZFN6/LFLtolNIp5jZ17pBDymYyKzDjYP88U7SXU3A59kJLQW6eJ5kAw5b7MyNZqsDblHGQh6/6NJ0nK7KfFS5nTgs2X05C3mbXE2jsuCtJwBb/+8tuFAqAiVVQNlMDV7az7vxR/2Uh230Fw7J9WD9x/HFiBlrttygFiy/F5jwevf8h5bMqPEugpUpOEo8JQ3FhYEZQCloNBBH2bQ0yJCIYaKF5hNgIC2j2fV0sXd5L9iB7zchFbCX07hTBgeC5tXeqrGR5qi2RvBXaWaGzqSml3eL87lFW4urZHC1M9tP3UCpaYQjM/ZQMp1T7Qu9pa/VzmcGQkDAQthNkCUYrgnYRpl4KUMyply/HVlys02x+krAPq7lRDgXZY4sFgGcZ+LL/Tjqmi1sLkvMN1HQ9v3Nl0DsEDBazr7w/Hc5a4D2hi7Uw==] >>> > TRACE - CookieRememberMeManager - Base64 decoded byte array length: >>> > 448 >>> > bytes. >>> > TRACE - JcaCipherService - Attempting to decrypt incoming byte >>> > array of length 432 >>> > DEBUG - MemberServiceImpl - Finding member by id: 2 >>> > DEBUG - MemberServiceImpl - Finding member by id: 2 >>> > DEBUG - DefaultSecurityManager - Found remembered >>> > PrincipalCollection. >>> > Adding to the context to be used for subject construction by the >>> > SubjectFactory. >>> > DEBUG - DefaultSecurityManager - Found remembered >>> > PrincipalCollection. >>> > Adding to the context to be used for subject construction by the >>> > SubjectFactory. >>> > TRACE - DefaultSecurityManager - No session in the current subject >>> > context. One will be created to persist principals [2] Doing this >>> > prevents >>> > unnecessary repeated RememberMe operations since an identity has been >>> > discovered. >>> > TRACE - DefaultSecurityManager - No session in the current subject >>> > context. One will be created to persist principals [2] Doing this >>> > prevents >>> > unnecessary repeated RememberMe operations since an identity has been >>> > discovered. >>> > TRACE - DefaultSessionManager - Creating session for host 127.0.0.1 >>> > DEBUG - DefaultSessionManager - Creating new EIS record for new >>> > session >>> > instance [org.apache.shiro.session.mgt.SimpleSession,id=null] >>> > TRACE - DefaultSessionManager - Creating session for host 127.0.0.1 >>> > DEBUG - DefaultSessionManager - Creating new EIS record for new >>> > session >>> > instance [org.apache.shiro.session.mgt.SimpleSession,id=null] >>> > DEBUG - DefaultWebSessionManager - Request or response object is not >>> > bound >>> > to the thread. Assuming this session start activity is due to a non web >>> > request (possible in a web application that also services non web >>> > clients. >>> > DEBUG - DefaultWebSessionManager - Request or response object is not >>> > bound >>> > to the thread. Assuming this session start activity is due to a non web >>> > request (possible in a web application that also services non web >>> > clients. >>> > DEBUG - DefaultSecurityManager - Created session with id >>> > f090c5a5-8461-4411-a1b4-468a5637eb55 to retain discovered principals 2 >>> > DEBUG - DefaultSecurityManager - Created session with id >>> > d406a455-494b-4194-bf57-7f47fc4ccd50 to retain discovered principals 2 >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [d406a455-494b-4194-bf57-7f47fc4ccd50] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [f090c5a5-8461-4411-a1b4-468a5637eb55] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [d406a455-494b-4194-bf57-7f47fc4ccd50] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [d406a455-494b-4194-bf57-7f47fc4ccd50] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [f090c5a5-8461-4411-a1b4-468a5637eb55] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [f090c5a5-8461-4411-a1b4-468a5637eb55] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [f090c5a5-8461-4411-a1b4-468a5637eb55] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [d406a455-494b-4194-bf57-7f47fc4ccd50] >>> > TRACE - DelegatingSubject - attempting to get session; create = >>> > false; session is null = false; session has id = true >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [d406a455-494b-4194-bf57-7f47fc4ccd50] >>> > 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 - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [f090c5a5-8461-4411-a1b4-468a5637eb55] >>> > 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 - 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 >>> > [f090c5a5-8461-4411-a1b4-468a5637eb55] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [d406a455-494b-4194-bf57-7f47fc4ccd50] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [f090c5a5-8461-4411-a1b4-468a5637eb55] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [d406a455-494b-4194-bf57-7f47fc4ccd50] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [f090c5a5-8461-4411-a1b4-468a5637eb55] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [d406a455-494b-4194-bf57-7f47fc4ccd50] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [f090c5a5-8461-4411-a1b4-468a5637eb55] >>> > TRACE - ctValidatingSessionManager - Attempting to retrieve session with >>> > id >>> > [d406a455-494b-4194-bf57-7f47fc4ccd50] >>> > TRACE - ShiroFilterFactoryBean - Ignoring non-Filter bean >>> > 'assignorsResource' >>> > 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 - 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...@3792ca4c[id=2,Name=beck] >>> > DEBUG - MemberServiceImpl - Returning member: >>> > com.sprtz.model.mem...@1c9ac1e4[id=2,Name=beck] >>> > DEBUG - GameJsonServiceImpl - Get Games managed by member: >>> > com.sprtz.model.mem...@3792ca4c[id=2,Name=beck] >>> > Is there anything in these logs that should concern me? Specifically, >>> > the >>> > following entries make me wonder if everything is working correctly: >>> > DEBUG - DefaultWebSessionManager - No request or response bound to the >>> > thread. Session ID cookie cannot be removed. This could occur in a web >>> > application that also services non web clients (e.g. RMI remoting). >>> > DEBUG - DefaultSecurityManager - Resolved SubjectContext context >>> > session >>> > is invalid. Ignoring and creating an anonymous (session-less) Subject >>> > instance. >>> > org.apache.shiro.session.UnknownSessionException: There is no session >>> > with >>> > id [dc51b21d-5e34-4407-b2e2-74a2bebb7b19] >>> > TRACE - DefaultSecurityManager - No session in the current subject >>> > context. One will be created to persist principals [2] Doing this >>> > prevents >>> > unnecessary repeated RememberMe operations since an identity has been >>> > discovered. >>> > TRACE - DefaultSessionManager - Creating session for host 127.0.0.1 >>> > DEBUG - DefaultSessionManager - Creating new EIS record for new >>> > session >>> > instance [org.apache.shiro.session.mgt.SimpleSession,id=null] >>> > DEBUG - DefaultWebSessionManager - Request or response object is not >>> > bound >>> > to the thread. Assuming this session start activity is due to a non web >>> > request (possible in a web application that also services non web >>> > clients. >>> > Thanks again, >>> > Tauren >>> > >>> > >>> > On Mon, May 17, 2010 at 6:18 PM, Tauren Mills <[email protected]> wrote: >>> >> >>> >> I just updated to the 165 version and it seems to now be working >>> >> reliably! >>> >> Very nice... Will report back if I have futher problems. What was it >>> >> that >>> >> Kalle fixed, what issue number so I can take a look? >>> >> Thanks, >>> >> Tauren >>> >> >>> >> On Mon, May 17, 2010 at 6:08 PM, Tauren Mills <[email protected]> >>> >> wrote: >>> >>> >>> >>> I'm using this snapshot, which I updated to only about 5 or 6 hours >>> >>> ago: >>> >>> shiro-core-1.0-incubating-20100515.200134-162.jar dated 5/17/2010 at >>> >>> 12:08:40PM PDT >>> >>> I'll try updating again and see if it helps. >>> >>> Tauren >>> >>> >>> >>> On Mon, May 17, 2010 at 6:00 PM, Les Hazlewood <[email protected]> >>> >>> wrote: >>> >>>> >>> >>>> Hi Tauren - quick question - are you using the very latest snapshot? >>> >>>> Kalle committed a fix to the codebase today that helped fix a bug >>> >>>> related to intermittent failures. >>> >>>> >>> >>>> On Mon, May 17, 2010 at 5:36 PM, Tauren Mills <[email protected]> >>> >>>> wrote: >>> >>>> > 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 >>> >>>> > >>> >>> >>> >> >>> > >>> > >> >> >
