14:10:03,801 [main:jboss.web.deployment:war=lams-admin.war,id=165027451 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Initializing filter 'HibernateFilter' 14:10:03,832 [main:jboss.web.deployment:war=lams-admin.war,id=165027451 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Filter 'HibernateFilter' configured successfully 14:10:03,847 [main:jboss.web.deployment:war=lams-admin.war,id=165027451 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:03,847 [main:jboss.web.deployment:war=lams-admin.war,id=165027451 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:09,379 [main:jboss.web.deployment:war=lams-central.war,id=-356408316 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:11,441 [main:jboss.web.deployment:war=lams-central.war,id=-356408316 WebModule] DEBUG org.lamsfoundation.lams.tool.qa.QaQueContent - org.apache.log4j.Logger@131cd12 org.lamsfoundation.lams.tool.qa.QaQueContentin constructor: QaQueContent() 14:10:11,519 [main:jboss.web.deployment:war=lams-central.war,id=-356408316 WebModule] DEBUG org.lamsfoundation.lams.tool.qa.QaQueContent - org.apache.log4j.Logger@131cd12 org.lamsfoundation.lams.tool.qa.QaQueContent$$EnhancerByCGLIB$$58f51929in constructor: QaQueContent() 14:10:11,519 [main:jboss.web.deployment:war=lams-central.war,id=-356408316 WebModule] DEBUG org.lamsfoundation.lams.tool.qa.QaQueContent - org.apache.log4j.Logger@131cd12 org.lamsfoundation.lams.tool.qa.QaQueContentin constructor: QaQueContent() 14:10:16,863 [main:jboss.web.deployment:war=lams-central.war,id=-356408316 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Initializing filter 'hibernateFilter' 14:10:16,863 [main:jboss.web.deployment:war=lams-central.war,id=-356408316 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Filter 'hibernateFilter' configured successfully 14:10:16,863 [main:jboss.web.deployment:war=lams-central.war,id=-356408316 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:16,863 [main:jboss.web.deployment:war=lams-central.war,id=-356408316 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:20,145 [main:jboss.web.deployment:war=lams-learning.war,id=-1378480900 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:20,520 [main:jboss.web.deployment:war=lams-learning.war,id=-1378480900 WebModule] DEBUG org.lamsfoundation.lams.tool.qa.QaQueContent - org.apache.log4j.Logger@131cd12 org.lamsfoundation.lams.tool.qa.QaQueContentin constructor: QaQueContent() 14:10:20,520 [main:jboss.web.deployment:war=lams-learning.war,id=-1378480900 WebModule] DEBUG org.lamsfoundation.lams.tool.qa.QaQueContent - org.apache.log4j.Logger@131cd12 org.lamsfoundation.lams.tool.qa.QaQueContent$$EnhancerByCGLIB$$58f51929in constructor: QaQueContent() 14:10:20,520 [main:jboss.web.deployment:war=lams-learning.war,id=-1378480900 WebModule] DEBUG org.lamsfoundation.lams.tool.qa.QaQueContent - org.apache.log4j.Logger@131cd12 org.lamsfoundation.lams.tool.qa.QaQueContentin constructor: QaQueContent() 14:10:23,317 [main:jboss.web.deployment:war=lams-learning.war,id=-1378480900 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:23,317 [main:jboss.web.deployment:war=lams-learning.war,id=-1378480900 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:25,629 [main:jboss.web.deployment:war=lams-monitoring.war,id=-527998234 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:25,973 [main:jboss.web.deployment:war=lams-monitoring.war,id=-527998234 WebModule] DEBUG org.lamsfoundation.lams.tool.qa.QaQueContent - org.apache.log4j.Logger@131cd12 org.lamsfoundation.lams.tool.qa.QaQueContentin constructor: QaQueContent() 14:10:25,973 [main:jboss.web.deployment:war=lams-monitoring.war,id=-527998234 WebModule] DEBUG org.lamsfoundation.lams.tool.qa.QaQueContent - org.apache.log4j.Logger@131cd12 org.lamsfoundation.lams.tool.qa.QaQueContent$$EnhancerByCGLIB$$58f51929in constructor: QaQueContent() 14:10:25,973 [main:jboss.web.deployment:war=lams-monitoring.war,id=-527998234 WebModule] DEBUG org.lamsfoundation.lams.tool.qa.QaQueContent - org.apache.log4j.Logger@131cd12 org.lamsfoundation.lams.tool.qa.QaQueContentin constructor: QaQueContent() 14:10:27,129 [main:jboss.web.deployment:war=lams-monitoring.war,id=-527998234 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Initializing filter 'HibernateFilter' 14:10:27,129 [main:jboss.web.deployment:war=lams-monitoring.war,id=-527998234 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Filter 'HibernateFilter' configured successfully 14:10:27,129 [main:jboss.web.deployment:war=lams-monitoring.war,id=-527998234 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:27,129 [main:jboss.web.deployment:war=lams-monitoring.war,id=-527998234 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:29,411 [main:jboss.web.deployment:war=lams-tool-lachat11.war,id=1272540270 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:29,598 [main:jboss.web.deployment:war=lams-tool-lachat11.war,id=1272540270 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Initializing filter 'hibernateFilter' 14:10:29,598 [main:jboss.web.deployment:war=lams-tool-lachat11.war,id=1272540270 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Filter 'hibernateFilter' configured successfully 14:10:29,598 [main:jboss.web.deployment:war=lams-tool-lachat11.war,id=1272540270 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:29,598 [main:jboss.web.deployment:war=lams-tool-lachat11.war,id=1272540270 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:31,973 [main:jboss.web.deployment:war=lams-tool-lafrum11.war,id=-1632765830 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:32,333 [main:jboss.web.deployment:war=lams-tool-lafrum11.war,id=-1632765830 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:32,333 [main:jboss.web.deployment:war=lams-tool-lafrum11.war,id=-1632765830 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:35,192 [main:jboss.web.deployment:war=lams-tool-lamc11.war,id=-1576227732 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:35,379 [main:jboss.web.deployment:war=lams-tool-lamc11.war,id=-1576227732 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Initializing filter 'hibernateFilter' 14:10:35,379 [main:jboss.web.deployment:war=lams-tool-lamc11.war,id=-1576227732 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Filter 'hibernateFilter' configured successfully 14:10:35,379 [main:jboss.web.deployment:war=lams-tool-lamc11.war,id=-1576227732 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:35,379 [main:jboss.web.deployment:war=lams-tool-lamc11.war,id=-1576227732 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:37,395 [main:jboss.web.deployment:war=lams-tool-lanb11.war,id=-720921078 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:37,583 [main:jboss.web.deployment:war=lams-tool-lanb11.war,id=-720921078 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Initializing filter 'hibernateFilter' 14:10:37,583 [main:jboss.web.deployment:war=lams-tool-lanb11.war,id=-720921078 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Filter 'hibernateFilter' configured successfully 14:10:37,583 [main:jboss.web.deployment:war=lams-tool-lanb11.war,id=-720921078 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:37,583 [main:jboss.web.deployment:war=lams-tool-lanb11.war,id=-720921078 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:39,692 [main:jboss.web.deployment:war=lams-tool-lantbk11.war,id=1241486437 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:39,801 [main:jboss.web.deployment:war=lams-tool-lantbk11.war,id=1241486437 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Initializing filter 'hibernateFilter' 14:10:39,801 [main:jboss.web.deployment:war=lams-tool-lantbk11.war,id=1241486437 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Filter 'hibernateFilter' configured successfully 14:10:39,801 [main:jboss.web.deployment:war=lams-tool-lantbk11.war,id=1241486437 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:39,801 [main:jboss.web.deployment:war=lams-tool-lantbk11.war,id=1241486437 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:41,973 [main:jboss.web.deployment:war=lams-tool-laqa11.war,id=-674961050 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:42,083 [main:jboss.web.deployment:war=lams-tool-laqa11.war,id=-674961050 WebModule] DEBUG org.lamsfoundation.lams.tool.qa.QaQueContent - org.apache.log4j.Logger@131cd12 org.lamsfoundation.lams.tool.qa.QaQueContentin constructor: QaQueContent() 14:10:42,083 [main:jboss.web.deployment:war=lams-tool-laqa11.war,id=-674961050 WebModule] DEBUG org.lamsfoundation.lams.tool.qa.QaQueContent - org.apache.log4j.Logger@131cd12 org.lamsfoundation.lams.tool.qa.QaQueContent$$EnhancerByCGLIB$$58f51929in constructor: QaQueContent() 14:10:42,083 [main:jboss.web.deployment:war=lams-tool-laqa11.war,id=-674961050 WebModule] DEBUG org.lamsfoundation.lams.tool.qa.QaQueContent - org.apache.log4j.Logger@131cd12 org.lamsfoundation.lams.tool.qa.QaQueContentin constructor: QaQueContent() 14:10:42,130 [main:jboss.web.deployment:war=lams-tool-laqa11.war,id=-674961050 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Initializing filter 'hibernateFilter' 14:10:42,130 [main:jboss.web.deployment:war=lams-tool-laqa11.war,id=-674961050 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Filter 'hibernateFilter' configured successfully 14:10:42,130 [main:jboss.web.deployment:war=lams-tool-laqa11.war,id=-674961050 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:42,130 [main:jboss.web.deployment:war=lams-tool-laqa11.war,id=-674961050 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:46,567 [main:jboss.web.deployment:war=lams-tool-larsrc11.war,id=1572986312 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:46,864 [main:jboss.web.deployment:war=lams-tool-larsrc11.war,id=1572986312 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:46,864 [main:jboss.web.deployment:war=lams-tool-larsrc11.war,id=1572986312 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:48,708 [main:jboss.web.deployment:war=lams-tool-lasbmt11.war,id=-177996084 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:48,974 [main:jboss.web.deployment:war=lams-tool-lasbmt11.war,id=-177996084 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:48,974 [main:jboss.web.deployment:war=lams-tool-lasbmt11.war,id=-177996084 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:51,208 [main:jboss.web.deployment:war=lams-tool-lascrb11.war,id=-656530538 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:51,396 [main:jboss.web.deployment:war=lams-tool-lascrb11.war,id=-656530538 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Initializing filter 'hibernateFilter' 14:10:51,396 [main:jboss.web.deployment:war=lams-tool-lascrb11.war,id=-656530538 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Filter 'hibernateFilter' configured successfully 14:10:51,396 [main:jboss.web.deployment:war=lams-tool-lascrb11.war,id=-656530538 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:51,396 [main:jboss.web.deployment:war=lams-tool-lascrb11.war,id=-656530538 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:53,130 [main:jboss.web.deployment:war=lams-tool-lasurv11.war,id=1739231932 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:53,489 [main:jboss.web.deployment:war=lams-tool-lasurv11.war,id=1739231932 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:53,489 [main:jboss.web.deployment:war=lams-tool-lasurv11.war,id=1739231932 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:55,427 [main:jboss.web.deployment:war=lams-tool-lavote11.war,id=392476288 WebModule] INFO org.lamsfoundation.lams.contentrepository.service.SimpleRepository - Repository singleton being created. 14:10:55,630 [main:jboss.web.deployment:war=lams-tool-lavote11.war,id=392476288 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Initializing filter 'hibernateFilter' 14:10:55,630 [main:jboss.web.deployment:war=lams-tool-lavote11.war,id=392476288 WebModule] INFO org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Filter 'hibernateFilter' configured successfully 14:10:55,630 [main:jboss.web.deployment:war=lams-tool-lavote11.war,id=392476288 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:55,630 [main:jboss.web.deployment:war=lams-tool-lavote11.war,id=392476288 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:55,942 [main:jboss.web.deployment:war=lams-www.war,id=-666786398 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Initializing filter 'LocaleFilter' 14:10:55,942 [main:jboss.web.deployment:war=lams-www.war,id=-666786398 WebModule] INFO org.lamsfoundation.lams.web.filter.LocaleFilter - Filter 'LocaleFilter' configured successfully 14:10:56,489 [http-0.0.0.0-8080-1:] DEBUG org.lamsfoundation.lams.integration.security.SingleSignOn - Process request for '/lams//services/xml/LearningDesignRepository' 14:10:56,505 [http-0.0.0.0-8080-1:] DEBUG org.lamsfoundation.lams.integration.security.SingleSignOn - Checking for SSO cookie 14:10:56,505 [http-0.0.0.0-8080-1:] DEBUG org.lamsfoundation.lams.integration.security.SingleSignOn - SSO cookie is not present 14:10:56,521 [http-0.0.0.0-8080-1:] DEBUG org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Using SessionFactory 'coreSessionFactory' for OpenSessionInViewFilter 14:10:56,521 [http-0.0.0.0-8080-1:] DEBUG org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Opening single Hibernate Session in OpenSessionInViewFilter 14:10:57,083 [http-0.0.0.0-8080-1:] DEBUG org.lamsfoundation.lams.integration.service.IntegrationService - http://localhost/sakai-lamstwo-tool/servlet/UserDataServlet?username=65589020-3192-4e98-80e2-aadb6ecbf203&tamp=1182588057083&hash=58df7765836e9f3e4408fc098912e03f0a794eaf 14:10:57,130 [http-0.0.0.0-8080-1:] DEBUG org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Closing single Hibernate Session in OpenSessionInViewFilter 14:10:57,161 [http-0.0.0.0-8080-2:] DEBUG org.lamsfoundation.lams.integration.security.SingleSignOn - Process request for '/lams//services/xml/LearningDesignRepository' 14:10:57,161 [http-0.0.0.0-8080-2:] DEBUG org.lamsfoundation.lams.integration.security.SingleSignOn - Checking for SSO cookie 14:10:57,161 [http-0.0.0.0-8080-2:] DEBUG org.lamsfoundation.lams.integration.security.SingleSignOn - SSO cookie is not present 14:10:57,161 [http-0.0.0.0-8080-2:] DEBUG org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Using SessionFactory 'coreSessionFactory' for OpenSessionInViewFilter 14:10:57,161 [http-0.0.0.0-8080-2:] DEBUG org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Opening single Hibernate Session in OpenSessionInViewFilter 14:10:57,177 [http-0.0.0.0-8080-2:] DEBUG org.lamsfoundation.lams.integration.service.IntegrationService - http://localhost/sakai-lamstwo-tool/servlet/UserDataServlet?username=65589020-3192-4e98-80e2-aadb6ecbf203&tamp=1182588057177&hash=79a9f09952005a188be3ab1997f1c89f6db80447 14:10:57,177 [http-0.0.0.0-8080-2:] DEBUG org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Closing single Hibernate Session in OpenSessionInViewFilter 14:11:36,631 [http-0.0.0.0-8080-3:] DEBUG org.lamsfoundation.lams.integration.security.SingleSignOn - Process request for '/lams//LoginRequest' 14:11:36,631 [http-0.0.0.0-8080-3:] DEBUG org.lamsfoundation.lams.integration.security.SingleSignOn - Checking for SSO cookie 14:11:36,631 [http-0.0.0.0-8080-3:] DEBUG org.lamsfoundation.lams.integration.security.SingleSignOn - SSO cookie is not present 14:11:36,647 [http-0.0.0.0-8080-3:] DEBUG org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Using SessionFactory 'coreSessionFactory' for OpenSessionInViewFilter 14:11:36,647 [http-0.0.0.0-8080-3:] DEBUG org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Opening single Hibernate Session in OpenSessionInViewFilter 14:11:36,694 [http-0.0.0.0-8080-3:] DEBUG org.lamsfoundation.lams.integration.service.IntegrationService - http://localhost/sakai-lamstwo-tool/servlet/UserDataServlet?username=65589020-3192-4e98-80e2-aadb6ecbf203&tamp=1182588096694&hash=9d1f11de1f25d1bb1d544e7f9e65b0c0af54277b 14:11:36,694 [http-0.0.0.0-8080-3:] DEBUG org.lamsfoundation.lams.util.CustomizedOpenSessionInViewFilter - Closing single Hibernate Session in OpenSessionInViewFilter 14:11:36,694 [http-0.0.0.0-8080-3:] INFO org.lamsfoundation.lams.integration.security.LoginRequestValve - There are 2 headers in the response 14:11:36,694 [http-0.0.0.0-8080-3:] INFO org.lamsfoundation.lams.integration.security.LoginRequestValve - X-Powered-By = Servlet 2.4; JBoss-4.0.2 (build: CVSTag=JBoss_4_0_2 date=200505022023)/Tomcat-5.5 14:11:36,694 [http-0.0.0.0-8080-3:] INFO org.lamsfoundation.lams.integration.security.LoginRequestValve - Set-Cookie = JSESSIONID=47fb73d2-88e9-44ff-0039-5337141b2a37.localhost; Path=/ 14:11:36,694 [http-0.0.0.0-8080-3:] INFO org.lamsfoundation.lams.integration.security.LoginRequestValve - LOGIN REQUEST DETECTED - BUT NO LOGIN IS CARRIED OUT