[xwiki-dev] Is XWikiAuthServiceImpl.authenticate called on every page view?
Hi, Assuming "Always Authenticate on Viewing" is enabled in the wiki preferences, should XWikiAuthServiceImpl.authenticate(user, password, context) actually get called on every page view? Or is some cookie used to prevent this? I ask because this behaviour seems to have changed on my local xwiki installation, and I'm not what I've done to cause the change (it used to get called on every page view, and doesn't any more). Thanks, Robin.
Hi, As I can see in the code, it's call before opening every page. I'm not sure, but i don't think some cookie used to prevent this. I configure my wiki like yours (Always Authenticate on Viewing enabled) and it's always called. Can you give us more informations? Jérémi On 2/10/06, Robin Fernandes <[email protected]> wrote:
Hi,
Assuming "Always Authenticate on Viewing" is enabled in the wiki preferences, should XWikiAuthServiceImpl.authenticate(user, password, context) actually get called on every page view? Or is some cookie used to prevent this?
I ask because this behaviour seems to have changed on my local xwiki installation, and I'm not what I've done to cause the change (it used to get called on every page view, and doesn't any more).
Thanks, Robin.
-- You receive this message as a subscriber of the [email protected] mailing list. To unsubscribe: mailto:[email protected] For general help: mailto:[email protected]?subject=help ObjectWeb mailing lists service home page: http://www.objectweb.org/wws
-- Blog: http://www.jeremi.info LinkedIn: https://www.linkedin.com/profile?viewProfile=&key=1437724 http://www.xwiki.org skype: jeremi23 -- msn et gtalk : [email protected]
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 <[email protected]> wrote:
Hi, As I can see in the code, it's call before opening every page. I'm not sure, but i don't think some cookie used to prevent this.
I configure my wiki like yours (Always Authenticate on Viewing enabled) and it's always called.
Can you give us more informations?
Jérémi
On 2/10/06, Robin Fernandes <[email protected]> wrote:
Hi,
Assuming "Always Authenticate on Viewing" is enabled in the wiki preferences, should XWikiAuthServiceImpl.authenticate(user, password, context) actually get called on every page view? Or is some cookie used to prevent this?
I ask because this behaviour seems to have changed on my local xwiki installation, and I'm not what I've done to cause the change (it used to get called on every page view, and doesn't any more).
Thanks, Robin.
-- You receive this message as a subscriber of the [email protected] mailing list. To unsubscribe: mailto:[email protected] For general help: mailto:[email protected]?subject=help ObjectWeb mailing lists service home page: http://www.objectweb.org/wws
-- Blog: http://www.jeremi.info LinkedIn: https://www.linkedin.com/profile?viewProfile=&key=1437724 http://www.xwiki.org skype: jeremi23 -- msn et gtalk : [email protected]
-- You receive this message as a subscriber of the [email protected] mailing list. To unsubscribe: mailto:[email protected] For general help: mailto:[email protected]?subject=help ObjectWeb mailing lists service home page: http://www.objectweb.org/wws
Hi, I use the last version of XWiki, I do the same as you and myAuthService is always called. Maybe ludovic have an idea about that? Jérémi On 2/11/06, Robin Fernandes <[email protected]> wrote:
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 <[email protected]> wrote:
Hi, As I can see in the code, it's call before opening every page. I'm not sure, but i don't think some cookie used to prevent this.
I configure my wiki like yours (Always Authenticate on Viewing enabled) and it's always called.
Can you give us more informations?
Jérémi
On 2/10/06, Robin Fernandes <[email protected]> wrote:
Hi,
Assuming "Always Authenticate on Viewing" is enabled in the wiki preferences, should XWikiAuthServiceImpl.authenticate(user, password, context) actually get called on every page view? Or is some cookie used to prevent this?
I ask because this behaviour seems to have changed on my local xwiki installation, and I'm not what I've done to cause the change (it used to get called on every page view, and doesn't any more).
Thanks, Robin.
-- You receive this message as a subscriber of the [email protected] mailing list. To unsubscribe: mailto:[email protected] For general help: mailto:[email protected]?subject=help ObjectWeb mailing lists service home page: http://www.objectweb.org/wws
-- Blog: http://www.jeremi.info LinkedIn: https://www.linkedin.com/profile?viewProfile=&key=1437724 http://www.xwiki.org skype: jeremi23 -- msn et gtalk : [email protected]
-- You receive this message as a subscriber of the [email protected] mailing list. To unsubscribe: mailto:[email protected] For general help: mailto:[email protected]?subject=help ObjectWeb mailing lists service home page: http://www.objectweb.org/wws
-- You receive this message as a subscriber of the [email protected] mailing list. To unsubscribe: mailto:[email protected] For general help: mailto:[email protected]?subject=help ObjectWeb mailing lists service home page: http://www.objectweb.org/wws
-- Blog: http://www.jeremi.info LinkedIn: https://www.linkedin.com/profile?viewProfile=&key=1437724 http://www.xwiki.org skype: jeremi23 -- msn et gtalk : [email protected]
I looked at the code, and as I expected: 1/ First login, the form is presented and login is performed from the form data 2/ Second login, the username/password is extracted from the cookie and passed to the authenticate function So the authenticate function should be called each time.. I think debugging would be the best for you to understand what's going on Ludovic jeremi joslin a écrit :
Hi, I use the last version of XWiki, I do the same as you and myAuthService is always called.
Maybe ludovic have an idea about that?
Jérémi
On 2/11/06, Robin Fernandes <[email protected]> wrote:
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 <[email protected]> wrote:
Hi, As I can see in the code, it's call before opening every page. I'm not sure, but i don't think some cookie used to prevent this.
I configure my wiki like yours (Always Authenticate on Viewing enabled) and it's always called.
Can you give us more informations?
Jérémi
On 2/10/06, Robin Fernandes <[email protected]> wrote:
Hi,
Assuming "Always Authenticate on Viewing" is enabled in the wiki preferences, should XWikiAuthServiceImpl.authenticate(user, password, context) actually get called on every page view? Or is some cookie used to prevent this?
I ask because this behaviour seems to have changed on my local xwiki installation, and I'm not what I've done to cause the change (it used to get called on every page view, and doesn't any more).
Thanks, Robin.
-- You receive this message as a subscriber of the [email protected] mailing list. To unsubscribe: mailto:[email protected] For general help: mailto:[email protected]?subject=help ObjectWeb mailing lists service home page: http://www.objectweb.org/wws
-- Blog: http://www.jeremi.info LinkedIn: https://www.linkedin.com/profile?viewProfile=&key=1437724 http://www.xwiki.org skype: jeremi23 -- msn et gtalk : [email protected]
-- You receive this message as a subscriber of the [email protected] mailing list. To unsubscribe: mailto:[email protected] For general help: mailto:[email protected]?subject=help ObjectWeb mailing lists service home page: http://www.objectweb.org/wws
-- You receive this message as a subscriber of the [email protected] mailing list. To unsubscribe: mailto:[email protected] For general help: mailto:[email protected]?subject=help ObjectWeb mailing lists service home page: http://www.objectweb.org/wws
-- Blog: http://www.jeremi.info LinkedIn: https://www.linkedin.com/profile?viewProfile=&key=1437724 http://www.xwiki.org skype: jeremi23 -- msn et gtalk : [email protected]
------------------------------------------------------------------------
-- You receive this message as a subscriber of the [email protected] mailing list. To unsubscribe: mailto:[email protected] For general help: mailto:[email protected]?subject=help ObjectWeb mailing lists service home page: http://www.objectweb.org/wws
-- Ludovic Dubost XPertNet: http://www.xpertnet.fr/ Blog: http://www.ludovic.org/blog/ XWiki: http://www.xwiki.com Skype: ldubost AIM: nvludo Yahoo: ludovic
participants (3)
-
jeremi joslin -
Ludovic Dubost -
Robin Fernandes