Re: [xwiki-dev] Is XWikiAuthServiceImpl.authenticate called on every page view?

Ludovic, Jérémi, thank you for answering my probably dumb questions. :) Yes I do see the name at the top. Here's what is confusing me. I have written a very simple extension to the authentication service implementation like this: public class myAuthService extends XWikiAuthServiceImpl { private static final Log log = LogFactory.getLog(myAuthService.class); public Principal authenticate(String username, String password, XWikiContext context) throws XWikiException { log.debug("myAuthService: robinf - in authenticate."); return super.authenticate(username, password, context); } } I have set in xwiki.cfg: xwiki.authentication.authclass=com.ibm.robinf.xwiki.authentication.myAuthService and in the log4j.properties I have added: log4j.logger.com.ibm.robinf.xwiki.authentication.myAuthService=debug Here is my xwiki.log after several page visits. You'll see that there is just one occurence of the trace string "myAuthService: robinf - in authenticate". I'm on XWiki v0.9.840, and I'm assuming the exceptions are explained by http://mail-archive.objectweb.org/xwiki-users/2005-12/msg00077.html . -------------------------- 16:48:17,265 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'login' 16:48:19,098 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/login/XWiki/XWikiLogin Configurator:configure:126 - No configuration found. Configuring ehcache from ehcache-failsafe.xml found in the classpath: jar:file:/C:/Program%20Files/Apache%20Software%20Foundation/Tomcat%205.5/webapps/xwiki/WEB-INF/lib/ehcache-1.1.jar!/ehcache-failsafe.xml 16:48:21,882 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/login/XWiki/XWikiLogin XWikiHibernateStore:updateSchema:177 - Schema update for wiki xwiki 16:48:25,817 DEBUG http-8080-Processor25 http://localhost:8080/xwiki/bin/login/XWiki/XWikiLogin myAuthService:authenticate:16 - myAuthService: robinf - in authenticate (user: robintest) 16:48:26,368 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'view' 16:48:40,228 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/XWiki/robintest XWikiStatsServiceImpl:addCookie:474 - Setting cookie WMKS8KK6ODUTD58A0ZOK4FNRM0IQ13OP for name visitid with domain localhost and path / and maxage -2074260 16:48:40,228 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/XWiki/robintest XWikiStatsServiceImpl:findVisit:314 - Found visit with cookie UB3FYZV9J09JZ2UBWPRVMAQPJAQATSTS in session 0C98371BFD9D704F6C4E732928ABD862 for request with cookie WMKS8KK6ODUTD58A0ZOK4FNRM0IQ13OP 16:48:40,949 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/view/XWiki/robintest AssertionFailure:<init>:22 - an assertion failure occured (this may indicate a bug in Hibernate, but is more likely due to unsafe use of the session) org.hibernate.AssertionFailure: possible nonthreadsafe access to session at org.hibernate.action.EntityDeleteAction.execute(EntityDeleteAction.java:68) at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:239) at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:223) at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:141) at org.hibernate.event.def.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:274) at org.hibernate.event.def.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:27) at org.hibernate.impl.SessionImpl.flush(SessionImpl.java:726) at org.hibernate.impl.SessionImpl.managedFlush(SessionImpl.java:320) at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:86) at com.xpn.xwiki.store.XWikiHibernateStore.endTransaction(XWikiHibernateStore.java:350) at com.xpn.xwiki.store.XWikiHibernateStore.deleteXWikiCollection(XWikiHibernateStore.java:982) at com.xpn.xwiki.stats.impl.XWikiStatsServiceImpl.notify(XWikiStatsServiceImpl.java:209) at com.xpn.xwiki.notify.XWikiActionRule.verify(XWikiActionRule.java:51) at com.xpn.xwiki.notify.XWikiNotificationManager.verify(XWikiNotificationManager.java:93) at com.xpn.xwiki.web.ViewEditAction.execute(ViewEditAction.java:268) at org.apache.struts.action.RequestProcessor.processActionPerform(RequestProcessor.java:421) at org.apache.struts.action.RequestProcessor.process(RequestProcessor.java:226) at org.apache.struts.action.ActionServlet.process(ActionServlet.java:1164) at org.apache.struts.action.ActionServlet.doGet(ActionServlet.java:397) at javax.servlet.http.HttpServlet.service(HttpServlet.java:689) at javax.servlet.http.HttpServlet.service(HttpServlet.java:802) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:252) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173) at com.xpn.xwiki.web.SetCharacterEncodingFilter.doFilter(SetCharacterEncodingFilter.java:127) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:178) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:126) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:105) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:107) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:148) at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:868) at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:663) at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:527) at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:80) at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:684) at java.lang.Thread.run(Thread.java:788) 16:48:43,393 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'view' 16:48:46,067 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome XWikiStatsServiceImpl:addCookie:474 - Setting cookie AAYI0BUY6AZCPDBPUVB6SYQF7W4GOXSN for name visitid with domain localhost and path / and maxage -2074265 16:48:46,077 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome XWikiStatsServiceImpl:findVisit:314 - Found visit with cookie UB3FYZV9J09JZ2UBWPRVMAQPJAQATSTS in session 0C98371BFD9D704F6C4E732928ABD862 for request with cookie AAYI0BUY6AZCPDBPUVB6SYQF7W4GOXSN 16:48:46,097 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome AssertionFailure:<init>:22 - an assertion failure occured (this may indicate a bug in Hibernate, but is more likely due to unsafe use of the session) org.hibernate.AssertionFailure: possible nonthreadsafe access to session at org.hibernate.action.EntityDeleteAction.execute(EntityDeleteAction.java:68) at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:239) [*snip* removing recurring stacktrace for legibility *snip*] at java.lang.Thread.run(Thread.java:788) 16:48:54,739 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'view' 16:48:59,866 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/XWiki/robintest XWikiStatsServiceImpl:addCookie:474 - Setting cookie HYUPZKDBBPIRN8SOMQ4WGKURIE5GEXMX for name visitid with domain localhost and path / and maxage -2074279 16:48:59,956 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/XWiki/robintest XWikiStatsServiceImpl:findVisit:314 - Found visit with cookie UB3FYZV9J09JZ2UBWPRVMAQPJAQATSTS in session 0C98371BFD9D704F6C4E732928ABD862 for request with cookie HYUPZKDBBPIRN8SOMQ4WGKURIE5GEXMX 16:49:00,537 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/view/XWiki/robintest AssertionFailure:<init>:22 - an assertion failure occured (this may indicate a bug in Hibernate, but is more likely due to unsafe use of the session) org.hibernate.AssertionFailure: possible nonthreadsafe access to session at org.hibernate.action.EntityDeleteAction.execute(EntityDeleteAction.java:68) at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:239) [*snip* removing recurring stacktrace for legibility *snip*] at java.lang.Thread.run(Thread.java:788) 16:49:02,610 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'view' 16:49:04,533 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/Teams XWikiStatsServiceImpl:addCookie:474 - Setting cookie DIXM1WAGYLHJQNYFVSCWUFKZ85ZFVKN2 for name visitid with domain localhost and path / and maxage -2074284 16:49:04,593 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/Teams XWikiStatsServiceImpl:findVisit:314 - Found visit with cookie UB3FYZV9J09JZ2UBWPRVMAQPJAQATSTS in session 0C98371BFD9D704F6C4E732928ABD862 for request with cookie DIXM1WAGYLHJQNYFVSCWUFKZ85ZFVKN2 16:49:04,673 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/Teams AssertionFailure:<init>:22 - an assertion failure occured (this may indicate a bug in Hibernate, but is more likely due to unsafe use of the session) org.hibernate.AssertionFailure: possible nonthreadsafe access to session at org.hibernate.action.EntityDeleteAction.execute(EntityDeleteAction.java:68) at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:239) [*snip* removing recurring stacktrace for legibility *snip*] at java.lang.Thread.run(Thread.java:788) 16:49:07,457 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'view' 16:49:08,779 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/Teams XWikiStatsServiceImpl:addCookie:474 - Setting cookie XIO9V3257B1UPP6WB82BLCHOYYKDZAGQ for name visitid with domain localhost and path / and maxage -2074288 16:49:08,919 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/Teams XWikiStatsServiceImpl:findVisit:314 - Found visit with cookie UB3FYZV9J09JZ2UBWPRVMAQPJAQATSTS in session 0C98371BFD9D704F6C4E732928ABD862 for request with cookie XIO9V3257B1UPP6WB82BLCHOYYKDZAGQ 16:49:09,010 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/Teams AssertionFailure:<init>:22 - an assertion failure occured (this may indicate a bug in Hibernate, but is more likely due to unsafe use of the session) org.hibernate.AssertionFailure: possible nonthreadsafe access to session at org.hibernate.action.EntityDeleteAction.execute(EntityDeleteAction.java:68) at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:239) [*snip* removing recurring stacktrace for legibility *snip*] at java.lang.Thread.run(Thread.java:788) 16:49:09,080 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'skin' 16:49:09,110 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'skin' 16:49:09,130 WARN http-8080-Processor24 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'skin' 16:49:09,200 WARN http-8080-Processor22 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'skin' 16:49:09,220 WARN http-8080-Processor23 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'skin' 16:49:09,400 WARN http-8080-Processor24 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'skin' 16:49:09,430 WARN http-8080-Processor22 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'skin' 16:49:09,440 WARN http-8080-Processor23 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'skin' 16:49:10,101 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'skin' 16:49:12,224 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'view' 16:49:12,394 WARN Finalizer thread JDBCContext:finalize:333 - afterTransactionCompletion() was never called 16:49:12,394 WARN Finalizer thread JDBCContext:finalize:333 - afterTransactionCompletion() was never called 16:49:12,394 WARN Finalizer thread JDBCContext:finalize:333 - afterTransactionCompletion() was never called 16:49:12,394 WARN Finalizer thread JDBCContext:finalize:333 - afterTransactionCompletion() was never called 16:49:12,394 WARN Finalizer thread JDBCContext:finalize:333 - afterTransactionCompletion() was never called 16:49:14,748 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/JTC/ArchitectureAndDesign XWikiStatsServiceImpl:addCookie:474 - Setting cookie B6LRLQQ1YOETNSAIZLGNEYHJRGAEFK0R for name visitid with domain localhost and path / and maxage -2074294 16:49:14,748 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/JTC/ArchitectureAndDesign XWikiStatsServiceImpl:findVisit:314 - Found visit with cookie UB3FYZV9J09JZ2UBWPRVMAQPJAQATSTS in session 0C98371BFD9D704F6C4E732928ABD862 for request with cookie B6LRLQQ1YOETNSAIZLGNEYHJRGAEFK0R 16:49:14,838 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/view/JTC/ArchitectureAndDesign AssertionFailure:<init>:22 - an assertion failure occured (this may indicate a bug in Hibernate, but is more likely due to unsafe use of the session) org.hibernate.AssertionFailure: possible nonthreadsafe access to session at org.hibernate.action.EntityDeleteAction.execute(EntityDeleteAction.java:68) at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:239) [*snip* removing recurring stacktrace for legibility *snip*] at java.lang.Thread.run(Thread.java:788) -------------------------- Since my last mail I established what I had changed on my system: I set the cookie domain to localhost. If I remove the cookie domain from my xwiki.cfg as so: #xwiki.authentication.cookiedomains=localhost then my trace point _does_ get hit on every page view: -------------------------- 17:00:18,052 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'view' 17:00:19,734 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome Configurator:configure:126 - No configuration found. Configuring ehcache from ehcache-failsafe.xml found in the classpath: jar:file:/C:/Program%20Files/Apache%20Software%20Foundation/Tomcat%205.5/webapps/xwiki/WEB-INF/lib/ehcache-1.1.jar!/ehcache-failsafe.xml 17:00:22,218 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome XWikiHibernateStore:updateSchema:177 - Schema update for wiki xwiki 17:00:26,604 DEBUG http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome myAuthService:authenticate:16 - myAuthService: robinf - in authenticate (user: robintest) 17:00:36,308 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome XWikiStatsServiceImpl:addCookie:474 - Setting cookie ZLYJYGUWZXCMUR8OKGRPEKRLNJU4Y6BG for name visitid with domain null and path / and maxage -2074255 17:00:36,308 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome XWikiStatsServiceImpl:findVisit:314 - Found visit with cookie UB3FYZV9J09JZ2UBWPRVMAQPJAQATSTS in session 0C98371BFD9D704F6C4E732928ABD862 for request with cookie ZLYJYGUWZXCMUR8OKGRPEKRLNJU4Y6BG 17:00:36,758 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome AssertionFailure:<init>:22 - an assertion failure occured (this may indicate a bug in Hibernate, but is more likely due to unsafe use of the session) org.hibernate.AssertionFailure: possible nonthreadsafe access to session at org.hibernate.action.EntityDeleteAction.execute(EntityDeleteAction.java:68) at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:239) [*snip* removing recurring stacktrace for legibility *snip*] at java.lang.Thread.run(Thread.java:788) 17:00:42,977 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'view' 17:00:42,987 DEBUG http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/Teams myAuthService:authenticate:16 - myAuthService: robinf - in authenticate (user: robintest) 17:00:46,432 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/Teams XWikiStatsServiceImpl:addCookie:474 - Setting cookie VDJ4LC3FPKAT0XVU8ITI7SLGNPSBKN1W for name visitid with domain null and path / and maxage -2074265 17:00:46,442 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/Teams XWikiStatsServiceImpl:findVisit:314 - Found visit with cookie UB3FYZV9J09JZ2UBWPRVMAQPJAQATSTS in session 0C98371BFD9D704F6C4E732928ABD862 for request with cookie VDJ4LC3FPKAT0XVU8ITI7SLGNPSBKN1W 17:00:46,462 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/Teams AssertionFailure:<init>:22 - an assertion failure occured (this may indicate a bug in Hibernate, but is more likely due to unsafe use of the session) org.hibernate.AssertionFailure: possible nonthreadsafe access to session at org.hibernate.action.EntityDeleteAction.execute(EntityDeleteAction.java:68) at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:239) [*snip* removing recurring stacktrace for legibility *snip*] at java.lang.Thread.run(Thread.java:788) 17:01:04,959 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'view' 17:01:04,979 DEBUG http-8080-Processor25 http://localhost:8080/xwiki/bin/view/JTC/RolesAndResponsibilities myAuthService:authenticate:16 - myAuthService: robinf - in authenticate (user: robintest) 17:01:06,361 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/JTC/RolesAndResponsibilities XWikiStatsServiceImpl:addCookie:474 - Setting cookie KWWHZOWMIHI3IBN0APUGERVCDLFNXTQS for name visitid with domain null and path / and maxage -2074285 17:01:06,361 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/JTC/RolesAndResponsibilities XWikiStatsServiceImpl:findVisit:314 - Found visit with cookie UB3FYZV9J09JZ2UBWPRVMAQPJAQATSTS in session 0C98371BFD9D704F6C4E732928ABD862 for request with cookie KWWHZOWMIHI3IBN0APUGERVCDLFNXTQS 17:01:06,511 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/view/JTC/RolesAndResponsibilities AssertionFailure:<init>:22 - an assertion failure occured (this may indicate a bug in Hibernate, but is more likely due to unsafe use of the session) org.hibernate.AssertionFailure: possible nonthreadsafe access to session at org.hibernate.action.EntityDeleteAction.execute(EntityDeleteAction.java:68) at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:239) [*snip* removing recurring stacktrace for legibility *snip*] at java.lang.Thread.run(Thread.java:788) 17:01:09,095 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'view' 17:01:09,105 DEBUG http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome myAuthService:authenticate:16 - myAuthService: robinf - in authenticate (user: robintest) 17:01:10,267 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome XWikiStatsServiceImpl:addCookie:474 - Setting cookie DBT70UT0NV9ZGNVK92UP5NDPH1YTGSML for name visitid with domain null and path / and maxage -2074289 17:01:10,267 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome XWikiStatsServiceImpl:findVisit:314 - Found visit with cookie UB3FYZV9J09JZ2UBWPRVMAQPJAQATSTS in session 0C98371BFD9D704F6C4E732928ABD862 for request with cookie DBT70UT0NV9ZGNVK92UP5NDPH1YTGSML 17:01:10,357 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/view/Main/WebHome AssertionFailure:<init>:22 - an assertion failure occured (this may indicate a bug in Hibernate, but is more likely due to unsafe use of the session) org.hibernate.AssertionFailure: possible nonthreadsafe access to session at org.hibernate.action.EntityDeleteAction.execute(EntityDeleteAction.java:68) at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:239) [*snip* removing recurring stacktrace for legibility *snip*] at java.lang.Thread.run(Thread.java:788) 17:01:24,397 WARN http-8080-Processor25 RequestUtils:createActionForm:177 - No FormBeanConfig found under 'view' 17:01:24,407 DEBUG http-8080-Processor25 http://localhost:8080/xwiki/bin/view/JTC/RolesAndResponsibilities myAuthService:authenticate:16 - myAuthService: robinf - in authenticate (user: robintest) 17:01:25,629 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/JTC/RolesAndResponsibilities XWikiStatsServiceImpl:addCookie:474 - Setting cookie PZ8I4VLKA1U18EFQRV64M7W11OMPNA2F for name visitid with domain null and path / and maxage -2074304 17:01:25,629 WARN http-8080-Processor25 http://localhost:8080/xwiki/bin/view/JTC/RolesAndResponsibilities XWikiStatsServiceImpl:findVisit:314 - Found visit with cookie UB3FYZV9J09JZ2UBWPRVMAQPJAQATSTS in session 0C98371BFD9D704F6C4E732928ABD862 for request with cookie PZ8I4VLKA1U18EFQRV64M7W11OMPNA2F 17:01:25,739 ERROR http-8080-Processor25 http://localhost:8080/xwiki/bin/view/JTC/RolesAndResponsibilities AssertionFailure:<init>:22 - an assertion failure occured (this may indicate a bug in Hibernate, but is more likely due to unsafe use of the session) org.hibernate.AssertionFailure: possible nonthreadsafe access to session at org.hibernate.action.EntityDeleteAction.execute(EntityDeleteAction.java:68) at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:239) [*snip* removing recurring stacktrace for legibility *snip*] at java.lang.Thread.run(Thread.java:788) -------------------------- Is this behaviour expected? If so, could you explain a little bit what is going on? Thanks again! Robin. On 10/02/06, jeremi joslin &lt;jeremi23(a)gmail.com&gt; wrote: