0 Replies Latest reply on Jun 29, 2009 3:54 PM by arpan sharma

    error with jbpm-console using Jboss 4.2.2.GA

    arpan sharma Newbie


      Hi,

      I am using JBpm-3.3.1.GA with JBoss-4.2.2.GA. However, when I start Jboss and try to login as a user, I get login failed.Invalid username or password error..Below is the log file..

      2009-06-29 14:15:03,251 DEBUG [org.hibernate.hql.ast.ErrorCounter] throwQueryException() : no errors
      2009-06-29 14:15:03,252 DEBUG [org.hibernate.hql.ast.ErrorCounter] throwQueryException() : no errors
      2009-06-29 14:15:03,253 DEBUG [org.hibernate.impl.SessionFactoryImpl] Checking 0 named SQL queries
      2009-06-29 14:15:03,264 DEBUG [org.jbpm.persistence.jta.JtaDbPersistenceService] begin user transaction
      2009-06-29 14:15:03,276 DEBUG [org.jbpm.persistence.db.DbPersistenceService] using current hibernate session
      2009-06-29 14:15:03,469 DEBUG [org.hibernate.jdbc.JDBCContext] successfully registered Synchronization
      2009-06-29 14:15:03,469 DEBUG [org.hibernate.impl.SessionImpl] opened session at timestamp: 5104841946595328
      2009-06-29 14:15:03,519 DEBUG [org.jbpm.JbpmContext] closing jbpmContext org.jbpm.JbpmContext@110769b
      2009-06-29 14:15:03,519 DEBUG [org.jbpm.svc.Services] closing service 'persistence': org.jbpm.persistence.jta.JtaDbPersistenceService@157f3a4
      2009-06-29 14:15:03,522 DEBUG [org.jbpm.persistence.jta.JtaDbPersistenceService] committing user transaction
      2009-06-29 14:15:03,532 DEBUG [org.jbpm.svc.Services] closing service 'tx': org.jbpm.tx.TxService@c4f498
      2009-06-29 14:15:03,534 DEBUG [org.jboss.web.tomcat.filters.ReplyHeaderFilter] Adding header name: X-Powered-By='Servlet 2.4; JBoss-4.2.2.GA (build: SVNTag=JBoss_4_2_2_GA date=200710221139)/Tomcat-5.5'
      2009-06-29 14:15:03,569 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Initialized: {WebApplication: /C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/jsf-console.war/, URL: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/jsf-console.war/, classLoader: java.net.FactoryURLClassLoader@f2ff9b:15925147} jboss.web:j2eeType=WebModule,name=//localhost/jbpm-console,J2EEApplication=none,J2EEServer=none
      2009-06-29 14:15:03,570 DEBUG [org.jboss.web.WebModule] Started jboss.web.deployment:war=jsf-console.war,id=110889708
      2009-06-29 14:15:03,570 DEBUG [org.jboss.system.ServiceController] Starting dependent components for: jboss.web.deployment:war=jsf-console.war,id=110889708 dependent components: []
      2009-06-29 14:15:03,602 DEBUG [org.jboss.deployment.MainDeployer] End deployment start on package: jsf-console.war
      2009-06-29 14:15:03,602 DEBUG [org.jboss.deployment.MainDeployer] Deployed package: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/jsf-console.war/
      2009-06-29 14:15:03,603 DEBUG [org.jboss.deployment.scanner.URLDeploymentScanner] Watch URL for: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/jsf-console.war/ -> file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/jsf-console.war/WEB-INF/web.xml
      2009-06-29 14:15:03,604 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment of package: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/report-server.war
      2009-06-29 14:15:03,605 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment (init step) of package at: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/report-server.war
      2009-06-29 14:15:03,607 DEBUG [org.jboss.deployment.MainDeployer] Copying file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/report-server.war -> C:\Users\sparkle\Documents\Downloads\jboss-4.2.2.GA\server\default\tmp\deploy\tmp5422report-server.war
      2009-06-29 14:15:06,622 DEBUG [org.jboss.deployment.MainDeployer] using deployer MBeanProxyExt[jboss.web:service=WebServer]
      2009-06-29 14:15:06,623 DEBUG [org.jboss.web.tomcat.service.JBossWeb] Begin init
      2009-06-29 14:15:06,724 DEBUG [org.jboss.web.tomcat.service.JBossWeb] Unpacking war to: C:\Users\sparkle\Documents\Downloads\jboss-4.2.2.GA\server\default\tmp\deploy\tmp5422report-server-exp.war
      2009-06-29 14:15:09,278 DEBUG [org.jboss.web.tomcat.service.JBossWeb] Replaced war with unpacked contents
      2009-06-29 14:15:09,279 DEBUG [org.jboss.web.tomcat.service.JBossWeb] Was unable to delete war file
      2009-06-29 14:15:09,279 DEBUG [org.jboss.web.tomcat.service.JBossWeb] webContext: null
      2009-06-29 14:15:09,280 DEBUG [org.jboss.web.tomcat.service.JBossWeb] warURL: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/tmp/deploy/tmp5422report-server-exp.war/
      2009-06-29 14:15:09,324 DEBUG [org.jboss.web.tomcat.service.JBossWeb] End init
      2009-06-29 14:15:09,324 DEBUG [org.jboss.deployment.DeploymentInfo] createLoaderRepository from config: LoaderRepositoryConfig(repositoryName: JMImplementation:service=LoaderRepository,name=Default, repositoryClassName: null, configParserClassName: null, repositoryConfig: null)
      2009-06-29 14:15:09,325 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] setRepository, repository=org.jboss.mx.loading.UnifiedLoaderRepository3@198a455, cl=org.jboss.mx.loading.UnifiedClassLoader3@1754daa{ url=file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/tmp/deploy/tmp5422report-server-exp.war/ ,addedOrder=0}
      2009-06-29 14:15:09,325 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] setRepository, repository=org.jboss.mx.loading.UnifiedLoaderRepository3@198a455, cl=org.jboss.mx.loading.UnifiedClassLoader3@1754daa{ url=file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/tmp/deploy/tmp5422report-server-exp.war/ ,addedOrder=0}
      2009-06-29 14:15:09,325 DEBUG [org.jboss.mx.loading.UnifiedLoaderRepository3] Adding org.jboss.mx.loading.UnifiedClassLoader3@1754daa{ url=file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/tmp/deploy/tmp5422report-server-exp.war/ ,addedOrder=0}
      2009-06-29 14:15:09,327 DEBUG [org.jboss.deployment.MainDeployer] found 0 subpackages of file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/report-server.war
      2009-06-29 14:15:09,327 DEBUG [org.jboss.deployment.MainDeployer] Watching new file: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/report-server.war
      2009-06-29 14:15:09,328 DEBUG [org.jboss.deployment.MainDeployer] create step for deployment file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/report-server.war
      2009-06-29 14:15:09,328 DEBUG [org.jboss.web.tomcat.service.JBossWeb] create, report-server.war
      2009-06-29 14:15:09,333 DEBUG [org.jboss.system.ServiceController] Creating service jboss.web.deployment:war=report-server.war,id=-1949213586
      2009-06-29 14:15:09,333 DEBUG [org.jboss.system.ServiceController] adding depends in ServiceController.register: []
      2009-06-29 14:15:09,333 DEBUG [org.jboss.web.WebModule] Creating jboss.web.deployment:war=report-server.war,id=-1949213586
      2009-06-29 14:15:09,333 DEBUG [org.jboss.web.WebModule] Created jboss.web.deployment:war=report-server.war,id=-1949213586
      2009-06-29 14:15:09,333 DEBUG [org.jboss.system.ServiceController] Creating dependent components for: jboss.web.deployment:war=report-server.war,id=-1949213586 dependents are: []
      2009-06-29 14:15:09,435 DEBUG [org.jboss.deployment.MainDeployer] Done with create step of deploying report-server.war
      2009-06-29 14:15:09,436 DEBUG [org.jboss.deployment.MainDeployer] Begin deployment start file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/report-server.war
      2009-06-29 14:15:09,436 DEBUG [org.jboss.system.ServiceController] starting service jboss.web.deployment:war=report-server.war,id=-1949213586
      2009-06-29 14:15:09,436 DEBUG [org.jboss.web.WebModule] Starting jboss.web.deployment:war=report-server.war,id=-1949213586
      2009-06-29 14:15:09,437 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] webContext: null
      2009-06-29 14:15:09,437 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] warURL: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/tmp/deploy/tmp5422report-server-exp.war/
      2009-06-29 14:15:09,437 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] webAppParser: org.jboss.web.AbstractWebDeployer$DescriptorParser@170c7a3
      2009-06-29 14:15:09,437 DEBUG [org.jboss.web.WebPermissionMapping] Qualified url patterns: {/rs/*=PatternInfo[pattern=/rs/*,type=1,isOverriden=false,qualifiers=[]], /=PatternInfo[pattern=/,type=3,isOverriden=false,qualifiers=[PatternInfo[pattern=/rs/*,type=1,isOverriden=false,qualifiers=[]]]]}
      2009-06-29 14:15:09,450 INFO [org.jboss.web.tomcat.service.TomcatDeployer] deploy, ctxPath=/report-server, warUrl=.../tmp/deploy/tmp5422report-server-exp.war/
      2009-06-29 14:15:09,450 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] AbstractWebContainer.parseWebAppDescriptors, Begin
      2009-06-29 14:15:09,458 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Creating ENC using ClassLoader: java.net.FactoryURLClassLoader@142d884
      2009-06-29 14:15:09,459 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] ..org.jboss.mx.loading.UnifiedClassLoader3@1754daa{ url=file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/tmp/deploy/tmp5422report-server-exp.war/ ,addedOrder=51}
      2009-06-29 14:15:09,459 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] ..org.jboss.system.server.NoAnnotationURLClassLoader@1e4457d
      2009-06-29 14:15:09,459 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] ..sun.misc.Launcher$AppClassLoader@1ba34f2
      2009-06-29 14:15:09,459 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] ..sun.misc.Launcher$ExtClassLoader@1ea2dfe
      2009-06-29 14:15:09,460 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Unable to retrieve orbjavax.management.InstanceNotFoundException: jboss:service=CorbaORB is not registered.
      2009-06-29 14:15:09,460 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Linked java:comp/UserTransaction to JNDI name: UserTransaction
      2009-06-29 14:15:09,461 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] addEnvEntries
      2009-06-29 14:15:09,461 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkResourceEnvRefs
      2009-06-29 14:15:09,461 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkResourceRefs
      2009-06-29 14:15:09,461 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkMessageDestinationRefs
      2009-06-29 14:15:09,461 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkEjbRefs
      2009-06-29 14:15:09,461 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkEjbLocalRefs
      2009-06-29 14:15:09,461 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkServiceRefs
      2009-06-29 14:15:09,461 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkSecurityDomain
      2009-06-29 14:15:09,461 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Linking security/securityMgr to JNDI name: java:/jaas/jbpm-console
      2009-06-29 14:15:09,463 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] AbstractWebContainer.parseWebAppDescriptors, End
      2009-06-29 14:15:09,536 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Using session cookies default setting
      2009-06-29 14:15:10,281 INFO [STDOUT] FOUND JAX-RS @Provider: org.jboss.balalaika.FileWriter
      2009-06-29 14:15:10,392 ERROR [STDERR] 172 [main] INFO org.jboss.resteasy.plugins.providers - Added DataSourceProvider
      2009-06-29 14:15:10,400 ERROR [STDERR] 180 [main] INFO org.jboss.resteasy.plugins.providers - Added DefaultTextPlain
      2009-06-29 14:15:10,484 ERROR [STDERR] 265 [main] INFO org.jboss.resteasy.plugins.providers - Added JAXBXmlRootElementProvider
      2009-06-29 14:15:10,497 ERROR [STDERR] 278 [main] INFO org.jboss.resteasy.plugins.providers - Added JAXBElementProvider
      2009-06-29 14:15:10,507 ERROR [STDERR] 288 [main] INFO org.jboss.resteasy.plugins.providers - Added JAXBXmlTypeProvider
      2009-06-29 14:15:10,543 ERROR [STDERR] 324 [main] INFO org.jboss.resteasy.plugins.providers - Adding org.jboss.resteasy.plugins.providers.IIOImageProvider
      2009-06-29 14:15:10,562 ERROR [STDERR] 343 [main] INFO org.jboss.resteasy.plugins.providers - Adding org.jboss.resteasy.plugins.providers.jaxb.json.JsonJAXBElementProvider
      2009-06-29 14:15:10,581 ERROR [STDERR] 362 [main] INFO org.jboss.resteasy.plugins.providers - Adding org.jboss.resteasy.plugins.providers.jaxb.json.JsonXmlTypeProvider
      2009-06-29 14:15:10,588 ERROR [STDERR] 369 [main] INFO org.jboss.resteasy.plugins.providers - Adding org.jboss.resteasy.plugins.providers.jaxb.json.JsonXmlRootElementProvider
      2009-06-29 14:15:10,597 ERROR [STDERR] 378 [main] INFO org.jboss.resteasy.plugins.providers - Adding org.jboss.resteasy.plugins.providers.MimeMultipartProvider
      2009-06-29 14:15:10,613 ERROR [STDERR] 394 [main] INFO org.jboss.resteasy.plugins.providers - Adding org.jboss.resteasy.plugins.providers.YamlProvider
      2009-06-29 14:15:10,647 ERROR [STDERR] 427 [main] INFO org.jboss.resteasy.plugins.providers - Adding org.jboss.resteasy.plugins.providers.jaxb.fastinfoset.FastinfoSetXmlRootElementProvider
      2009-06-29 14:15:10,661 ERROR [STDERR] 441 [main] INFO org.jboss.resteasy.plugins.providers - Adding org.jboss.resteasy.plugins.providers.jaxb.fastinfoset.FastinfoSetJAXBElementProvider
      2009-06-29 14:15:10,670 ERROR [STDERR] 451 [main] INFO org.jboss.resteasy.plugins.providers - Adding org.jboss.resteasy.plugins.providers.jaxb.fastinfoset.FastinfoSetXmlTypeProvider
      2009-06-29 14:15:10,898 DEBUG [org.jboss.web.tomcat.filters.ReplyHeaderFilter] Adding header name: X-Powered-By='Servlet 2.4; JBoss-4.2.2.GA (build: SVNTag=JBoss_4_2_2_GA date=200710221139)/Tomcat-5.5'
      2009-06-29 14:15:11,098 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Initialized: {WebApplication: /C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/tmp/deploy/tmp5422report-server-exp.war/, URL: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/tmp/deploy/tmp5422report-server-exp.war/, classLoader: java.net.FactoryURLClassLoader@142d884:21158020} jboss.web:j2eeType=WebModule,name=//localhost/report-server,J2EEApplication=none,J2EEServer=none
      2009-06-29 14:15:11,098 DEBUG [org.jboss.web.WebModule] Started jboss.web.deployment:war=report-server.war,id=-1949213586
      2009-06-29 14:15:11,098 DEBUG [org.jboss.system.ServiceController] Starting dependent components for: jboss.web.deployment:war=report-server.war,id=-1949213586 dependent components: []
      2009-06-29 14:15:11,124 DEBUG [org.jboss.deployment.MainDeployer] End deployment start on package: report-server.war
      2009-06-29 14:15:11,124 DEBUG [org.jboss.deployment.MainDeployer] Deployed package: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/report-server.war
      2009-06-29 14:15:11,125 DEBUG [org.jboss.deployment.scanner.URLDeploymentScanner] Watch URL for: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/report-server.war -> file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jbpm/report-server.war
      2009-06-29 14:15:11,126 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment of package: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/
      2009-06-29 14:15:11,126 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment (init step) of package at: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/
      2009-06-29 14:15:11,127 DEBUG [org.jboss.deployment.MainDeployer] using deployer MBeanProxyExt[jboss.web:service=WebServer]
      2009-06-29 14:15:11,127 DEBUG [org.jboss.web.tomcat.service.JBossWeb] Begin init
      2009-06-29 14:15:11,163 DEBUG [org.jboss.web.tomcat.service.JBossWeb] webContext: null
      2009-06-29 14:15:11,163 DEBUG [org.jboss.web.tomcat.service.JBossWeb] warURL: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/
      2009-06-29 14:15:11,298 DEBUG [org.jboss.web.tomcat.service.JBossWeb] End init
      2009-06-29 14:15:11,298 DEBUG [org.jboss.deployment.DeploymentInfo] createLoaderRepository from config: LoaderRepositoryConfig(repositoryName: JMImplementation:service=LoaderRepository,name=Default, repositoryClassName: null, configParserClassName: null, repositoryConfig: null)
      2009-06-29 14:15:11,299 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] setRepository, repository=org.jboss.mx.loading.UnifiedLoaderRepository3@198a455, cl=org.jboss.mx.loading.UnifiedClassLoader3@4764a1{ url=file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/ ,addedOrder=0}
      2009-06-29 14:15:11,299 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] setRepository, repository=org.jboss.mx.loading.UnifiedLoaderRepository3@198a455, cl=org.jboss.mx.loading.UnifiedClassLoader3@4764a1{ url=file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/ ,addedOrder=0}
      2009-06-29 14:15:11,299 DEBUG [org.jboss.mx.loading.UnifiedLoaderRepository3] Adding org.jboss.mx.loading.UnifiedClassLoader3@4764a1{ url=file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/ ,addedOrder=0}
      2009-06-29 14:15:11,302 DEBUG [org.jboss.deployment.MainDeployer] found 0 subpackages of file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/
      2009-06-29 14:15:11,304 DEBUG [org.jboss.deployment.MainDeployer] Watching new file: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/
      2009-06-29 14:15:11,304 DEBUG [org.jboss.deployment.MainDeployer] create step for deployment file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/
      2009-06-29 14:15:11,305 DEBUG [org.jboss.web.tomcat.service.JBossWeb] create, jmx-console.war
      2009-06-29 14:15:11,309 DEBUG [org.jboss.system.ServiceController] Creating service jboss.web.deployment:war=jmx-console.war,id=-1761145912
      2009-06-29 14:15:11,309 DEBUG [org.jboss.system.ServiceController] adding depends in ServiceController.register: []
      2009-06-29 14:15:11,310 DEBUG [org.jboss.web.WebModule] Creating jboss.web.deployment:war=jmx-console.war,id=-1761145912
      2009-06-29 14:15:11,310 DEBUG [org.jboss.web.WebModule] Created jboss.web.deployment:war=jmx-console.war,id=-1761145912
      2009-06-29 14:15:11,310 DEBUG [org.jboss.system.ServiceController] Creating dependent components for: jboss.web.deployment:war=jmx-console.war,id=-1761145912 dependents are: []
      2009-06-29 14:15:11,674 DEBUG [org.jboss.deployment.MainDeployer] Done with create step of deploying jmx-console.war
      2009-06-29 14:15:11,674 DEBUG [org.jboss.deployment.MainDeployer] Begin deployment start file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/
      2009-06-29 14:15:11,674 DEBUG [org.jboss.system.ServiceController] starting service jboss.web.deployment:war=jmx-console.war,id=-1761145912
      2009-06-29 14:15:11,674 DEBUG [org.jboss.web.WebModule] Starting jboss.web.deployment:war=jmx-console.war,id=-1761145912
      2009-06-29 14:15:11,675 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] webContext: null
      2009-06-29 14:15:11,675 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] warURL: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/
      2009-06-29 14:15:11,675 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] webAppParser: org.jboss.web.AbstractWebDeployer$DescriptorParser@e7da60
      2009-06-29 14:15:11,675 DEBUG [org.jboss.web.WebPermissionMapping] Qualified url patterns: {/=PatternInfo[pattern=/,type=3,isOverriden=false,qualifiers=[]]}
      2009-06-29 14:15:11,684 INFO [org.jboss.web.tomcat.service.TomcatDeployer] deploy, ctxPath=/jmx-console, warUrl=.../deploy/jmx-console.war/
      2009-06-29 14:15:11,685 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] AbstractWebContainer.parseWebAppDescriptors, Begin
      2009-06-29 14:15:11,694 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Creating ENC using ClassLoader: java.net.FactoryURLClassLoader@1b1d931
      2009-06-29 14:15:11,695 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] ..org.jboss.mx.loading.UnifiedClassLoader3@4764a1{ url=file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/ ,addedOrder=52}
      2009-06-29 14:15:11,695 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] ..org.jboss.system.server.NoAnnotationURLClassLoader@1e4457d
      2009-06-29 14:15:11,695 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] ..sun.misc.Launcher$AppClassLoader@1ba34f2
      2009-06-29 14:15:11,695 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] ..sun.misc.Launcher$ExtClassLoader@1ea2dfe
      2009-06-29 14:15:11,696 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Unable to retrieve orbjavax.management.InstanceNotFoundException: jboss:service=CorbaORB is not registered.
      2009-06-29 14:15:11,697 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Linked java:comp/UserTransaction to JNDI name: UserTransaction
      2009-06-29 14:15:11,697 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] addEnvEntries
      2009-06-29 14:15:11,697 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkResourceEnvRefs
      2009-06-29 14:15:11,697 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkResourceRefs
      2009-06-29 14:15:11,697 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkMessageDestinationRefs
      2009-06-29 14:15:11,697 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkEjbRefs
      2009-06-29 14:15:11,697 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkEjbLocalRefs
      2009-06-29 14:15:11,697 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkServiceRefs
      2009-06-29 14:15:11,697 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] linkSecurityDomain
      2009-06-29 14:15:11,697 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] No security-domain given, using default: java:/jaas/other
      2009-06-29 14:15:11,697 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Linking security/securityMgr to JNDI name: java:/jaas/other
      2009-06-29 14:15:11,699 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] AbstractWebContainer.parseWebAppDescriptors, End
      2009-06-29 14:15:11,776 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Using session cookies default setting
      2009-06-29 14:15:11,975 DEBUG [org.jboss.web.tomcat.filters.ReplyHeaderFilter] Adding header name: X-Powered-By='Servlet 2.4; JBoss-4.2.2.GA (build: SVNTag=JBoss_4_2_2_GA date=200710221139)/Tomcat-5.5'
      2009-06-29 14:15:12,002 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Initialized: {WebApplication: /C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/, URL: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/, classLoader: java.net.FactoryURLClassLoader@1b1d931:28432689} jboss.web:j2eeType=WebModule,name=//localhost/jmx-console,J2EEApplication=none,J2EEServer=none
      2009-06-29 14:15:12,003 DEBUG [org.jboss.web.WebModule] Started jboss.web.deployment:war=jmx-console.war,id=-1761145912
      2009-06-29 14:15:12,003 DEBUG [org.jboss.system.ServiceController] Starting dependent components for: jboss.web.deployment:war=jmx-console.war,id=-1761145912 dependent components: []
      2009-06-29 14:15:12,100 DEBUG [org.jboss.deployment.MainDeployer] End deployment start on package: jmx-console.war
      2009-06-29 14:15:12,100 DEBUG [org.jboss.deployment.MainDeployer] Deployed package: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/
      2009-06-29 14:15:12,100 DEBUG [org.jboss.deployment.scanner.URLDeploymentScanner] Watch URL for: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/ -> file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/deploy/jmx-console.war/WEB-INF/web.xml
      2009-06-29 14:15:12,103 ERROR [org.jboss.deployment.scanner.URLDeploymentScanner] Incomplete Deployment listing:

      --- MBeans waiting for other MBeans ---
      ObjectName: jboss.j2ee:service=EjbModule,module=jbpm-enterprise.jar
      State: FAILED
      Reason: org.jboss.deployment.DeploymentException: Error while fixing table name; - nested throwable: (org.jboss.util.NestedSQLException: Unexpected throwable while trying to create a connection: null; - nested throwable: (java.lang.reflect.UndeclaredThrowableException); - nested throwable: (org.jboss.resource.JBossResourceException: Unexpected throwable while trying to create a connection: null; - nested throwable: (java.lang.reflect.UndeclaredThrowableException)))

      --- MBEANS THAT ARE THE ROOT CAUSE OF THE PROBLEM ---
      ObjectName: jboss.j2ee:service=EjbModule,module=jbpm-enterprise.jar
      State: FAILED
      Reason: org.jboss.deployment.DeploymentException: Error while fixing table name; - nested throwable: (org.jboss.util.NestedSQLException: Unexpected throwable while trying to create a connection: null; - nested throwable: (java.lang.reflect.UndeclaredThrowableException); - nested throwable: (org.jboss.resource.JBossResourceException: Unexpected throwable while trying to create a connection: null; - nested throwable: (java.lang.reflect.UndeclaredThrowableException)))


      2009-06-29 14:15:12,105 DEBUG [org.jboss.deployment.scanner.AbstractDeploymentScanner$ScannerThread] Notified that enabled: true
      2009-06-29 14:15:12,118 DEBUG [org.jboss.deployment.scanner.URLDeploymentScanner] Started jboss.deployment:type=DeploymentScanner,flavor=URL
      2009-06-29 14:15:12,118 DEBUG [org.jboss.system.ServiceController] Starting dependent components for: jboss.deployment:type=DeploymentScanner,flavor=URL dependent components: []
      2009-06-29 14:15:12,407 DEBUG [org.jboss.deployment.MainDeployer] End deployment start on package: jboss-service.xml
      2009-06-29 14:15:12,408 DEBUG [org.jboss.deployment.MainDeployer] Deployed package: file:/C:/Users/sparkle/Documents/Downloads/jboss-4.2.2.GA/server/default/conf/jboss-service.xml
      2009-06-29 14:15:12,412 DEBUG [org.jboss.web.tomcat.service.JBossWeb] Saw org.jboss.system.server.started notification, starting connectors
      2009-06-29 14:15:12,451 INFO [org.apache.coyote.http11.Http11Protocol] Starting Coyote HTTP/1.1 on http-127.0.0.1-8080
      2009-06-29 14:15:14,796 INFO [org.apache.coyote.ajp.AjpProtocol] Starting Coyote AJP/1.3 on ajp-127.0.0.1-8009
      2009-06-29 14:15:14,894 INFO [org.jboss.system.server.Server] JBoss (MX MicroKernel) [4.2.2.GA (build: SVNTag=JBoss_4_2_2_GA date=200710221139)] Started in 5m:37s:828ms
      2009-06-29 14:15:14,908 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:15:14>
      2009-06-29 14:15:14,917 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:15:14,918 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:15:14,920 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:15:24,932 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:15:24>
      2009-06-29 14:15:24,932 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:15:24,932 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:15:24,933 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:17:24,934 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:17:24>
      2009-06-29 14:17:24,934 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:17:24,935 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:17:24,936 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:17:34,938 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:17:34>
      2009-06-29 14:17:34,938 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:17:34,938 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:17:34,938 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:19:34,938 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:19:34>
      2009-06-29 14:19:34,938 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:19:34,939 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:19:34,940 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:19:44,940 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:19:44>
      2009-06-29 14:19:44,940 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:19:44,940 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:19:44,940 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:21:26,667 DEBUG [org.jboss.resource.connectionmanager.IdleRemover] run: IdleRemover notifying pools, interval: 450000
      2009-06-29 14:21:44,940 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:21:44>
      2009-06-29 14:21:44,940 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:21:44,941 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:21:44,942 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:21:54,942 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:21:54>
      2009-06-29 14:21:54,942 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:21:54,942 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:21:54,942 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:23:54,942 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:23:54>
      2009-06-29 14:23:54,942 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:23:54,943 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:23:54,944 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:24:04,965 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:24:04>
      2009-06-29 14:24:04,966 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:24:04,966 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:24:04,966 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:26:04,966 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:26:04>
      2009-06-29 14:26:04,966 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:26:04,967 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:26:04,968 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:26:14,968 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:26:14>
      2009-06-29 14:26:14,968 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:26:14,968 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:26:14,968 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:28:14,968 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:28:14>
      2009-06-29 14:28:14,968 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:28:14,969 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:28:14,970 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:28:24,970 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:28:24>
      2009-06-29 14:28:24,970 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:28:24,970 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:28:24,971 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:28:56,673 DEBUG [org.jboss.resource.connectionmanager.IdleRemover] run: IdleRemover notifying pools, interval: 450000
      2009-06-29 14:30:24,971 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:30:24>
      2009-06-29 14:30:24,971 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:30:24,972 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:30:24,973 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:30:34,973 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:30:34>
      2009-06-29 14:30:34,973 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:30:34,973 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:30:34,973 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:32:34,973 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:32:34>
      2009-06-29 14:32:34,973 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:32:34,974 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:32:34,975 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:32:44,976 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:32:44>
      2009-06-29 14:32:44,976 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:32:44,977 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:32:44,977 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:34:44,980 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:34:44>
      2009-06-29 14:34:44,980 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:34:44,980 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:34:44,982 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:34:54,983 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:34:54>
      2009-06-29 14:34:54,983 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:34:54,983 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:34:54,983 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:36:26,674 DEBUG [org.jboss.resource.connectionmanager.IdleRemover] run: IdleRemover notifying pools, interval: 450000
      2009-06-29 14:36:54,983 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:36:54>
      2009-06-29 14:36:54,983 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:36:54,984 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:36:54,986 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:37:04,986 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:37:04>
      2009-06-29 14:37:04,986 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:37:04,986 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:37:04,986 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:39:04,986 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:39:04>
      2009-06-29 14:39:04,986 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:39:04,987 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:39:04,988 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:39:14,989 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:39:14>
      2009-06-29 14:39:14,989 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:39:14,989 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:39:14,989 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:41:14,990 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:41:14>
      2009-06-29 14:41:14,990 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:41:14,991 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:41:14,992 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:41:24,992 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:41:24>
      2009-06-29 14:41:24,992 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:41:24,992 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:41:24,992 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:43:24,993 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:43:24>
      2009-06-29 14:43:24,993 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:43:24,994 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:43:24,995 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:43:34,996 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:43:34>
      2009-06-29 14:43:34,996 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:43:34,996 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:43:34,996 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:43:56,674 DEBUG [org.jboss.resource.connectionmanager.IdleRemover] run: IdleRemover notifying pools, interval: 450000
      2009-06-29 14:45:34,996 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:45:34>
      2009-06-29 14:45:34,996 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:45:34,997 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:45:34,999 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:45:44,999 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:45:44>
      2009-06-29 14:45:44,999 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:45:44,999 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:45:44,999 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:47:45,006 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:47:45>
      2009-06-29 14:47:45,006 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:47:45,007 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:47:45,008 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:47:55,008 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:47:55>
      2009-06-29 14:47:55,010 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:47:55,011 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:47:55,011 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:49:55,011 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:49:55>
      2009-06-29 14:49:55,011 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:49:55,012 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:49:55,013 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:50:05,013 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:50:05>
      2009-06-29 14:50:05,013 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:50:05,013 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:50:05,013 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:51:26,674 DEBUG [org.jboss.resource.connectionmanager.IdleRemover] run: IdleRemover notifying pools, interval: 450000
      2009-06-29 14:52:05,013 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:52:05>
      2009-06-29 14:52:05,013 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:52:05,014 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:52:05,016 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:52:15,016 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:52:15>
      2009-06-29 14:52:15,016 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:52:15,016 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:52:15,016 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:54:15,016 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:54:15>
      2009-06-29 14:54:15,016 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:54:15,017 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:54:15,018 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:54:25,019 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:54:25>
      2009-06-29 14:54:25,019 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:54:25,019 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:54:25,019 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:56:25,019 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:56:25>
      2009-06-29 14:56:25,019 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:56:25,020 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:56:25,046 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:56:35,046 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:56:35>
      2009-06-29 14:56:35,046 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:56:35,046 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:56:35,046 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:58:35,047 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 14:58:35>
      2009-06-29 14:58:35,047 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 14:58:35,048 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 14:58:35,049 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 14:58:45,049 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 14:58:45>
      2009-06-29 14:58:45,049 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 14:58:45,049 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 14:58:45,049 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 14:58:56,674 DEBUG [org.jboss.resource.connectionmanager.IdleRemover] run: IdleRemover notifying pools, interval: 450000
      2009-06-29 15:00:45,049 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:00:45>
      2009-06-29 15:00:45,049 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:00:45,050 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 15:00:45,051 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 15:00:55,051 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 15:00:55>
      2009-06-29 15:00:55,051 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 15:00:55,051 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 15:00:55,051 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 15:02:55,051 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:02:55>
      2009-06-29 15:02:55,051 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:02:55,052 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 15:02:55,053 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 15:03:05,053 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 15:03:05>
      2009-06-29 15:03:05,053 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 15:03:05,053 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 15:03:05,053 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 15:05:05,053 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:05:05>
      2009-06-29 15:05:05,053 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:05:05,054 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 15:05:05,055 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 15:05:15,055 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 15:05:15>
      2009-06-29 15:05:15,055 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 15:05:15,055 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 15:05:15,055 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 15:06:26,675 DEBUG [org.jboss.resource.connectionmanager.IdleRemover] run: IdleRemover notifying pools, interval: 450000
      2009-06-29 15:07:15,055 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:07:15>
      2009-06-29 15:07:15,055 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:07:15,056 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 15:07:15,056 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 15:07:25,057 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 15:07:25>
      2009-06-29 15:07:25,057 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 15:07:25,057 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 15:07:25,057 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 15:09:25,057 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:09:25>
      2009-06-29 15:09:25,057 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:09:25,058 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 15:09:25,059 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 15:09:35,060 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 15:09:35>
      2009-06-29 15:09:35,060 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 15:09:35,060 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 15:09:35,061 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 15:11:35,061 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:11:35>
      2009-06-29 15:11:35,061 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:11:35,062 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 15:11:35,063 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 15:11:45,063 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 15:11:45>
      2009-06-29 15:11:45,063 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 15:11:45,063 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 15:11:45,063 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 15:13:45,589 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:13:45>
      2009-06-29 15:13:45,589 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:13:45,590 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 15:13:45,590 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 15:13:55,591 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 15:13:55>
      2009-06-29 15:13:55,591 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 15:13:55,591 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 15:13:55,591 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 15:13:56,675 DEBUG [org.jboss.resource.connectionmanager.IdleRemover] run: IdleRemover notifying pools, interval: 450000
      2009-06-29 15:15:55,591 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:15:55>
      2009-06-29 15:15:55,591 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:15:55,592 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 15:15:55,593 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 15:16:05,593 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 15:16:05>
      2009-06-29 15:16:05,593 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 15:16:05,593 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 15:16:05,593 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 15:18:05,593 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:18:05>
      2009-06-29 15:18:05,593 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:18:05,594 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 15:18:05,595 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 15:18:15,595 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 15:18:15>
      2009-06-29 15:18:15,595 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 15:18:15,595 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 15:18:15,595 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 15:20:15,595 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:20:15>
      2009-06-29 15:20:15,595 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:20:15,596 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 15:20:15,597 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 15:20:25,598 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 15:20:25>
      2009-06-29 15:20:25,598 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 15:20:25,598 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 15:20:25,598 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 15:21:26,675 DEBUG [org.jboss.resource.connectionmanager.IdleRemover] run: IdleRemover notifying pools, interval: 450000
      2009-06-29 15:22:25,598 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:22:25>
      2009-06-29 15:22:25,598 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:22:25,599 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 15:22:25,600 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 15:22:35,600 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 15:22:35>
      2009-06-29 15:22:35,600 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 15:22:35,600 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 15:22:35,600 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 15:24:35,601 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:24:35>
      2009-06-29 15:24:35,601 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:24:35,602 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
      2009-06-29 15:24:35,603 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
      2009-06-29 15:24:45,613 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - second pass <Mon, 29 Jun 2009 15:24:45>
      2009-06-29 15:24:45,614 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] AtomicActionRecoveryModule: Second pass
      2009-06-29 15:24:45,614 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_6] - TORecoveryModule - second pass
      2009-06-29 15:24:45,614 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.recovery.info.secondpass] Local XARecoveryModule - second pass
      2009-06-29 15:26:45,614 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] Periodic recovery - first pass <Mon, 29 Jun 2009 15:26:45>
      2009-06-29 15:26:45,614 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] StatusModule: first pass
      2009-06-29 15:26:45,615 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] [com.arjuna.ats.internal.txoj.recovery.TORecove