Return-Path: X-Original-To: apmail-jackrabbit-users-archive@minotaur.apache.org Delivered-To: apmail-jackrabbit-users-archive@minotaur.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id A51A292DB for ; Thu, 1 Mar 2012 14:26:58 +0000 (UTC) Received: (qmail 43937 invoked by uid 500); 1 Mar 2012 14:26:58 -0000 Delivered-To: apmail-jackrabbit-users-archive@jackrabbit.apache.org Received: (qmail 43905 invoked by uid 500); 1 Mar 2012 14:26:58 -0000 Mailing-List: contact users-help@jackrabbit.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: users@jackrabbit.apache.org Delivered-To: mailing list users@jackrabbit.apache.org Received: (qmail 43896 invoked by uid 99); 1 Mar 2012 14:26:58 -0000 Received: from athena.apache.org (HELO athena.apache.org) (140.211.11.136) by apache.org (qpsmtpd/0.29) with ESMTP; Thu, 01 Mar 2012 14:26:58 +0000 X-ASF-Spam-Status: No, hits=-0.7 required=5.0 tests=RCVD_IN_DNSWL_LOW,SPF_PASS X-Spam-Check-By: apache.org Received-SPF: pass (athena.apache.org: domain of jan.haderka@magnolia-cms.com designates 109.71.96.11 as permitted sender) Received: from [109.71.96.11] (HELO mail.magnolia-cms.com) (109.71.96.11) by apache.org (qpsmtpd/0.29) with ESMTP; Thu, 01 Mar 2012 14:26:50 +0000 X-Spam-Level: X-Footer: bWFnbm9saWEtY21zLmNvbQ== Received: from [10.0.1.3] ([90.183.155.218]) (authenticated user jan.haderka@magnolia-cms.com) by mail.magnolia-cms.com (Kerio Connect 7.3.2) (using TLSv1/SSLv3 with cipher AES128-SHA (128 bits)) for users@jackrabbit.apache.org; Thu, 1 Mar 2012 15:26:27 +0100 Content-Type: text/plain; charset=us-ascii Mime-Version: 1.0 (Apple Message framework v1084) Subject: Re: RepositoryImpl closing sessions twice on shutdown From: Jan Haderka In-Reply-To: <98F2D51B-0A81-4BDD-8651-52E41C38D663@magnolia-cms.com> Date: Thu, 1 Mar 2012 15:26:26 +0100 Content-Transfer-Encoding: quoted-printable Message-Id: <31C98918-67C0-4699-BFF5-3E7EFCC0BFF7@magnolia-cms.com> References: <98F2D51B-0A81-4BDD-8651-52E41C38D663@magnolia-cms.com> To: users@jackrabbit.apache.org X-Mailer: Apple Mail (2.1084) X-Virus-Checked: Checked by ClamAV on apache.org X-Old-Spam-Status: No, hits=0.0 required=5.0 tests=AWL: 0.062,BAYES_00: -1.665,TOTAL_SCORE: -1.603,autolearn=ham Seems like there is no wisdom or other interest in this issue, so I've = logged it as https://issues.apache.org/jira/browse/JCR-3246 since I = failed to find a solution for the problem apart from changing JR code. Would be nice if this can be fixed in 1.4.1 Thanks, Jan On Feb 28, 2012, at 11:00 AM, Jan Haderka wrote: > Hi, > I ran into strange issue w/ JR 2.4.0.=20 > On shutdown sessions are being closed twice which lead to the = exception being logged as shown below. As far as I can tell = RepositoryImpl has system sessions in the list of active sessions which = is why it tries to close them twice - first time when closing all active = sessions (RepositoryImpl.java:1078) and second time when disposing = workspace (RepositoryImpl.java:1090). >=20 > However I have no idea if the system session is supposed to be on the = list of active sessions or not.=20 > Also it seems to be related to timing - I have troubles reproducing = the issue with debugger attached to the server. >=20 > Is this known issue? Any pointers to what to look for when preventing = this issue from occurring? >=20 > Thanks, > Jan >=20 >=20 > 2012-02-28 10:36:00,614 WARN = org.apache.jackrabbit.core.session.SessionState : Attempt to close = session-31 after it has already been closed. Please review your code for = proper session management. > java.lang.Exception: Stack trace of the duplicate attempt to close = session-31 > at = org.apache.jackrabbit.core.session.SessionState.close(SessionState.java:28= 0) > at = org.apache.jackrabbit.core.SessionImpl.logout(SessionImpl.java:943) > at = org.apache.jackrabbit.core.XASessionImpl.logout(XASessionImpl.java:392) > at = org.apache.jackrabbit.core.security.user.UserManagerImpl.loggedOut(UserMan= agerImpl.java:1115) > at = org.apache.jackrabbit.core.SessionImpl.notifyLoggedOut(SessionImpl.java:56= 5) > at = org.apache.jackrabbit.core.SessionImpl.logout(SessionImpl.java:979) > at = org.apache.jackrabbit.core.RepositoryImpl$WorkspaceInfo.doDispose(Reposito= ryImpl.java:2200) > at = org.apache.jackrabbit.core.RepositoryImpl$WorkspaceInfo.dispose(Repository= Impl.java:2154) > at = org.apache.jackrabbit.core.RepositoryImpl.doShutdown(RepositoryImpl.java:1= 090) > at = org.apache.jackrabbit.core.RepositoryImpl.shutdown(RepositoryImpl.java:104= 1) > at = org.apache.jackrabbit.core.jndi.BindableRepository.shutdown(BindableReposi= tory.java:259) > at = org.apache.jackrabbit.core.jndi.RegistryHelper.unregisterRepository(Regist= ryHelper.java:94) > ... > 2012-02-28 10:36:00,617 WARN = org.apache.jackrabbit.core.session.SessionState : session-31 has = already been closed. See the attached exception for a trace of where = this session was closed. > java.lang.Exception: Stack trace of where session-31 was originally = closed > at = org.apache.jackrabbit.core.session.SessionState.close(SessionState.java:27= 5) > at = org.apache.jackrabbit.core.SessionImpl.logout(SessionImpl.java:943) > at = org.apache.jackrabbit.core.XASessionImpl.logout(XASessionImpl.java:392) > at = org.apache.jackrabbit.core.RepositoryImpl.doShutdown(RepositoryImpl.java:1= 078) > at = org.apache.jackrabbit.core.RepositoryImpl.shutdown(RepositoryImpl.java:104= 1) > at = org.apache.jackrabbit.core.jndi.BindableRepository.shutdown(BindableReposi= tory.java:259) > at = org.apache.jackrabbit.core.jndi.RegistryHelper.unregisterRepository(Regist= ryHelper.java:94) > ... >=20 >=20 >=20