[jboss-user] [JBoss jBPM] - invoke called, but our invoker is disconnected
bertrand.njiipwo
do-not-reply at jboss.com
Tue Jan 2 13:19:11 EST 2007
Hello @all,
first all my Best wishes for 2007!.
First sorry because i don't know if this thread belongs to this forum.
I was facing the probem on invoking a web service deployed on axis 1.1.
I could partially solve (I'll post the solution in this thread later http://www.jboss.com/index.html?module=bb&op=viewtopic&t=97346 ).
Now i can invoke the deployed web service and it generates the expected output. The problem will be now to feedback the response to the running BPEL process in the PortConsumer - PortProvider Relation. because the effectiv call was routed to a non ws4ee-web-service (runnning axis service) some informations are losed at that time.
My opinion is that i'll need to reinit a PortProvider object with the response of generated by the service call.
I'll appreciate any suggestion to solve the following error i'm getting after the invoke operation:
anonymous wrote :
| 2007-01-02 15:46:34,822 DEBUG [org.hibernate.loader.Loader] done entity load
| 2007-01-02 15:46:34,822 DEBUG [org.jbpm.bpel.relation.jms.RelationContext] initialized partner reference: instance=org.jbpm.bpel.service.exe.PartnerLinkInstance at 1620d92[name=SchufaLink,id=0], reference=org.jbpm.bpel.service.exe.wsa.WsaEndpointReference at 1110f31[address=http://localhost:8081/creditprocess/schufa,portType={urn:samples:schufa}SchufaWS,service={urn:samples:schufa}SchufaWSService]
| 2007-01-02 15:46:34,992 DEBUG [org.jboss.ws.server.ServiceEndpoint] WSDL request, using host: milaine
| 2007-01-02 15:46:35,032 DEBUG [org.jboss.ws.server.WSDLRequestHandler] Mapping import from 'schufa.wsdl' to 'http://milaine:8080/schufa/schufaWS?wsdl&resource=schufa.wsdl'
| 2007-01-02 15:46:35,032 DEBUG [org.jboss.ws.server.WSDLRequestHandler] Mapping address from 'http://milaine:8080/schufa/schufaWS' to 'http://milaine:8080/schufa/schufaWS'
| 2007-01-02 15:46:35,112 DEBUG [org.jboss.ws.server.ServiceEndpoint] WSDL request, using host: milaine
| 2007-01-02 15:46:35,162 DEBUG [org.jbpm.bpel.relation.jms.RelationContext] selected partner port: instance=org.jbpm.bpel.service.exe.PartnerLinkInstance at 1620d92[name=SchufaLink,id=0], port=SchufaPort
| 2007-01-02 15:46:35,182 INFO [STDOUT] PortConsumer: AddresseLocation configure to: http://milaine:8080/schufa/schufaWS
| 2007-01-02 15:46:35,182 INFO [STDOUT] PortConsumer: Swapping URL-Address to :http://127.0.0.1:8081/creditprocess/schufa
| 2007-01-02 15:46:35,182 DEBUG [org.hibernate.impl.SessionImpl] initializing proxy: [org.jbpm.bpel.wsdl.impl.OperationImpl#62]
| 2007-01-02 15:46:35,182 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Cache lookup: org.jbpm.bpel.wsdl.impl.OperationImpl#62
| 2007-01-02 15:46:35,182 DEBUG [org.hibernate.cache.EhCache] key: org.jbpm.bpel.wsdl.impl.OperationImpl#62
| 2007-01-02 15:46:35,182 DEBUG [org.hibernate.cache.EhCache] Element for org.jbpm.bpel.wsdl.impl.OperationImpl#62 is null
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Cache miss
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.loader.Loader] loading entity: [org.jbpm.bpel.wsdl.impl.OperationImpl#62]
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.SQL] select operationi0_.id as id60_0_, operationi0_.NAME_ as NAME2_60_0_, operationi0_.STYLE_ as STYLE3_60_0_, operationi0_.INPUT_ as INPUT4_60_0_, operationi0_.OUTPUT_ as OUTPUT5_60_0_ from WSDL_OPERATION operationi0_ where operationi0_.id=?
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open ResultSet (open ResultSets: 0, globally: 0)
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[org.jbpm.bpel.wsdl.impl.OperationImpl#62]
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close ResultSet (open ResultSets: 1, globally: 1)
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [org.jbpm.bpel.wsdl.impl.OperationImpl#62]
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.engine.TwoPhaseLoad] adding entity to second-level cache: [org.jbpm.bpel.wsdl.impl.OperationImpl#62]
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Caching: org.jbpm.bpel.wsdl.impl.OperationImpl#62
| 2007-01-02 15:46:35,192 DEBUG [net.sf.ehcache.Cache] org.jbpm.bpel.wsdl.impl.OperationImpl: Is element with key org.jbpm.bpel.wsdl.impl.OperationImpl#61 expired?: false
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [org.jbpm.bpel.wsdl.impl.OperationImpl#62]
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.engine.StatefulPersistenceContext] initializing non-lazy collections
| 2007-01-02 15:46:35,192 DEBUG [org.hibernate.loader.Loader] done entity load
| 2007-01-02 15:46:35,192 DEBUG [org.jbpm.bpel.relation.jms.JmsRelationService] invoking: partnerLink=43, operation=validCustomer, input={_surname=[_surname: null], _firstname=[_firstname: null]}
| 2007-01-02 15:46:35,223 INFO [STDOUT] PortConsumer: Builded SOAPMessage: org.jboss.ws.soap.SOAPMessageImpl at 5e305f
| 2007-01-02 15:46:35,383 DEBUG [org.jboss.ws.soap.SOAPConnectionImpl] Get locator for: http://127.0.0.1:8081/creditprocess/schufa
| 2007-01-02 15:46:35,673 DEBUG [org.jboss.remoting.Client] invoke called, but our invoker is disconnected, discarding and fetching another fresh invoker for: InvokerLocator [http://127.0.0.1:8081/creditprocess/schufa]
| 2007-01-02 15:46:35,683 DEBUG [org.jboss.remoting.transport.http.HTTPClientInvoker] connect called for: org.jboss.remoting.transport.http.HTTPClientInvoker at 142db11
| 2007-01-02 15:46:35,683 DEBUG [org.jboss.remoting.transport.http.HTTPClientInvoker] Setting request header with SOAPAction : "urn:samples:schufa:validCustomer"
| 2007-01-02 15:46:35,683 DEBUG [org.jboss.remoting.transport.http.HTTPClientInvoker] Setting request header with Content-Type : text/xml; charset=UTF-8
| 2007-01-02 15:46:59,007 INFO [STDOUT]
|
| ================================================
| 2007-01-02 15:46:59,027 INFO [STDOUT] Schufa web service : Start method validCustomer
| 2007-01-02 15:46:59,147 INFO [STDOUT] Schufa web service : End method validCustomer
| 2007-01-02 15:46:59,147 INFO [STDOUT] ==============================================
|
| 2007-01-02 15:46:59,437 DEBUG [org.jboss.ws.binding.soap.SOAPMessageUnMarshaller] getMimeHeaders from: {Content-Length=[399], X-Powered-By=[Servlet 2.4; JBoss-4.0.4.GA (build: CVSTag=JBoss_4_0_4_GA date=200605151000)/Tomcat-5.5], ResponseCodeMessage=OK, null=[HTTP/1.1 200 OK], Date=[Tue, 02 Jan 2007 14:46:59 GMT], Content-Type=[text/xml;charset=utf-8], Server=[Apache-Coyote/1.1], HEADER={SOAPAction="urn:samples:schufa:validCustomer", Content-Type=text/xml; charset=UTF-8}, ResponseCode=200}
| 2007-01-02 15:46:59,768 DEBUG [org.jboss.ws.soap.MessageFactoryImpl] createMessage: [contentType=text/xml; charset=utf-8]
| 2007-01-02 15:46:59,788 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Cache lookup: org.jbpm.graph.def.Node.exceptionHandlers#341
| 2007-01-02 15:46:59,788 DEBUG [org.hibernate.cache.EhCache] key: org.jbpm.graph.def.Node.exceptionHandlers#341
| 2007-01-02 15:46:59,788 DEBUG [org.hibernate.cache.EhCache] Element for org.jbpm.graph.def.Node.exceptionHandlers#341 is null
| 2007-01-02 15:46:59,788 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Cache miss
| 2007-01-02 15:46:59,788 DEBUG [org.hibernate.loader.Loader] loading collection: [org.jbpm.graph.def.Node.exceptionHandlers#341]
| 2007-01-02 15:46:59,788 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
| 2007-01-02 15:46:59,788 DEBUG [org.hibernate.SQL] select exceptionh0_.NODE_ as NODE9_1_, exceptionh0_.ID_ as ID1_1_, exceptionh0_.GRAPHELEMENTINDEX_ as GRAPHELE6_1_, exceptionh0_.ID_ as ID1_3_0_, exceptionh0_.EXCEPTIONCLASSNAME_ as EXCEPTIO2_3_0_, exceptionh0_.TYPE_ as TYPE3_3_0_, exceptionh0_.GRAPHELEMENT_ as GRAPHELE4_3_0_ from JBPM_EXCEPTIONHANDLER exceptionh0_ where exceptionh0_.NODE_=?
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open ResultSet (open ResultSets: 0, globally: 0)
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.loader.Loader] result set contains (possibly empty) collection: [org.jbpm.graph.def.Node.exceptionHandlers#341]
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close ResultSet (open ResultSets: 1, globally: 1)
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections were found in result set for role: org.jbpm.graph.def.Node.exceptionHandlers
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.engine.CollectionLoadContext] Caching collection: [org.jbpm.graph.def.Node.exceptionHandlers#341]
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Caching: org.jbpm.graph.def.Node.exceptionHandlers#341
| 2007-01-02 15:46:59,818 DEBUG [net.sf.ehcache.Cache] org.jbpm.graph.def.Node.exceptionHandlers: Is element with key org.jbpm.graph.def.Node.exceptionHandlers#341 expired?: false
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.engine.CollectionLoadContext] collection fully initialized: [org.jbpm.graph.def.Node.exceptionHandlers#341]
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections initialized for role: org.jbpm.graph.def.Node.exceptionHandlers
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.engine.StatefulPersistenceContext] initializing non-lazy collections
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.loader.Loader] done loading collection
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Cache lookup: org.jbpm.graph.def.Node.exceptionHandlers#336
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.cache.EhCache] key: org.jbpm.graph.def.Node.exceptionHandlers#336
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.cache.EhCache] Element for org.jbpm.graph.def.Node.exceptionHandlers#336 is null
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Cache miss
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.loader.Loader] loading collection: [org.jbpm.graph.def.Node.exceptionHandlers#336]
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
| 2007-01-02 15:46:59,818 DEBUG [org.hibernate.SQL] select exceptionh0_.NODE_ as NODE9_1_, exceptionh0_.ID_ as ID1_1_, exceptionh0_.GRAPHELEMENTINDEX_ as GRAPHELE6_1_, exceptionh0_.ID_ as ID1_3_0_, exceptionh0_.EXCEPTIONCLASSNAME_ as EXCEPTIO2_3_0_, exceptionh0_.TYPE_ as TYPE3_3_0_, exceptionh0_.GRAPHELEMENT_ as GRAPHELE4_3_0_ from JBPM_EXCEPTIONHANDLER exceptionh0_ where exceptionh0_.NODE_=?
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open ResultSet (open ResultSets: 0, globally: 0)
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.loader.Loader] result set contains (possibly empty) collection: [org.jbpm.graph.def.Node.exceptionHandlers#336]
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close ResultSet (open ResultSets: 1, globally: 1)
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections were found in result set for role: org.jbpm.graph.def.Node.exceptionHandlers
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.engine.CollectionLoadContext] Caching collection: [org.jbpm.graph.def.Node.exceptionHandlers#336]
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Caching: org.jbpm.graph.def.Node.exceptionHandlers#336
| 2007-01-02 15:46:59,828 DEBUG [net.sf.ehcache.Cache] org.jbpm.graph.def.Node.exceptionHandlers: Is element with key org.jbpm.graph.def.Node.exceptionHandlers#341 expired?: false
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.engine.CollectionLoadContext] collection fully initialized: [org.jbpm.graph.def.Node.exceptionHandlers#336]
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections initialized for role: org.jbpm.graph.def.Node.exceptionHandlers
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.engine.StatefulPersistenceContext] initializing non-lazy collections
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.loader.Loader] done loading collection
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Cache lookup: org.jbpm.graph.def.Node.exceptionHandlers#335
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.cache.EhCache] key: org.jbpm.graph.def.Node.exceptionHandlers#335
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.cache.EhCache] Element for org.jbpm.graph.def.Node.exceptionHandlers#335 is null
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Cache miss
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.loader.Loader] loading collection: [org.jbpm.graph.def.Node.exceptionHandlers#335]
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.SQL] select exceptionh0_.NODE_ as NODE9_1_, exceptionh0_.ID_ as ID1_1_, exceptionh0_.GRAPHELEMENTINDEX_ as GRAPHELE6_1_, exceptionh0_.ID_ as ID1_3_0_, exceptionh0_.EXCEPTIONCLASSNAME_ as EXCEPTIO2_3_0_, exceptionh0_.TYPE_ as TYPE3_3_0_, exceptionh0_.GRAPHELEMENT_ as GRAPHELE4_3_0_ from JBPM_EXCEPTIONHANDLER exceptionh0_ where exceptionh0_.NODE_=?
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open ResultSet (open ResultSets: 0, globally: 0)
| 2007-01-02 15:46:59,828 DEBUG [org.hibernate.loader.Loader] result set contains (possibly empty) collection: [org.jbpm.graph.def.Node.exceptionHandlers#335]
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.loader.Loader] result row: EntityKey[org.jbpm.graph.def.ExceptionHandler#25]
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.loader.Loader] found row of collection: [org.jbpm.graph.def.Node.exceptionHandlers#335]
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close ResultSet (open ResultSets: 1, globally: 1)
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.engine.TwoPhaseLoad] resolving associations for [org.jbpm.graph.def.ExceptionHandler#25]
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.engine.TwoPhaseLoad] adding entity to second-level cache: [org.jbpm.graph.def.ExceptionHandler#25]
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Caching: org.jbpm.graph.def.ExceptionHandler#25
| 2007-01-02 15:46:59,838 DEBUG [net.sf.ehcache.Cache] org.jbpm.graph.def.ExceptionHandler: Is element with key org.jbpm.graph.def.ExceptionHandler#25 expired?: false
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.engine.TwoPhaseLoad] done materializing entity [org.jbpm.graph.def.ExceptionHandler#25]
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections were found in result set for role: org.jbpm.graph.def.Node.exceptionHandlers
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.engine.CollectionLoadContext] Caching collection: [org.jbpm.graph.def.Node.exceptionHandlers#335]
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Caching: org.jbpm.graph.def.Node.exceptionHandlers#335
| 2007-01-02 15:46:59,838 DEBUG [net.sf.ehcache.Cache] org.jbpm.graph.def.Node.exceptionHandlers: Is element with key org.jbpm.graph.def.Node.exceptionHandlers#341 expired?: false
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.engine.CollectionLoadContext] collection fully initialized: [org.jbpm.graph.def.Node.exceptionHandlers#335]
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections initialized for role: org.jbpm.graph.def.Node.exceptionHandlers
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.engine.StatefulPersistenceContext] initializing non-lazy collections
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.loader.Loader] done loading collection
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Cache lookup: org.jbpm.graph.def.ProcessDefinition.exceptionHandlers#21
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.cache.EhCache] key: org.jbpm.graph.def.ProcessDefinition.exceptionHandlers#21
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.cache.EhCache] Element for org.jbpm.graph.def.ProcessDefinition.exceptionHandlers#21 is null
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Cache miss
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.loader.Loader] loading collection: [org.jbpm.graph.def.ProcessDefinition.exceptionHandlers#21]
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
| 2007-01-02 15:46:59,838 DEBUG [org.hibernate.SQL] select exceptionh0_.PROCESSDEFINITION_ as PROCESSD8_1_, exceptionh0_.ID_ as ID1_1_, exceptionh0_.GRAPHELEMENTINDEX_ as GRAPHELE6_1_, exceptionh0_.ID_ as ID1_3_0_, exceptionh0_.EXCEPTIONCLASSNAME_ as EXCEPTIO2_3_0_, exceptionh0_.TYPE_ as TYPE3_3_0_, exceptionh0_.GRAPHELEMENT_ as GRAPHELE4_3_0_ from JBPM_EXCEPTIONHANDLER exceptionh0_ where exceptionh0_.PROCESSDEFINITION_=?
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open ResultSet (open ResultSets: 0, globally: 0)
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.loader.Loader] result set contains (possibly empty) collection: [org.jbpm.graph.def.ProcessDefinition.exceptionHandlers#21]
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close ResultSet (open ResultSets: 1, globally: 1)
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections were found in result set for role: org.jbpm.graph.def.ProcessDefinition.exceptionHandlers
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.engine.CollectionLoadContext] Caching collection: [org.jbpm.graph.def.ProcessDefinition.exceptionHandlers#21]
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Caching: org.jbpm.graph.def.ProcessDefinition.exceptionHandlers#21
| 2007-01-02 15:46:59,848 DEBUG [net.sf.ehcache.Cache] org.jbpm.graph.def.ProcessDefinition.exceptionHandlers: Is element with key org.jbpm.graph.def.ProcessDefinition.exceptionHandlers#21 expired?: false
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.engine.CollectionLoadContext] collection fully initialized: [org.jbpm.graph.def.ProcessDefinition.exceptionHandlers#21]
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections initialized for role: org.jbpm.graph.def.ProcessDefinition.exceptionHandlers
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.engine.StatefulPersistenceContext] initializing non-lazy collections
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.loader.Loader] done loading collection
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Cache lookup: org.jbpm.graph.def.Node.exceptionHandlers#340
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.cache.EhCache] key: org.jbpm.graph.def.Node.exceptionHandlers#340
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.cache.EhCache] Element for org.jbpm.graph.def.Node.exceptionHandlers#340 is null
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Cache miss
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.loader.Loader] loading collection: [org.jbpm.graph.def.Node.exceptionHandlers#340]
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
| 2007-01-02 15:46:59,848 DEBUG [org.hibernate.SQL] select exceptionh0_.NODE_ as NODE9_1_, exceptionh0_.ID_ as ID1_1_, exceptionh0_.GRAPHELEMENTINDEX_ as GRAPHELE6_1_, exceptionh0_.ID_ as ID1_3_0_, exceptionh0_.EXCEPTIONCLASSNAME_ as EXCEPTIO2_3_0_, exceptionh0_.TYPE_ as TYPE3_3_0_, exceptionh0_.GRAPHELEMENT_ as GRAPHELE4_3_0_ from JBPM_EXCEPTIONHANDLER exceptionh0_ where exceptionh0_.NODE_=?
| 2007-01-02 15:46:59,888 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to open ResultSet (open ResultSets: 0, globally: 0)
| 2007-01-02 15:46:59,888 DEBUG [org.hibernate.loader.Loader] result set contains (possibly empty) collection: [org.jbpm.graph.def.Node.exceptionHandlers#340]
| 2007-01-02 15:46:59,888 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close ResultSet (open ResultSets: 1, globally: 1)
| 2007-01-02 15:46:59,888 DEBUG [org.hibernate.jdbc.AbstractBatcher] about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
| 2007-01-02 15:46:59,888 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections were found in result set for role: org.jbpm.graph.def.Node.exceptionHandlers
| 2007-01-02 15:46:59,888 DEBUG [org.hibernate.engine.CollectionLoadContext] Caching collection: [org.jbpm.graph.def.Node.exceptionHandlers#340]
| 2007-01-02 15:46:59,888 DEBUG [org.hibernate.cache.NonstrictReadWriteCache] Caching: org.jbpm.graph.def.Node.exceptionHandlers#340
| 2007-01-02 15:46:59,888 DEBUG [net.sf.ehcache.Cache] org.jbpm.graph.def.Node.exceptionHandlers: Is element with key org.jbpm.graph.def.Node.exceptionHandlers#341 expired?: false
| 2007-01-02 15:46:59,888 DEBUG [org.hibernate.engine.CollectionLoadContext] collection fully initialized: [org.jbpm.graph.def.Node.exceptionHandlers#340]
| 2007-01-02 15:46:59,888 DEBUG [org.hibernate.engine.CollectionLoadContext] 1 collections initialized for role: org.jbpm.graph.def.Node.exceptionHandlers
| 2007-01-02 15:46:59,888 DEBUG [org.hibernate.engine.StatefulPersistenceContext] initializing non-lazy collections
| 2007-01-02 15:46:59,888 DEBUG [org.hibernate.loader.Loader] done loading collection
| 2007-01-02 15:46:59,888 DEBUG [org.jbpm.bpel.relation.jms.StartListener] caught exception while passing control to process, searching for handler
| org.jbpm.graph.def.DelegationException
| at org.jbpm.graph.def.GraphElement.raiseException(GraphElement.java:349)
| at org.jbpm.graph.def.GraphElement.raiseException(GraphElement.java:343)
| at org.jbpm.graph.def.GraphElement.raiseException(GraphElement.java:343)
| at org.jbpm.graph.def.GraphElement.raiseException(GraphElement.java:343)
| at org.jbpm.bpel.def.Activity.enter(Activity.java:88)
| at org.jbpm.graph.def.Transition.take(Transition.java:119)
| at org.jbpm.graph.def.Node.leave(Node.java:382)
| at org.jbpm.bpel.def.Activity.leave(Activity.java:148)
| at org.jbpm.bpel.def.ProcessInstanceStarter.visit(ProcessInstanceStarter.java:43)
| at org.jbpm.bpel.def.Receive.accept(Receive.java:64)
| at org.jbpm.bpel.def.Receive$$FastClassByCGLIB$$516412f0.invoke()
| at net.sf.cglib.proxy.MethodProxy.invoke(MethodProxy.java:149)
| at org.hibernate.proxy.pojo.cglib.CGLIBLazyInitializer.intercept(CGLIBLazyInitializer.java:163)
| at org.jbpm.bpel.def.Receive$$EnhancerByCGLIB$$7e8cc0f8.accept()
| at org.jbpm.bpel.def.ProcessInstanceStarter.visit(ProcessInstanceStarter.java:82)
| at org.jbpm.bpel.def.Sequence.accept(Sequence.java:84)
| at org.jbpm.bpel.def.ProcessInstanceStarter.visit(ProcessInstanceStarter.java:29)
| at org.jbpm.bpel.def.BpelDefinition.messageReceived(BpelDefinition.java:110)
| at org.jbpm.bpel.relation.jms.StartListener.onMessage(StartListener.java:94)
| at org.jboss.mq.SpyMessageConsumer.run(SpyMessageConsumer.java:694)
| at java.lang.Thread.run(Thread.java:595)
| Caused by: org.jbpm.graph.def.DelegationException
| at org.jbpm.graph.def.GraphElement.raiseException(GraphElement.java:349)
| at org.jbpm.graph.def.GraphElement.raiseException(GraphElement.java:343)
| at org.jbpm.graph.def.GraphElement.raiseException(GraphElement.java:343)
| at org.jbpm.graph.def.GraphElement.raiseException(GraphElement.java:343)
| at org.jbpm.bpel.def.Activity.enter(Activity.java:88)
| at org.jbpm.graph.def.Transition.take(Transition.java:119)
| at org.jbpm.graph.def.Node.leave(Node.java:382)
| at org.jbpm.bpel.def.Activity.leave(Activity.java:148)
| at org.jbpm.bpel.def.Assign.execute(Assign.java:41)
| at org.jbpm.bpel.def.Activity.enter(Activity.java:83)
| ... 16 more
| Caused by: java.lang.NullPointerException
| at org.jbpm.bpel.xml.util.XmlUtil.copyAttributes(XmlUtil.java:520)
| at org.jbpm.bpel.xml.util.XmlUtil.copy(XmlUtil.java:485)
| at org.jbpm.bpel.service.consumer.PortConsumer.readRpcBody(PortConsumer.java:344)
| at org.jbpm.bpel.service.consumer.PortConsumer.readMessage(PortConsumer.java:312)
| at org.jbpm.bpel.service.consumer.PortConsumer.call(PortConsumer.java:106)
| at org.jbpm.bpel.relation.jms.JmsRelationService.invoke(JmsRelationService.java:143)
| at org.jbpm.bpel.def.Invoke.execute(Invoke.java:28)
| at org.jbpm.bpel.def.Activity.enter(Activity.java:83)
| ... 21 more
|
| 2007-01-02 15:47:00,068 DEBUG [org.jbpm.JbpmContext] closing JbpmContext
| 2007-01-02 15:47:00,068 DEBUG [org.jbpm.svc.Services] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService at 59aa86
| 2007-01-02 15:47:00,068 DEBUG [org.jbpm.persistence.db.DbPersistenceService] rolling back hibernate transaction
| 2007-01-02 15:47:00,068 DEBUG [org.hibernate.transaction.JDBCTransaction] rollback
|
|
View the original post : http://www.jboss.com/index.html?module=bb&op=viewtopic&p=3997319#3997319
Reply to the post : http://www.jboss.com/index.html?module=bb&op=posting&mode=reply&p=3997319
More information about the jboss-user
mailing list