[jboss-user] [JBoss jBPM] - error testing atm bpel process, java.lang.reflect.Invocation

javilaalonso do-not-reply at jboss.com
Mon Oct 2 15:17:20 EDT 2006


Hi, 

I don't really understand what is happening here. I am just testing the atm process (ant run-test ) and I get several errors.

[org.jbpm.bpel.integration.jms.RequestListener] could not resume process execution

The server log is here.


  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [org.jbpm.bpel.variable.def.MessageType#15]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [org.jbpm.bpel.variable.def.MessageType#15]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [org.jbpm.bpel.variable.def.MessageType#16]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [org.jbpm.bpel.variable.def.MessageType#16]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [org.jbpm.bpel.variable.def.MessageType#17]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [org.jbpm.bpel.variable.def.MessageType#17]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections were found in result set for role: org.jbpm.bpel.def.ImportsDefinition.messageTypes
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.CollectionLoadContext] collection fully initialized: [org.jbpm.bpel.def.ImportsDefinition.messageTypes#4]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections initialized for role: org.jbpm.bpel.def.ImportsDefinition.messageTypes
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.StatefulPersistenceContext] initializing non-lazy collections
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.loader.Loader] done loading collection
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.loader.Loader] loading collection: [org.jbpm.bpel.variable.def.VariableType.propertyAliases#12]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 1)
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_TIMER
  |         (ID_, NAME_, DUEDATE_, REPEAT_, TRANSITIONNAME_, EXCEPTION_, ISSUSPENDED_, ACTION_, TOKEN_, PROCESSINSTANCE_, TASKINSTANCE_, GRAPHELEMENTTYPE_, GRAPHELEMENT_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.SQL] 
  |     select
  |         propertyal0_.VARIABLETYPE_ as VARIABL10_1_,
  |         propertyal0_.id as id1_,
  |         propertyal0_.LOCALNAME_ as LOCALNAME11_1_,
  |         propertyal0_.NAMESPACE_ as NAMESPACE12_1_,
  |         propertyal0_.id as id62_0_,
  |         propertyal0_.PROPERTY_ as PROPERTY2_62_0_,
  |         propertyal0_.MESSAGE_ as MESSAGE3_62_0_,
  |         propertyal0_.PART_ as PART4_62_0_,
  |         propertyal0_.TYPELOCALNAME_ as TYPELOCA5_62_0_,
  |         propertyal0_.TYPENAMESPACE_ as TYPENAME6_62_0_,
  |         propertyal0_.ELEMENTLOCALNAME_ as ELEMENTL7_62_0_,
  |         propertyal0_.ELEMENTNAMESPACE_ as ELEMENTN8_62_0_,
  |         propertyal0_.QUERY_ as QUERY9_62_0_ 
  |     from
  |         BPEL_PROPERTYALIAS propertyal0_ 
  |     where
  |         propertyal0_.VARIABLETYPE_=?
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 2)
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 1)
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open ResultSet (open ResultSets: 0, globally: 0)
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.loader.Loader] result set contains (possibly empty) collection: [org.jbpm.bpel.variable.def.VariableType.propertyAliases#12]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[org.jbpm.bpel.wsdl.impl.PropertyAliasImpl#5]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 3
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 2)
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.loader.Loader] found row of collection: [org.jbpm.bpel.variable.def.VariableType.propertyAliases#12]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close ResultSet (open ResultSets: 1, globally: 1)
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [org.jbpm.bpel.wsdl.impl.PropertyAliasImpl#5]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.TwoPhaseLoad] adding entity to second-level cache: [org.jbpm.bpel.wsdl.impl.PropertyAliasImpl#5]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Caching: org.jbpm.bpel.wsdl.impl.PropertyAliasImpl#5
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [org.jbpm.bpel.wsdl.impl.PropertyAliasImpl#5]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections were found in result set for role: org.jbpm.bpel.variable.def.VariableType.propertyAliases
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.CollectionLoadContext] collection fully initialized: [org.jbpm.bpel.variable.def.VariableType.propertyAliases#12]
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections initialized for role: org.jbpm.bpel.variable.def.VariableType.propertyAliases
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.engine.StatefulPersistenceContext] initializing non-lazy collections
  | 2006-10-02 20:36:16,375 DEBUG [org.hibernate.loader.Loader] done loading collection
  | 2006-10-02 20:36:16,375 ERROR [org.jbpm.bpel.integration.jms.RequestListener] could not resume process execution
  | java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
  | 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.Pick_$$_javassist_159.messageReceived(Pick_$$_javassist_159.java)
  | 	at org.jbpm.bpel.integration.jms.RequestListener.onMessage(RequestListener.java:135)
  | 	at org.jboss.mq.SpyMessageConsumer.run(SpyMessageConsumer.java:694)
  | 	at java.lang.Thread.run(Thread.java:595)
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor166.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.StructuredActivity$Begin_$$_javassist_123.leave(StructuredActivity$Begin_$$_javassist_123.java)
  | 	at org.jbpm.bpel.def.Pick.pickPath(Pick.java:121)
  | 	at org.jbpm.bpel.def.Pick.messageReceived(Pick.java:87)
  | 	... 9 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor160.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.Activity_$$_javassist_11.enter(Activity_$$_javassist_11.java)
  | 	at org.jbpm.bpel.def.Scope.execute(Scope.java:138)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	at org.jbpm.graph.def.Transition.take(Transition.java:119)
  | 	at org.jbpm.graph.def.Node.leave(Node.java:383)
  | 	... 16 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor160.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.StructuredActivity$Begin_$$_javassist_123.enter(StructuredActivity$Begin_$$_javassist_123.java)
  | 	at org.jbpm.bpel.def.StructuredActivity.enter(StructuredActivity.java:52)
  | 	... 25 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor181.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.CompositeActivity_$$_javassist_8.execute(CompositeActivity_$$_javassist_8.java)
  | 	at org.jbpm.bpel.def.StructuredActivity$Begin.leave(StructuredActivity.java:219)
  | 	at org.jbpm.graph.def.Node.execute(Node.java:339)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	... 31 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor166.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.StructuredActivity$Begin_$$_javassist_123.leave(StructuredActivity$Begin_$$_javassist_123.java)
  | 	at org.jbpm.bpel.def.StructuredActivity.execute(StructuredActivity.java:56)
  | 	... 39 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor164.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java)
  | 	at org.jbpm.graph.def.Transition.take(Transition.java:119)
  | 	at org.jbpm.graph.def.Node.leave(Node.java:383)
  | 	... 45 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor164.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java)
  | 	at org.jbpm.graph.def.Transition.take(Transition.java:119)
  | 	at org.jbpm.graph.def.Node.leave(Node.java:383)
  | 	at org.jbpm.bpel.def.Activity.leave(Activity.java:171)
  | 	at org.jbpm.bpel.def.Assign.execute(Assign.java:55)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	... 52 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor164.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java)
  | 	at org.jbpm.graph.def.Transition.take(Transition.java:119)
  | 	at org.jbpm.graph.def.Node.leave(Node.java:383)
  | 	at org.jbpm.bpel.def.Activity.leave(Activity.java:171)
  | 	at org.jbpm.bpel.def.Invoke.execute(Invoke.java:45)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	... 62 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor181.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.CompositeActivity_$$_javassist_8.execute(CompositeActivity_$$_javassist_8.java)
  | 	at org.jbpm.bpel.def.StructuredActivity$Begin.leave(StructuredActivity.java:219)
  | 	at org.jbpm.graph.def.Node.execute(Node.java:339)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	... 72 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor166.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.StructuredActivity$Begin_$$_javassist_123.leave(StructuredActivity$Begin_$$_javassist_123.java)
  | 	at org.jbpm.bpel.def.If.execute(If.java:80)
  | 	... 80 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor160.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.StructuredActivity$Begin_$$_javassist_123.enter(StructuredActivity$Begin_$$_javassist_123.java)
  | 	at org.jbpm.graph.def.Transition.take(Transition.java:119)
  | 	at org.jbpm.graph.def.Node.leave(Node.java:383)
  | 	... 86 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor166.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.StructuredActivity$Begin_$$_javassist_123.leave(StructuredActivity$Begin_$$_javassist_123.java)
  | 	at org.jbpm.bpel.def.StructuredActivity.execute(StructuredActivity.java:56)
  | 	at org.jbpm.bpel.def.StructuredActivity$Begin.leave(StructuredActivity.java:219)
  | 	at org.jbpm.graph.def.Node.execute(Node.java:339)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	... 93 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor164.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java)
  | 	at org.jbpm.graph.def.Transition.take(Transition.java:119)
  | 	at org.jbpm.graph.def.Node.leave(Node.java:383)
  | 	... 102 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor164.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java)
  | 	at org.jbpm.graph.def.Transition.take(Transition.java:119)
  | 	at org.jbpm.graph.def.Node.leave(Node.java:383)
  | 	at org.jbpm.bpel.def.Activity.leave(Activity.java:171)
  | 	at org.jbpm.bpel.def.Assign.execute(Assign.java:55)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	... 109 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor175.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.StructuredActivity$End_$$_javassist_57.enter(StructuredActivity$End_$$_javassist_57.java)
  | 	at org.jbpm.graph.def.Transition.take(Transition.java:119)
  | 	at org.jbpm.graph.def.Node.leave(Node.java:383)
  | 	at org.jbpm.bpel.def.Activity.leave(Activity.java:171)
  | 	at org.jbpm.bpel.def.Reply.execute(Reply.java:45)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	... 119 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor165.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.StructuredActivity$End_$$_javassist_57.leave(StructuredActivity$End_$$_javassist_57.java)
  | 	at org.jbpm.bpel.def.StructuredActivity.leave(StructuredActivity.java:60)
  | 	at org.jbpm.bpel.def.StructuredActivity$End.execute(StructuredActivity.java:243)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	... 129 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor175.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.StructuredActivity$End_$$_javassist_57.enter(StructuredActivity$End_$$_javassist_57.java)
  | 	at org.jbpm.graph.def.Transition.take(Transition.java:119)
  | 	at org.jbpm.graph.def.Node.leave(Node.java:383)
  | 	at org.jbpm.bpel.def.Activity.leave(Activity.java:171)
  | 	... 137 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor165.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.CompositeActivity_$$_javassist_8.leave(CompositeActivity_$$_javassist_8.java)
  | 	at org.jbpm.bpel.def.StructuredActivity$End.execute(StructuredActivity.java:243)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	... 145 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor165.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.StructuredActivity$End_$$_javassist_57.leave(StructuredActivity$End_$$_javassist_57.java)
  | 	at org.jbpm.bpel.def.StructuredActivity.leave(StructuredActivity.java:60)
  | 	... 152 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor164.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java)
  | 	at org.jbpm.graph.def.Transition.take(Transition.java:119)
  | 	at org.jbpm.graph.def.Node.leave(Node.java:383)
  | 	at org.jbpm.bpel.def.Activity.leave(Activity.java:171)
  | 	... 158 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor181.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.CompositeActivity_$$_javassist_8.execute(CompositeActivity_$$_javassist_8.java)
  | 	at org.jbpm.bpel.def.StructuredActivity$Begin.leave(StructuredActivity.java:219)
  | 	at org.jbpm.graph.def.Node.execute(Node.java:339)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	... 166 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor166.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.StructuredActivity$Begin_$$_javassist_123.leave(StructuredActivity$Begin_$$_javassist_123.java)
  | 	at org.jbpm.bpel.def.StructuredActivity.execute(StructuredActivity.java:56)
  | 	... 174 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor160.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.While$Loop_$$_javassist_157.enter(While$Loop_$$_javassist_157.java)
  | 	at org.jbpm.graph.def.Transition.take(Transition.java:119)
  | 	at org.jbpm.graph.def.Node.leave(Node.java:383)
  | 	... 180 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor164.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java)
  | 	at org.jbpm.graph.def.Transition.take(Transition.java:119)
  | 	at org.jbpm.graph.def.Node.leave(Node.java:383)
  | 	at org.jbpm.bpel.def.While$Loop.execute(While.java:178)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	... 187 more
  | Caused by: java.lang.reflect.InvocationTargetException
  | 	at sun.reflect.GeneratedMethodAccessor181.invoke(Unknown Source)
  | 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
  | 	at java.lang.reflect.Method.invoke(Method.java:585)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.def.CompositeActivity_$$_javassist_8.execute(CompositeActivity_$$_javassist_8.java)
  | 	at org.jbpm.bpel.def.StructuredActivity$Begin.leave(StructuredActivity.java:219)
  | 	at org.jbpm.graph.def.Node.execute(Node.java:339)
  | 	at org.jbpm.bpel.def.Activity.enter(Activity.java:101)
  | 	... 196 more
  | Caused by: java.lang.IllegalAccessException: Class org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer can not access a member of class org.jbpm.bpel.sublang.def.Snippet with modifiers "public"
  | 	at sun.reflect.Reflection.ensureMemberAccess(Reflection.java:65)
  | 	at java.lang.reflect.Method.invoke(Method.java:578)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:208)
  | 	at org.jbpm.bpel.sublang.def.Expression_$$_javassist_94.getText(Expression_$$_javassist_94.java)
  | 	at org.jbpm.bpel.alarm.Alarm.toString(Alarm.java:145)
  | 	at java.lang.String.valueOf(String.java:2577)
  | 	at java.lang.StringBuffer.append(StringBuffer.java:220)
  | 	at org.jbpm.bpel.alarm.Alarm.createTimer(Alarm.java:93)
  | 	at org.jbpm.bpel.def.Pick.execute(Pick.java:69)
  | 	... 204 more
  | 2006-10-02 20:36:16,375 DEBUG [org.jbpm.bpel.integration.server.SoapHandler] sent request: id=ID:2-115981417637526, destination=QUEUE.testQueue, replyTo=QUEUE.JMS_TQ14, correlationId=null, _$partnerLinkId=2, _$operationName=getBalance, customerId=ernie
  | 2006-10-02 20:36:16,375 DEBUG [org.jbpm.configuration.JbpmContextInfo] creating jbpm context with service factories '[message, integration, scheduler, logging, persistence, authentication]'
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.JbpmContext] closing JbpmContext
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.JbpmContext] creating JbpmContext
  | 2006-10-02 20:36:16,390 DEBUG [org.jboss.mq.security.SecurityManager] No SecurityMetadadata was available for JMS_TQ14 using default security config
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.svc.Services] executing default save operations
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.bpel.integration.jms.RequestListener] received request: id=ID:2-115981417637526, destination=QUEUE.testQueue, replyTo=QUEUE.JMS_TQ14, correlationId=null, _$partnerLinkId=2, _$operationName=getBalance, JMSXDeliveryCount=1, customerId=ernie
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.bpel.integration.server.SoapHandler] listening for response: JMS_TQ14
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.persistence.db.DbPersistenceService] creating hibernate session
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.impl.SessionImpl] opened session at timestamp: 4750598866493440
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.persistence.db.DbPersistenceService] beginning hibernate transaction
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.transaction.JDBCTransaction] begin
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.ConnectionManager] opening JDBC connection
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.transaction.JDBCTransaction] current autocommit status: true
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.transaction.JDBCTransaction] disabling autocommit
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.impl.SessionImpl] initializing proxy: [org.jbpm.graph.exe.Token#32]
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, NODE_, ENTER_, LEAVE_, DURATION_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, ?, 'N')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.loader.Loader] loading entity: [org.jbpm.graph.exe.Token#32]
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     select
  |         token0_.ID_ as ID1_20_0_,
  |         token0_.VERSION_ as VERSION2_20_0_,
  |         token0_.NAME_ as NAME3_20_0_,
  |         token0_.START_ as START4_20_0_,
  |         token0_.END_ as END5_20_0_,
  |         token0_.NODEENTER_ as NODEENTER6_20_0_,
  |         token0_.NEXTLOGINDEX_ as NEXTLOGI7_20_0_,
  |         token0_.ISABLETOREACTIVATEPARENT_ as ISABLETO8_20_0_,
  |         token0_.ISTERMINATIONIMPLICIT_ as ISTERMIN9_20_0_,
  |         token0_.ISSUSPENDED_ as ISSUSPE10_20_0_,
  |         token0_.NODE_ as NODE11_20_0_,
  |         token0_.PROCESSINSTANCE_ as PROCESS12_20_0_,
  |         token0_.PARENT_ as PARENT13_20_0_,
  |         token0_.SUBPROCESSINSTANCE_ as SUBPROC14_20_0_ 
  |     from
  |         JBPM_TOKEN token0_ 
  |     where
  |         token0_.ID_=?
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 2)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open ResultSet (open ResultSets: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close ResultSet (open ResultSets: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 2)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 432
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.engine.StatefulPersistenceContext] initializing non-lazy collections
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.loader.Loader] done entity load
  | 2006-10-02 20:36:16,390 ERROR [org.jbpm.bpel.integration.jms.RequestListener] could not resume process execution
  | org.hibernate.ObjectNotFoundException: No row with the given identifier exists: [org.jbpm.graph.exe.Token#32]
  | 	at org.hibernate.impl.SessionFactoryImpl$1.handleEntityNotFound(SessionFactoryImpl.java:372)
  | 	at org.hibernate.proxy.AbstractLazyInitializer.checkTargetState(AbstractLazyInitializer.java:79)
  | 	at org.hibernate.proxy.AbstractLazyInitializer.initialize(AbstractLazyInitializer.java:68)
  | 	at org.hibernate.proxy.AbstractLazyInitializer.getImplementation(AbstractLazyInitializer.java:111)
  | 	at org.hibernate.proxy.pojo.javassist.JavassistLazyInitializer.invoke(JavassistLazyInitializer.java:196)
  | 	at org.jbpm.graph.exe.Token_$$_javassist_61.getProcessInstance(Token_$$_javassist_61.java)
  | 	at org.jbpm.JbpmContext.addAutoSaveToken(JbpmContext.java:574)
  | 	at org.jbpm.JbpmContext.loadTokenForUpdate(JbpmContext.java:289)
  | 	at org.jbpm.bpel.integration.jms.RequestListener.onMessage(RequestListener.java:116)
  | 	at org.jboss.mq.SpyMessageConsumer.run(SpyMessageConsumer.java:694)
  | 	at java.lang.Thread.run(Thread.java:595)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.JbpmContext] closing JbpmContext
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.svc.Services] closing service 'persistence': org.jbpm.bpel.persistence.db.DbPersistenceService at 1afcc2c
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.persistence.db.DbPersistenceService] rolling back hibernate transaction
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.transaction.JDBCTransaction] rollback
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.transaction.JDBCTransaction] re-enabling autocommit
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, TRANSITION_, SOURCENODE_, DESTINATIONNODE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, 'T')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.transaction.JDBCTransaction] rolled back JDBC Connection
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.ConnectionManager] aggressively releasing JDBC connection
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.ConnectionManager] releasing JDBC connection [ (open PreparedStatements: 0, globally: 1) (open ResultSets: 0, globally: 0)]
  | 2006-10-02 20:36:16,390 DEBUG [org.jbpm.persistence.db.DbPersistenceService] closing hibernate session
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 433
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, CHILD_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, 'O')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 434
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, CHILD_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, 'O')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 435
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         BPEL_SCOPEINSTANCE
  |         (ID_, STATE_, DEFINITION_, TOKEN_, FAULT_, COMPENSATIONLISTENERCLASS_, COMPENSATIONLISTENER_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, 'S')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 17
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_VARIABLEINSTANCE
  |         (ID_, NAME_, CONVERTER_, TOKEN_, TOKENVARIABLEMAP_, PROCESSINSTANCE_, LONGIDCLASS_, LONGVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 108
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, 'R')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 436
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, OLDLONGIDCLASS_, OLDLONGIDVALUE_, NEWLONGIDCLASS_, NEWLONGIDVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 437
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         BPEL_MESSAGEVALUE
  |         (ID_, TYPE_) 
  |     values
  |         (null, ?)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 54
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_VARIABLEINSTANCE
  |         (ID_, NAME_, CONVERTER_, TOKEN_, TOKENVARIABLEMAP_, PROCESSINSTANCE_, LONGIDCLASS_, LONGVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 109
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, 'R')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 438
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, OLDLONGIDCLASS_, OLDLONGIDVALUE_, NEWLONGIDCLASS_, NEWLONGIDVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 439
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         BPEL_MESSAGEVALUE
  |         (ID_, TYPE_) 
  |     values
  |         (null, ?)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 55
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_VARIABLEINSTANCE
  |         (ID_, NAME_, CONVERTER_, TOKEN_, TOKENVARIABLEMAP_, PROCESSINSTANCE_, LONGIDCLASS_, LONGVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 110
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, 'R')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 440
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, OLDLONGIDCLASS_, OLDLONGIDVALUE_, NEWLONGIDCLASS_, NEWLONGIDVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 441
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         BPEL_MESSAGEVALUE
  |         (ID_, TYPE_) 
  |     values
  |         (null, ?)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 56
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_VARIABLEINSTANCE
  |         (ID_, NAME_, CONVERTER_, TOKEN_, TOKENVARIABLEMAP_, PROCESSINSTANCE_, LONGIDCLASS_, LONGVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 111
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, 'R')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 442
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, OLDLONGIDCLASS_, OLDLONGIDVALUE_, NEWLONGIDCLASS_, NEWLONGIDVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 443
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         BPEL_MESSAGEVALUE
  |         (ID_, TYPE_) 
  |     values
  |         (null, ?)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 57
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,390 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_VARIABLEINSTANCE
  |         (ID_, NAME_, CONVERTER_, TOKEN_, TOKENVARIABLEMAP_, PROCESSINSTANCE_, LONGIDCLASS_, LONGVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 112
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, 'R')
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 444
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, OLDLONGIDCLASS_, OLDLONGIDVALUE_, NEWLONGIDCLASS_, NEWLONGIDVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 445
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         BPEL_MESSAGEVALUE
  |         (ID_, TYPE_) 
  |     values
  |         (null, ?)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 58
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_VARIABLEINSTANCE
  |         (ID_, NAME_, CONVERTER_, TOKEN_, TOKENVARIABLEMAP_, PROCESSINSTANCE_, LONGIDCLASS_, LONGVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 113
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, 'R')
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 446
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, OLDLONGIDCLASS_, OLDLONGIDVALUE_, NEWLONGIDCLASS_, NEWLONGIDVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 447
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_VARIABLEINSTANCE
  |         (ID_, NAME_, CONVERTER_, TOKEN_, TOKENVARIABLEMAP_, PROCESSINSTANCE_, ELEMENTVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, 'E')
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 114
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_LOG
  |         (ID_, INDEX_, DATE_, TOKEN_, PARENT_, VARIABLEINSTANCE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, 'R')
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 448
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         BPEL_MESSAGEVALUE
  |         (ID_, TYPE_) 
  |     values
  |         (null, ?)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     call identity()
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.id.IdentifierGeneratorFactory] Natively generated identity: 59
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] executing identity-insert immediately
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.SQL] 
  |     insert 
  |     into
  |         JBPM_VARIABLEINSTANCE
  |         (ID_, NAME_, CONVERTER_, TOKEN_, TOKENVARIABLEMAP_, PROCESSINSTANCE_, LONGIDCLASS_, LONGVALUE_, CLASS_) 
  |     values
  |         (null, ?, ?, ?, ?, ?, ?, ?, 'H')
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
  | 2006-10-02 20:36:16,406 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, gl

View the original post : http://www.jboss.com/index.html?module=bb&op=viewtopic&p=3975585#3975585

Reply to the post : http://www.jboss.com/index.html?module=bb&op=posting&mode=reply&p=3975585



More information about the jboss-user mailing list