0 Replies Latest reply on Jan 27, 2006 11:07 AM by Yann Schluchter

    Table JBPM_TIMER deleted when starting jBoss server

    Yann Schluchter Newbie

      Hi,

      I have the following configuration:

      jdk1.5.0_06
      jboss-4.0.3SP1
      apache-ant-1.6.5
      jbpm-3.0.2

      When I try to do the following, the JBPM_TIMER table is deleted from the database.

      1) ant create.jbpm.configuration
      2) ant db.start
      3) With DBVisualizer, I can connect to the database and see that I have a lot of JBPM_xyz tables in the PUBLIC database. Normal!
      4) ant db.stop
      5) ant start.jboss

      Here the stack trace tells me "Table not found in statement [select timer0_.ID_ as col_0_0_ from JBPM_TIMER..." (see complete log at the end of this message)

      If I open DBVisualizer again, I can see taht all the JBPM tables have been deleted from the PUBLIC database.

      The only remaining tables are:

      JMS_MESSAGES
      JMS_ROLES
      JMS_SUBSCRIPTIONS
      JMS_TRANSACTIONS
      JMS_USERS
      TIMERS

      Could anybody please help me to solve this issue? It is quite urgent...

      Thanks in advance!
      Yann

      Here is the log:

      Buildfile: C:\Java\jbpm-3.0.2\build.deploy.xml
      declare.jbpm.tasks:
      compile.jbpm:
      build.jbpm:
      build.jbpm.src:
      compile.identity:
      build.identity:
      build.identity.src:
      compile.jbpm.test:
      compile.webapp:
      compile.identity.test:
      compile.examples:
      compile:
      build.webapp:
      build.service.archive:
      build.converter:
      build:
      start.jboss:
      [startjboss] starting 'C:/Java/jboss-4.0.3SP1\bin\run.bat -c jbpm'...
      [startjboss] ===============================================================================
      [startjboss] .
      [startjboss] JBoss Bootstrap Environment
      [startjboss] .
      [startjboss] JBOSS_HOME: C:\Java\jboss-4.0.3SP1\bin\\..
      [startjboss] .
      [startjboss] JAVA: C:\Java\jdk1.5.0_06\bin\java
      [startjboss] .
      [startjboss] JAVA_OPTS: -Dprogram.name=run.bat -Xms128m -Xmx512m
      [startjboss] .
      [startjboss] CLASSPATH: C:\Java\jdk1.5.0_06\lib\tools.jar;C:\Java\jboss-4.0.3SP1\bin\\run.jar
      [startjboss] .
      [startjboss] ===============================================================================
      [startjboss] .
      [startjboss] 16:49:44,484 INFO [Server] Starting JBoss (MX MicroKernel)...
      [startjboss] 16:49:44,484 INFO [Server] Release ID: JBoss [Zion] 4.0.3SP1 (build: CVSTag=JBoss_4_0_3_SP1 date=200510231054)
      [startjboss] 16:49:44,484 INFO [Server] Home Dir: C:\Java\jboss-4.0.3SP1
      [startjboss] 16:49:44,484 INFO [Server] Home URL: file:/C:/Java/jboss-4.0.3SP1/
      [startjboss] 16:49:44,500 INFO [Server] Patch URL: null
      [startjboss] 16:49:44,500 INFO [Server] Server Name: jbpm
      [startjboss] 16:49:44,500 INFO [Server] Server Home Dir: C:\Java\jboss-4.0.3SP1\server\jbpm
      [startjboss] 16:49:44,500 INFO [Server] Server Home URL: file:/C:/Java/jboss-4.0.3SP1/server/jbpm/
      [startjboss] 16:49:44,500 INFO [Server] Server Temp Dir: C:\Java\jboss-4.0.3SP1\server\jbpm\tmp
      [startjboss] 16:49:44,500 INFO [Server] Root Deployment Filename: jboss-service.xml
      [startjboss] 16:49:44,765 INFO [ServerInfo] Java version: 1.5.0_06,Sun Microsystems Inc.
      [startjboss] 16:49:44,765 INFO [ServerInfo] Java VM: Java HotSpot(TM) Client VM 1.5.0_06-b05,Sun Microsystems Inc.
      [startjboss] 16:49:44,765 INFO [ServerInfo] OS-System: Windows XP 5.1,x86
      [startjboss] 16:49:45,078 INFO [Server] Core system initialized
      [startjboss] 16:49:46,484 INFO [WebService] Using RMI server codebase: http://GVA-YSCHLUCHTER:8083/
      [startjboss] 16:49:46,500 INFO [Log4jService$URLWatchTimerTask] Configuring from URL: resource:log4j.xml
      [startjboss] 16:49:46,703 INFO [NamingService] Started jndi bootstrap jnpPort=1099, rmiPort=1098, backlog=50, bindAddress=/0.0.0.0, Client SocketFactory=null, Server SocketFactory=org.jboss.net.sockets.DefaultSocketFactory@ad093076
      [startjboss] 16:49:48,406 INFO [Embedded] Catalina naming disabled
      [startjboss] 16:49:48,687 INFO [Http11Protocol] Initializing Coyote HTTP/1.1 on http-0.0.0.0-8080
      [startjboss] 16:49:48,703 INFO [Catalina] Initialization processed in 250 ms
      [startjboss] 16:49:48,703 INFO [StandardService] Starting service jboss.web
      [startjboss] 16:49:48,703 INFO [StandardEngine] Starting Servlet Engine: Apache Tomcat/5.5
      [startjboss] 16:49:48,750 INFO [StandardHost] XML validation disabled
      [startjboss] 16:49:48,765 INFO [Catalina] Server startup in 62 ms
      [startjboss] 16:49:48,906 INFO [TomcatDeployer] deploy, ctxPath=/invoker, warUrl=.../deploy/http-invoker.sar/invoker.war/
      [startjboss] 16:49:49,171 INFO [WebappLoader] Dual registration of jndi stream handler: factory already defined
      [startjboss] 16:49:49,625 INFO [TomcatDeployer] deploy, ctxPath=/, warUrl=.../deploy/jbossweb-tomcat55.sar/ROOT.war/
      [startjboss] 16:49:50,031 INFO [TomcatDeployer] deploy, ctxPath=/jbossmq-httpil, warUrl=.../deploy/jms/jbossmq-httpil.sar/jbossmq-httpil.war/
      [startjboss] 16:49:51,093 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-local-jdbc.rar
      [startjboss] 16:49:51,187 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-xa-jdbc.rar
      [startjboss] 16:49:51,312 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jms/jms-ra.rar
      [startjboss] 16:49:51,500 DEBUG [JbpmService] Creating jboss.jbpm:name=DefaultJbpm,service=JbpmService
      [startjboss] 16:49:51,500 DEBUG [JbpmService] Created jboss.jbpm:name=DefaultJbpm,service=JbpmService
      [startjboss] 16:49:51,578 INFO [STDOUT] [Server@c74910]: [Thread[hypersonic-default,5,jboss]]: checkRunning(false) entered
      [startjboss] 16:49:51,578 INFO [STDOUT] [Server@c74910]: [Thread[hypersonic-default,5,jboss]]: checkRunning(false) exited
      [startjboss] 16:49:51,578 INFO [STDOUT] [Server@c74910]: Startup sequence initiated from main() method
      [startjboss] 16:49:51,578 INFO [STDOUT] [Server@c74910]: Loaded properties from [C:\Java\jbpm-3.0.2\server.properties]
      [startjboss] 16:49:51,578 INFO [STDOUT] [Server@c74910]: Initiating startup sequence...
      [startjboss] 16:49:51,578 INFO [STDOUT] [Server@c74910]: Server socket opened successfully in 0 ms.
      [startjboss] 16:49:51,640 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DefaultDS' to JNDI name 'java:DefaultDS'
      [startjboss] 16:49:52,125 INFO [STDOUT] [Server@c74910]: Database [index=0, id=0, db=file:C:\Java\jboss-4.0.3SP1\server\jbpm\data\hypersonic\default, alias=] opened sucessfully in 532 ms.
      [startjboss] 16:49:52,125 INFO [STDOUT] [Server@c74910]: Startup sequence completed in 547 ms.
      [startjboss] 16:49:52,125 INFO [STDOUT] [Server@c74910]: 2006-01-27 16:49:52.125 HSQLDB server 1.8.0 is online
      [startjboss] 16:49:52,125 INFO [STDOUT] [Server@c74910]: To close normally, connect and execute SHUTDOWN SQL
      [startjboss] 16:49:52,125 INFO [STDOUT] [Server@c74910]: From command line, use [Ctrl]+[C] to abort abruptly
      [startjboss] 16:49:52,218 DEBUG [JbpmService] Starting jboss.jbpm:name=DefaultJbpm,service=JbpmService
      [startjboss] 16:49:52,234 DEBUG [JbpmService] starting jbpmSessionFactory for 'java:/jbpm/JbpmSessionFactory'...
      [startjboss] 16:49:52,250 DEBUG [JbpmConfiguration] jbpm.session.factory.jndi.name=java:/jbpm/JbpmSessionFactory
      [startjboss] 16:49:52,250 DEBUG [JbpmConfiguration] jbpm.task.instance.class=org.jbpm.taskmgmt.exe.TaskInstance
      [startjboss] 16:49:52,250 DEBUG [JbpmConfiguration] jbpm.hibernate.cfg.xml=jbpm.hibernate.cfg.xml
      [startjboss] 16:49:52,250 DEBUG [JbpmConfiguration] jbpm.scheduler.service.factory=org.jbpm.scheduler.impl.SchedulerServiceImpl
      [startjboss] 16:49:52,250 DEBUG [JbpmConfiguration] jbpm.hibernate.properties=jbpm.hibernate.properties
      [startjboss] 16:49:52,265 INFO [Environment] Hibernate 3.1
      [startjboss] 16:49:52,281 INFO [Environment] hibernate.properties not found
      [startjboss] 16:49:52,281 INFO [Environment] using CGLIB reflection optimizer
      [startjboss] 16:49:52,281 INFO [Environment] using JDK 1.4 java.sql.Timestamp handling
      [startjboss] 16:49:52,390 DEBUG [JbpmSessionFactory] using 'jbpm.hibernate.cfg.xml' as hibernate configuration for jbpm
      [startjboss] 16:49:52,390 INFO [Configuration] configuring from resource: jbpm.hibernate.cfg.xml
      [startjboss] 16:49:52,390 INFO [Configuration] Configuration resource: jbpm.hibernate.cfg.xml
      [startjboss] 16:49:52,406 INFO [Configuration] Reading mappings from resource: org/jbpm/identity/User.hbm.xml
      [startjboss] 16:49:52,546 INFO [HbmBinder] Mapping class: org.jbpm.identity.User -> JBPM_ID_USER
      [startjboss] 16:49:52,609 INFO [HbmBinder] Mapping collection: org.jbpm.identity.User.permissions -> JBPM_ID_PERMISSIONS
      [startjboss] 16:49:52,609 INFO [Configuration] Reading mappings from resource: org/jbpm/identity/Group.hbm.xml
      [startjboss] 16:49:52,640 INFO [HbmBinder] Mapping class: org.jbpm.identity.Group -> JBPM_ID_GROUP
      [startjboss] 16:49:52,640 INFO [HbmBinder] Mapping collection: org.jbpm.identity.Group.permissions -> JBPM_ID_PERMISSIONS
      [startjboss] 16:49:52,640 INFO [Configuration] Reading mappings from resource: org/jbpm/identity/Membership.hbm.xml
      [startjboss] 16:49:52,656 INFO [HbmBinder] Mapping class: org.jbpm.identity.Membership -> JBPM_ID_MEMBERSHIP
      [startjboss] 16:49:52,750 INFO [HbmBinder] Mapping collection: org.jbpm.identity.Membership.permissions -> JBPM_ID_PERMISSIONS
      [startjboss] 16:49:52,750 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/def/ProcessDefinition.hbm.xml
      [startjboss] 16:49:52,765 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.ProcessDefinition -> JBPM_PROCESSDEFINITION
      [startjboss] 16:49:52,796 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/def/Node.hbm.xml
      [startjboss] 16:49:52,812 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.Node -> JBPM_NODE
      [startjboss] 16:49:52,812 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/def/Transition.hbm.xml
      [startjboss] 16:49:52,859 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.Transition -> JBPM_TRANSITION
      [startjboss] 16:49:52,859 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/def/Event.hbm.xml
      [startjboss] 16:49:52,875 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.Event -> JBPM_EVENT
      [startjboss] 16:49:52,875 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/def/Action.hbm.xml
      [startjboss] 16:49:52,890 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.Action -> JBPM_ACTION
      [startjboss] 16:49:52,890 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/def/SuperState.hbm.xml
      [startjboss] 16:49:52,937 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.def.SuperState -> JBPM_NODE
      [startjboss] 16:49:52,968 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/def/ExceptionHandler.hbm.xml
      [startjboss] 16:49:52,984 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.ExceptionHandler -> JBPM_EXCEPTIONHANDLER
      [startjboss] 16:49:52,984 INFO [Configuration] Reading mappings from resource: org/jbpm/instantiation/Delegation.hbm.xml
      [startjboss] 16:49:53,000 INFO [HbmBinder] Mapping class: org.jbpm.instantiation.Delegation -> JBPM_DELEGATION
      [startjboss] 16:49:53,000 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/node/StartState.hbm.xml
      [startjboss] 16:49:53,000 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.StartState -> JBPM_NODE
      [startjboss] 16:49:53,000 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/node/EndState.hbm.xml
      [startjboss] 16:49:53,015 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.EndState -> JBPM_NODE
      [startjboss] 16:49:53,015 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/node/ProcessState.hbm.xml
      [startjboss] 16:49:53,031 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.ProcessState -> JBPM_NODE
      [startjboss] 16:49:53,031 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/node/Decision.hbm.xml
      [startjboss] 16:49:53,031 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.Decision -> JBPM_NODE
      [startjboss] 16:49:53,078 INFO [HbmBinder] Mapping collection: org.jbpm.graph.node.Decision.decisionConditions -> JBPM_DECISIONCONDITIONS
      [startjboss] 16:49:53,078 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/node/Fork.hbm.xml
      [startjboss] 16:49:53,078 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.Fork -> JBPM_NODE
      [startjboss] 16:49:53,078 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/node/Join.hbm.xml
      [startjboss] 16:49:53,093 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.Join -> JBPM_NODE
      [startjboss] 16:49:53,093 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/node/State.hbm.xml
      [startjboss] 16:49:53,093 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.State -> JBPM_NODE
      [startjboss] 16:49:53,093 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/node/TaskNode.hbm.xml
      [startjboss] 16:49:53,109 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.TaskNode -> JBPM_NODE
      [startjboss] 16:49:53,125 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/action/Script.hbm.xml
      [startjboss] 16:49:53,125 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.action.Script -> JBPM_ACTION
      [startjboss] 16:49:53,125 INFO [Configuration] Reading mappings from resource: org/jbpm/context/def/ContextDefinition.hbm.xml
      [startjboss] 16:49:53,140 INFO [Configuration] Reading mappings from resource: org/jbpm/context/def/VariableAccess.hbm.xml
      [startjboss] 16:49:53,140 INFO [HbmBinder] Mapping class: org.jbpm.context.def.VariableAccess -> JBPM_VARIABLEACCESS
      [startjboss] 16:49:53,140 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/def/TaskMgmtDefinition.hbm.xml
      [startjboss] 16:49:53,187 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/def/Swimlane.hbm.xml
      [startjboss] 16:49:53,203 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.def.Swimlane -> JBPM_SWIMLANE
      [startjboss] 16:49:53,203 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/def/Task.hbm.xml
      [startjboss] 16:49:53,203 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.def.Task -> JBPM_TASK
      [startjboss] 16:49:53,218 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/def/TaskController.hbm.xml
      [startjboss] 16:49:53,234 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.def.TaskController -> JBPM_TASKCONTROLLER
      [startjboss] 16:49:53,234 INFO [Configuration] Reading mappings from resource: org/jbpm/module/def/ModuleDefinition.hbm.xml
      [startjboss] 16:49:53,234 INFO [HbmBinder] Mapping class: org.jbpm.module.def.ModuleDefinition -> JBPM_MODULEDEFINITION
      [startjboss] 16:49:53,234 INFO [Configuration] Reading mappings from resource: org/jbpm/bytes/ByteArray.hbm.xml
      [startjboss] 16:49:53,250 INFO [HbmBinder] Mapping class: org.jbpm.bytes.ByteArray -> JBPM_BYTEARRAY
      [startjboss] 16:49:53,250 INFO [HbmBinder] Mapping collection: org.jbpm.bytes.ByteArray.byteBlocks -> JBPM_BYTEBLOCK
      [startjboss] 16:49:53,250 INFO [Configuration] Reading mappings from resource: org/jbpm/file/def/FileDefinition.hbm.xml
      [startjboss] 16:49:53,250 INFO [HbmBinder] Mapping subclass: org.jbpm.file.def.FileDefinition -> JBPM_MODULEDEFINITION
      [startjboss] 16:49:53,250 INFO [Configuration] Reading mappings from resource: org/jbpm/scheduler/def/CreateTimerAction.hbm.xml
      [startjboss] 16:49:53,265 INFO [HbmBinder] Mapping subclass: org.jbpm.scheduler.def.CreateTimerAction -> JBPM_ACTION
      [startjboss] 16:49:53,265 INFO [Configuration] Reading mappings from resource: org/jbpm/scheduler/def/CancelTimerAction.hbm.xml
      [startjboss] 16:49:53,265 INFO [HbmBinder] Mapping subclass: org.jbpm.scheduler.def.CancelTimerAction -> JBPM_ACTION
      [startjboss] 16:49:53,265 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/exe/Comment.hbm.xml
      [startjboss] 16:49:53,343 INFO [HbmBinder] Mapping class: org.jbpm.graph.exe.Comment -> JBPM_COMMENT
      [startjboss] 16:49:53,343 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/exe/ProcessInstance.hbm.xml
      [startjboss] 16:49:53,343 INFO [HbmBinder] Mapping class: org.jbpm.graph.exe.ProcessInstance -> JBPM_PROCESSINSTANCE
      [startjboss] 16:49:53,359 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/exe/Token.hbm.xml
      [startjboss] 16:49:53,359 INFO [HbmBinder] Mapping class: org.jbpm.graph.exe.Token -> JBPM_TOKEN
      [startjboss] 16:49:53,375 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/exe/RuntimeAction.hbm.xml
      [startjboss] 16:49:53,375 INFO [HbmBinder] Mapping class: org.jbpm.graph.exe.RuntimeAction -> JBPM_RUNTIMEACTION
      [startjboss] 16:49:53,375 INFO [Configuration] Reading mappings from resource: org/jbpm/module/exe/ModuleInstance.hbm.xml
      [startjboss] 16:49:53,437 INFO [HbmBinder] Mapping class: org.jbpm.module.exe.ModuleInstance -> JBPM_MODULEINSTANCE
      [startjboss] 16:49:53,437 INFO [Configuration] Reading mappings from resource: org/jbpm/context/exe/ContextInstance.hbm.xml
      [startjboss] 16:49:53,437 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.ContextInstance -> JBPM_MODULEINSTANCE
      [startjboss] 16:49:53,437 INFO [Configuration] Reading mappings from resource: org/jbpm/context/exe/TokenVariableMap.hbm.xml
      [startjboss] 16:49:53,453 INFO [HbmBinder] Mapping class: org.jbpm.context.exe.TokenVariableMap -> JBPM_TOKENVARIABLEMAP
      [startjboss] 16:49:53,468 INFO [Configuration] Reading mappings from resource: org/jbpm/context/exe/VariableInstance.hbm.xml
      [startjboss] 16:49:53,468 INFO [HbmBinder] Mapping class: org.jbpm.context.exe.VariableInstance -> JBPM_VARIABLEINSTANCE
      [startjboss] 16:49:53,468 INFO [Configuration] Reading mappings from resource: org/jbpm/context/exe/variableinstance/ByteArrayInstance.hbm.xml
      [startjboss] 16:49:53,484 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.ByteArrayInstance -> JBPM_VARIABLEINSTANCE
      [startjboss] 16:49:53,484 INFO [Configuration] Reading mappings from resource: org/jbpm/context/exe/variableinstance/DateInstance.hbm.xml
      [startjboss] 16:49:53,484 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.DateInstance -> JBPM_VARIABLEINSTANCE
      [startjboss] 16:49:53,484 INFO [Configuration] Reading mappings from resource: org/jbpm/context/exe/variableinstance/DoubleInstance.hbm.xml
      [startjboss] 16:49:53,484 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.DoubleInstance -> JBPM_VARIABLEINSTANCE
      [startjboss] 16:49:53,484 INFO [Configuration] Reading mappings from resource: org/jbpm/context/exe/variableinstance/HibernateLongInstance.hbm.xml
      [startjboss] 16:49:53,500 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.HibernateLongInstance -> JBPM_VARIABLEINSTANCE
      [startjboss] 16:49:53,500 INFO [Configuration] Reading mappings from resource: org/jbpm/context/exe/variableinstance/HibernateStringInstance.hbm.xml
      [startjboss] 16:49:53,500 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.HibernateStringInstance -> JBPM_VARIABLEINSTANCE
      [startjboss] 16:49:53,500 INFO [Configuration] Reading mappings from resource: org/jbpm/context/exe/variableinstance/LongInstance.hbm.xml
      [startjboss] 16:49:53,562 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.LongInstance -> JBPM_VARIABLEINSTANCE
      [startjboss] 16:49:53,562 INFO [Configuration] Reading mappings from resource: org/jbpm/context/exe/variableinstance/StringInstance.hbm.xml
      [startjboss] 16:49:53,562 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.StringInstance -> JBPM_VARIABLEINSTANCE
      [startjboss] 16:49:53,562 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/exe/TaskMgmtInstance.hbm.xml
      [startjboss] 16:49:53,578 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.exe.TaskMgmtInstance -> JBPM_MODULEINSTANCE
      [startjboss] 16:49:53,578 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/exe/TaskInstance.hbm.xml
      [startjboss] 16:49:53,593 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.exe.TaskInstance -> JBPM_TASKINSTANCE
      [startjboss] 16:49:53,593 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskInstance.pooledActors -> JBPM_TASKACTORPOOL
      [startjboss] 16:49:53,593 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/exe/PooledActor.hbm.xml
      [startjboss] 16:49:53,609 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.exe.PooledActor -> JBPM_POOLEDACTOR
      [startjboss] 16:49:53,609 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.PooledActor.taskInstances -> JBPM_TASKACTORPOOL
      [startjboss] 16:49:53,609 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/exe/SwimlaneInstance.hbm.xml
      [startjboss] 16:49:53,609 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.exe.SwimlaneInstance -> JBPM_SWIMLANEINSTANCE
      [startjboss] 16:49:53,671 INFO [Configuration] Reading mappings from resource: org/jbpm/scheduler/exe/Timer.hbm.xml
      [startjboss] 16:49:53,671 INFO [HbmBinder] Mapping class: org.jbpm.scheduler.exe.Timer -> JBPM_TIMER
      [startjboss] 16:49:53,687 INFO [Configuration] Reading mappings from resource: org/jbpm/logging/log/ProcessLog.hbm.xml
      [startjboss] 16:49:53,687 INFO [HbmBinder] Mapping class: org.jbpm.logging.log.ProcessLog -> JBPM_LOG
      [startjboss] 16:49:53,687 INFO [Configuration] Reading mappings from resource: org/jbpm/logging/log/MessageLog.hbm.xml
      [startjboss] 16:49:53,703 INFO [HbmBinder] Mapping subclass: org.jbpm.logging.log.MessageLog -> JBPM_LOG
      [startjboss] 16:49:53,703 INFO [Configuration] Reading mappings from resource: org/jbpm/logging/log/CompositeLog.hbm.xml
      [startjboss] 16:49:53,703 INFO [HbmBinder] Mapping subclass: org.jbpm.logging.log.CompositeLog -> JBPM_LOG
      [startjboss] 16:49:53,703 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/log/ActionLog.hbm.xml
      [startjboss] 16:49:53,703 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.ActionLog -> JBPM_LOG
      [startjboss] 16:49:53,718 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/log/NodeLog.hbm.xml
      [startjboss] 16:49:53,718 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.NodeLog -> JBPM_LOG
      [startjboss] 16:49:53,718 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/log/ProcessInstanceCreateLog.hbm.xml
      [startjboss] 16:49:53,718 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.ProcessInstanceCreateLog -> JBPM_LOG
      [startjboss] 16:49:53,718 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/log/ProcessInstanceEndLog.hbm.xml
      [startjboss] 16:49:53,781 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.ProcessInstanceEndLog -> JBPM_LOG
      [startjboss] 16:49:53,781 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/log/SignalLog.hbm.xml
      [startjboss] 16:49:53,781 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.SignalLog -> JBPM_LOG
      [startjboss] 16:49:53,781 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/log/TokenCreateLog.hbm.xml
      [startjboss] 16:49:53,812 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.TokenCreateLog -> JBPM_LOG
      [startjboss] 16:49:53,812 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/log/TokenEndLog.hbm.xml
      [startjboss] 16:49:53,812 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.TokenEndLog -> JBPM_LOG
      [startjboss] 16:49:53,812 INFO [Configuration] Reading mappings from resource: org/jbpm/graph/log/TransitionLog.hbm.xml
      [startjboss] 16:49:53,828 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.TransitionLog -> JBPM_LOG
      [startjboss] 16:49:53,828 INFO [Configuration] Reading mappings from resource: org/jbpm/context/log/VariableLog.hbm.xml
      [startjboss] 16:49:53,828 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.VariableLog -> JBPM_LOG
      [startjboss] 16:49:53,828 INFO [Configuration] Reading mappings from resource: org/jbpm/context/log/VariableCreateLog.hbm.xml
      [startjboss] 16:49:53,828 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.VariableCreateLog -> JBPM_LOG
      [startjboss] 16:49:53,828 INFO [Configuration] Reading mappings from resource: org/jbpm/context/log/VariableDeleteLog.hbm.xml
      [startjboss] 16:49:53,843 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.VariableDeleteLog -> JBPM_LOG
      [startjboss] 16:49:53,843 INFO [Configuration] Reading mappings from resource: org/jbpm/context/log/VariableUpdateLog.hbm.xml
      [startjboss] 16:49:53,843 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.VariableUpdateLog -> JBPM_LOG
      [startjboss] 16:49:53,843 INFO [Configuration] Reading mappings from resource: org/jbpm/context/log/variableinstance/ByteArrayUpdateLog.hbm.xml
      [startjboss] 16:49:53,906 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.ByteArrayUpdateLog -> JBPM_LOG
      [startjboss] 16:49:53,906 INFO [Configuration] Reading mappings from resource: org/jbpm/context/log/variableinstance/DateUpdateLog.hbm.xml
      [startjboss] 16:49:53,921 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.DateUpdateLog -> JBPM_LOG
      [startjboss] 16:49:53,921 INFO [Configuration] Reading mappings from resource: org/jbpm/context/log/variableinstance/DoubleUpdateLog.hbm.xml
      [startjboss] 16:49:53,921 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.DoubleUpdateLog -> JBPM_LOG
      [startjboss] 16:49:53,921 INFO [Configuration] Reading mappings from resource: org/jbpm/context/log/variableinstance/HibernateLongUpdateLog.hbm.xml
      [startjboss] 16:49:53,937 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.HibernateLongUpdateLog -> JBPM_LOG
      [startjboss] 16:49:53,937 INFO [Configuration] Reading mappings from resource: org/jbpm/context/log/variableinstance/HibernateStringUpdateLog.hbm.xml
      [startjboss] 16:49:53,937 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.HibernateStringUpdateLog -> JBPM_LOG
      [startjboss] 16:49:53,937 INFO [Configuration] Reading mappings from resource: org/jbpm/context/log/variableinstance/LongUpdateLog.hbm.xml
      [startjboss] 16:49:53,953 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.LongUpdateLog -> JBPM_LOG
      [startjboss] 16:49:53,953 INFO [Configuration] Reading mappings from resource: org/jbpm/context/log/variableinstance/StringUpdateLog.hbm.xml
      [startjboss] 16:49:53,953 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.StringUpdateLog -> JBPM_LOG
      [startjboss] 16:49:53,953 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/log/TaskLog.hbm.xml
      [startjboss] 16:49:53,953 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.TaskLog -> JBPM_LOG
      [startjboss] 16:49:53,953 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/log/TaskCreateLog.hbm.xml
      [startjboss] 16:49:53,968 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.TaskCreateLog -> JBPM_LOG
      [startjboss] 16:49:53,968 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/log/TaskAssignLog.hbm.xml
      [startjboss] 16:49:53,968 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.TaskAssignLog -> JBPM_LOG
      [startjboss] 16:49:53,968 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/log/TaskEndLog.hbm.xml
      [startjboss] 16:49:54,031 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.TaskEndLog -> JBPM_LOG
      [startjboss] 16:49:54,031 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/log/SwimlaneLog.hbm.xml
      [startjboss] 16:49:54,046 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.SwimlaneLog -> JBPM_LOG
      [startjboss] 16:49:54,046 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/log/SwimlaneCreateLog.hbm.xml
      [startjboss] 16:49:54,046 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.SwimlaneCreateLog -> JBPM_LOG
      [startjboss] 16:49:54,046 INFO [Configuration] Reading mappings from resource: org/jbpm/taskmgmt/log/SwimlaneAssignLog.hbm.xml
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.SwimlaneAssignLog -> JBPM_LOG
      [startjboss] 16:49:54,062 INFO [Configuration] Configured SessionFactory: null
      [startjboss] 16:49:54,062 DEBUG [JbpmSessionFactory] overriding hibernate properties with {hibernate.dialect=org.hibernate.dialect.HSQLDialect, hibernate.connection.datasource=java:/DefaultDS}
      [startjboss] 16:49:54,062 DEBUG [JbpmSessionFactory] building hibernate session factory
      [startjboss] 16:49:54,062 INFO [Configuration] processing extends queue
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping subclass: org.jbpm.context.def.ContextDefinition -> JBPM_MODULEDEFINITION
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.def.TaskMgmtDefinition -> JBPM_MODULEDEFINITION
      [startjboss] 16:49:54,062 INFO [Configuration] processing collection mappings
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.identity.User.memberships -> JBPM_ID_MEMBERSHIP
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.identity.Group.memberships -> JBPM_ID_MEMBERSHIP
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.events -> JBPM_EVENT
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.exceptionHandlers -> JBPM_EXCEPTIONHANDLER
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.nodes -> JBPM_NODE
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.actions -> JBPM_ACTION
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.definitions -> JBPM_MODULEDEFINITION
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Node.events -> JBPM_EVENT
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Node.exceptionHandlers -> JBPM_EXCEPTIONHANDLER
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Node.leavingTransitions -> JBPM_TRANSITION
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Node.arrivingTransitions -> JBPM_TRANSITION
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Transition.events -> JBPM_EVENT
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Transition.exceptionHandlers -> JBPM_EXCEPTIONHANDLER
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Event.actions -> JBPM_ACTION
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.SuperState.nodes -> JBPM_NODE
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ExceptionHandler.actions -> JBPM_ACTION
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.node.ProcessState.variableAccesses -> JBPM_VARIABLEACCESS
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.node.TaskNode.tasks -> JBPM_TASK
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.graph.action.Script.variableAccesses -> JBPM_VARIABLEACCESS
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.Swimlane.tasks -> JBPM_TASK
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.Task.events -> JBPM_EVENT
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.Task.exceptionHandlers -> JBPM_EXCEPTIONHANDLER
      [startjboss] 16:49:54,062 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.TaskController.variableAccesses -> JBPM_VARIABLEACCESS
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.file.def.FileDefinition.processFiles -> JBPM_BYTEARRAY
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.graph.exe.ProcessInstance.runtimeActions -> JBPM_RUNTIMEACTION
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.graph.exe.ProcessInstance.instances -> JBPM_MODULEINSTANCE
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.graph.exe.Token.children -> JBPM_TOKEN
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.graph.exe.Token.comments -> JBPM_COMMENT
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.context.exe.ContextInstance.tokenVariableMaps -> JBPM_TOKENVARIABLEMAP
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.context.exe.TokenVariableMap.variableInstances -> JBPM_VARIABLEINSTANCE
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskMgmtInstance.swimlaneInstances -> JBPM_SWIMLANEINSTANCE
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskMgmtInstance.taskInstances -> JBPM_TASKINSTANCE
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskInstance.comments -> JBPM_COMMENT
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.SwimlaneInstance.pooledActors -> JBPM_POOLEDACTOR
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.logging.log.CompositeLog.children -> JBPM_LOG
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.TaskMgmtDefinition.swimlanes -> JBPM_SWIMLANE
      [startjboss] 16:49:54,078 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.TaskMgmtDefinition.tasks -> JBPM_TASK
      [startjboss] 16:49:54,078 INFO [Configuration] processing association property references
      [startjboss] 16:49:54,078 INFO [Configuration] processing foreign key constraints
      [startjboss] 16:49:54,265 INFO [NamingHelper] JNDI InitialContext properties:{}
      [startjboss] 16:49:54,281 INFO [DatasourceConnectionProvider] Using datasource: java:/DefaultDS
      [startjboss] 16:49:54,296 INFO [SettingsFactory] RDBMS: HSQL Database Engine, version: 1.8.0
      [startjboss] 16:49:54,296 INFO [SettingsFactory] JDBC driver: HSQL Database Engine Driver, version: 1.8.0
      [startjboss] 16:49:54,328 INFO [Dialect] Using dialect: org.hibernate.dialect.HSQLDialect
      [startjboss] 16:49:54,328 INFO [TransactionFactoryFactory] Using default transaction strategy (direct JDBC transactions)
      [startjboss] 16:49:54,390 INFO [TransactionManagerLookupFactory] No TransactionManagerLookup configured (in JTA environment, use of read-write or transactional second-level cache is not recommended)
      [startjboss] 16:49:54,390 INFO [SettingsFactory] Automatic flush during beforeCompletion(): disabled
      [startjboss] 16:49:54,390 INFO [SettingsFactory] Automatic session close at end of transaction: disabled
      [startjboss] 16:49:54,390 INFO [SettingsFactory] JDBC batch size: 15
      [startjboss] 16:49:54,390 INFO [SettingsFactory] JDBC batch updates for versioned data: disabled
      [startjboss] 16:49:54,406 INFO [SettingsFactory] Scrollable result sets: enabled
      [startjboss] 16:49:54,406 INFO [SettingsFactory] JDBC3 getGeneratedKeys(): disabled
      [startjboss] 16:49:54,406 INFO [SettingsFactory] Connection release mode: auto
      [startjboss] 16:49:54,406 INFO [SettingsFactory] Default batch fetch size: 1
      [startjboss] 16:49:54,406 INFO [SettingsFactory] Generate SQL with comments: disabled
      [startjboss] 16:49:54,406 INFO [SettingsFactory] Order SQL updates by primary key: disabled
      [startjboss] 16:49:54,406 INFO [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
      [startjboss] 16:49:54,406 INFO [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
      [startjboss] 16:49:54,406 INFO [SettingsFactory] Query language substitutions: {}
      [startjboss] 16:49:54,406 INFO [SettingsFactory] Second-level cache: enabled
      [startjboss] 16:49:54,406 INFO [SettingsFactory] Query cache: disabled
      [startjboss] 16:49:54,406 INFO [SettingsFactory] Cache provider: org.hibernate.cache.EhCacheProvider
      [startjboss] 16:49:54,406 INFO [SettingsFactory] Optimize cache for minimal puts: disabled
      [startjboss] 16:49:54,406 INFO [SettingsFactory] Structured second-level cache entries: disabled
      [startjboss] 16:49:54,421 INFO [SettingsFactory] Statistics: disabled
      [startjboss] 16:49:54,421 INFO [SettingsFactory] Deleted entity synthetic identifier rollback: disabled
      [startjboss] 16:49:54,421 INFO [SettingsFactory] Default entity-mode: POJO
      [startjboss] 16:49:54,625 INFO [SessionFactoryImpl] building session factory
      [startjboss] 16:49:54,765 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Node]; using defaults.
      [startjboss] 16:49:55,015 WARN [EhCacheProvider] Could not find configuration [org.jbpm.instantiation.Delegation]; using defaults.
      [startjboss] 16:49:55,093 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.Task]; using defaults.
      [startjboss] 16:49:55,125 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition]; using defaults.
      [startjboss] 16:49:55,171 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ExceptionHandler]; using defaults.
      [startjboss] 16:49:55,171 WARN [EhCacheProvider] Could not find configuration [org.jbpm.module.def.ModuleDefinition]; using defaults.
      [startjboss] 16:49:55,359 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Action]; using defaults.
      [startjboss] 16:49:55,375 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Event]; using defaults.
      [startjboss] 16:49:55,390 WARN [EhCacheProvider] Could not find configuration [org.jbpm.context.def.VariableAccess]; using defaults.
      [startjboss] 16:49:55,421 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Transition]; using defaults.
      [startjboss] 16:49:55,515 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.TaskController]; using defaults.
      [startjboss] 16:49:56,078 INFO [SessionFactoryObjectFactory] Not binding factory to JNDI, no JNDI name configured
      [startjboss] 16:49:56,078 INFO [SessionFactoryImpl] Checking 0 named queries
      [startjboss] 16:49:56,078 INFO [JbpmService] binding JbpmSessionFactory 'java:/jbpm/JbpmSessionFactory' into JNDI...
      [startjboss] 16:49:56,078 DEBUG [JbpmService] Started jboss.jbpm:name=DefaultJbpm,service=JbpmService
      [startjboss] 16:49:56,156 INFO [JbpmQueue] Bound to JNDI name: queue/JbpmQueue
      [startjboss] 16:49:56,218 INFO [UILServerILService] JBossMQ UIL service available at : /0.0.0.0:8093
      [startjboss] 16:49:56,234 INFO [DLQ] Bound to JNDI name: queue/DLQ
      [startjboss] 16:49:56,406 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA'
      [startjboss] 16:49:56,718 INFO [TomcatDeployer] deploy, ctxPath=/jbpm, warUrl=.../tmp/deploy/tmp32453jbpm-exp.war/
      [startjboss] 16:49:57,125 INFO [FacesConfigurator] Reading standard config org/apache/myfaces/resource/standard-faces-config.xml
      [startjboss] 16:49:57,140 INFO [FacesConfigurator] Reading config jar:file:/C:/Java/jboss-4.0.3SP1/server/jbpm/tmp/deploy/tmp32453jbpm-exp.war/WEB-INF/lib/tomahawk.jar!/META-INF/faces-config.xml
      [startjboss] 16:49:57,171 INFO [FacesConfigurator] Reading config /WEB-INF/faces-config.xml
      [startjboss] 16:49:57,218 DEBUG [ApplicationFactory] New ApplicationFactory instance created
      [startjboss] 16:49:57,218 ERROR [LocaleUtils] Locale name null or empty, ignoring
      [startjboss] 16:49:57,546 INFO [StartupServletContextListener] ServletContext 'C:\Java\jboss-4.0.3SP1\server\jbpm\.\tmp\deploy\tmp32453jbpm-exp.war\' initialized.
      [startjboss] 16:49:57,546 DEBUG [Scheduler] starting the scheduler
      [startjboss] 16:49:57,546 DEBUG [JbpmSessionFactory] fetching JbpmSessionFactory from 'java:/jbpm/JbpmSessionFactory'
      [startjboss] 16:49:57,640 DEBUG [SchedulerThread] checking for timers
      [startjboss] 16:49:57,671 INFO [TomcatDeployer] deploy, ctxPath=/jmx-console, warUrl=.../deploy/jmx-console.war/
      [startjboss] 16:49:58,218 WARN [JDBCExceptionReporter] SQL Error: -22, SQLState: S0002
      [startjboss] 16:49:58,218 ERROR [JDBCExceptionReporter] Table not found in statement [select timer0_.ID_ as col_0_0_ from JBPM_TIMER timer0_ where timer0_.EXCEPTION_ is null order by timer0_.DUEDATE_ asc]
      [startjboss] 16:49:58,218 ERROR [SchedulerSession] org.hibernate.exception.SQLGrammarException: could not execute query using iterate
      [startjboss] 16:49:58,218 ERROR [JbpmSession] java.lang.NullPointerException
      [startjboss] 16:49:58,218 ERROR [JbpmSession] couldn't rollback hibernate transaction
      [startjboss] org.hibernate.TransactionException: Transaction not successfully started
      [startjboss] at org.hibernate.transaction.JDBCTransaction.rollback(JDBCTransaction.java:149)
      [startjboss] at org.jbpm.db.JbpmSession.handleException(JbpmSession.java:177)
      [startjboss] at org.jbpm.db.JbpmSession.commitTransaction(JbpmSession.java:106)
      [startjboss] at org.jbpm.db.JbpmSession.commitTransactionAndClose(JbpmSession.java:129)
      [startjboss] at org.jbpm.scheduler.impl.SchedulerThread.executeTimers(SchedulerThread.java:121)
      [startjboss] at org.jbpm.scheduler.impl.SchedulerThread.run(SchedulerThread.java:34)
      [startjboss] 16:49:58,234 WARN [JbpmSession] can't pop current session: are you calling JbpmSession.close() multiple times ?
      [startjboss] 16:49:58,234 INFO [SchedulerThread] runtime exception while executing timers
      [startjboss] java.lang.RuntimeException: couldn't commit transaction
      [startjboss] at org.jbpm.db.JbpmSession.commitTransaction(JbpmSession.java:107)
      [startjboss] at org.jbpm.db.JbpmSession.commitTransactionAndClose(JbpmSession.java:129)
      [startjboss] at org.jbpm.scheduler.impl.SchedulerThread.executeTimers(SchedulerThread.java:121)
      [startjboss] at org.jbpm.scheduler.impl.SchedulerThread.run(SchedulerThread.java:34)
      [startjboss] Caused by: java.lang.NullPointerException
      [startjboss] at org.jbpm.db.JbpmSession.commitTransaction(JbpmSession.java:102)
      [startjboss] ... 3 more
      [startjboss] 16:49:58,453 INFO [Http11Protocol] Starting Coyote HTTP/1.1 on http-0.0.0.0-8080
      [startjboss] 16:49:58,515 INFO [ChannelSocket] JK: ajp13 listening on /0.0.0.0:8009
      [startjboss] 16:49:58,531 INFO [JkMain] Jk running ID=0 time=0/47 config=null
      [startjboss] 16:49:58,531 INFO [Server] JBoss (MX MicroKernel) [4.0.3SP1 (build: CVSTag=JBoss_4_0_3_SP1 date=200510231054)] Started in 14s:31ms
      [startjboss] 'C:/Java/jboss-4.0.3SP1\bin\run.bat -c jbpm' started.
      BUILD SUCCESSFUL
      Total time: 16 seconds