[jboss-user] [JBoss jBPM] - fault never reaches catchall

Hello, I wanted to test fault and compensation handlers on jBPM-BPEL so I added 'catchAll' on outer scope and I call 'Throw' at the end of service flow. From the server log it looks like it doesn't fine my fault handler. Here is my BPEL - | <?xml version="1.0" encoding="UTF-8"?> | <!-- | BPEL Process Definition | Edited using ActiveBPEL(tm) Designer Version 2.1.0 (http://www.active-endpoints.com) | --> | <process xmlns="http://schemas.xmlsoap.org/ws/2003/03/business-process/" xmlns:bpws="http://schemas.xmlsoap.org/ws/2003/03/business-process/&... xmlns:ns1="http://www.eclipse.org/alf/schema/EventBase/1" xmlns:ns2="ALFExampleServiceFlow" xmlns:ns3="http://www.eclipse.org/alf/logging" xmlns:xsd="http://www.w3.org/2001/XMLSchema" name="SimpleCompensate" suppressJoinFailure="yes" targetNamespace="http://SimpleCompensate"> | <partnerLinks> | <partnerLink myRole="ALFServiceFlow" name="ALFExampleServiceFlowPL" partnerLinkType="ns2:ALFExampleServiceFlowPL"/> | <partnerLink name="CommonLoggingPL" partnerLinkType="ns2:CommonLoggingPL" partnerRole="CommonLogging"/> | </partnerLinks> | <variables> | <variable messageType="ns1:EventNotice" name="EventNotice"/> | <variable messageType="ns3:logStringRequest" name="logStringRequest"/> | <variable messageType="ns3:logStringResponse" name="logStringResponse"/> | </variables> | <sequence> | <receive createInstance="yes" operation="EventNotice" partnerLink="ALFExampleServiceFlowPL" portType="ns1:ALFServiceFlow" variable="EventNotice"/> | <scope variableAccessSerializable="no"> | <faultHandlers> | <catchAll> | <sequence> | <assign> | <copy> | <from expression=""SimpleCompensate - In Fault Handler""/> | <to part="parameters" query="/ns3:logString/ns3:logMessage" variable="logStringRequest"/> | </copy> | </assign> | <invoke inputVariable="logStringRequest" operation="logString" outputVariable="logStringResponse" partnerLink="CommonLoggingPL" portType="ns3:ALFLoggingService"/> | <compensate/> | </sequence> | </catchAll> | </faultHandlers> | <compensationHandler> | <sequence> | <assign> | <copy> | <from expression=""SimpleCompensate - Outer Compensation - should not run""/> | <to part="parameters" query="/ns3:logString/ns3:logMessage" variable="logStringRequest"/> | </copy> | </assign> | <invoke inputVariable="logStringRequest" operation="logString" outputVariable="logStringResponse" partnerLink="CommonLoggingPL" portType="ns3:ALFLoggingService"/> | </sequence> | </compensationHandler> | <sequence> | | <assign> | <copy> | <from part="EventNotice" query="/EventNotice/ns1:Base/ns1:EventControl/ns1:EmEventId" variable="EventNotice"/> | <to part="parameters" query="/ns3:logString/ns3:eventId" variable="logStringRequest"/> | </copy> | <copy> | <from part="EventNotice" query="/EventNotice/ns1:Base/ns1:EventControl/ns1:ServiceFlowId" variable="EventNotice"/> | <to part="parameters" query="/ns3:logString/ns3:serviceFlowId" variable="logStringRequest"/> | </copy> | <copy> | <from expression=""SimpleCompensate - Outer Work""/> | <to part="parameters" query="/ns3:logString/ns3:logMessage" variable="logStringRequest"/> | </copy> | <copy> | <from expression=""INFO""/> | <to part="parameters" query="/ns3:logString/ns3:logLevel" variable="logStringRequest"/> | </copy> | </assign> | <invoke inputVariable="logStringRequest" operation="logString" outputVariable="logStringResponse" partnerLink="CommonLoggingPL" portType="ns3:ALFLoggingService"/> | <scope variableAccessSerializable="no"> | <compensationHandler> | <sequence> | <assign> | <copy> | <from expression=""SimpleCompensate - Inner Compensation""/> | <to part="parameters" query="/ns3:logString/ns3:logMessage" variable="logStringRequest"/> | </copy> | </assign> | <invoke inputVariable="logStringRequest" operation="logString" outputVariable="logStringResponse" partnerLink="CommonLoggingPL" portType="ns3:ALFLoggingService"/> | </sequence> | </compensationHandler> | <sequence> | <assign> | <copy> | <from expression=""SimpleCompensate - Inner Work""/> | <to part="parameters" query="/ns3:logString/ns3:logMessage" variable="logStringRequest"/> | </copy> | </assign> | <invoke inputVariable="logStringRequest" operation="logString" outputVariable="logStringResponse" partnerLink="CommonLoggingPL" portType="ns3:ALFLoggingService"/> | </sequence> | </scope> | <throw faultName="SimpleCompensateExampleFault"/> | </sequence> | </scope> | </sequence> | </process> | Here is the server log | 2007-03-08 13:28:05,560 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-leave' on 'Receive(606f26)' for 'Token(/primary)' | 2007-03-08 13:28:05,560 DEBUG [org.jbpm.graph.def.GraphElement] event 'transition' on 'Transition(Receive-StructuredActivity.End)' for 'Token(/primary)' | 2007-03-08 13:28:05,560 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-enter' on 'Scope(121572b)' for 'Token(/primary)' | 2007-03-08 13:28:05,560 DEBUG [org.jbpm.bpel.graph.exe.ScopeInstance] state change to 'performingPrimaryActivity' on 'Scope(121572b)' for 'Token(/primary/null)' | 2007-03-08 13:28:05,560 DEBUG [org.jbpm.context.exe.VariableContainer] create variable 's:instance' in 'TokenVariableMap826a5f' with value 'org.jbpm.bpel.graph.exe.ScopeInstance@15b26b[name=<null>,token=/primary/null,state=performingPrimaryActivity,id=0]' | 2007-03-08 13:28:05,570 WARN [org.hibernate.engine.StatefulPersistenceContext.ProxyWarnLog] Narrowing proxy to class org.jbpm.bpel.graph.def.CompositeActivity - this operation breaks == | 2007-03-08 13:28:05,570 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-enter' on 'StructuredActivity$Begin(127751c)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:05,570 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-leave' on 'StructuredActivity$Begin(127751c)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:05,570 DEBUG [org.jbpm.graph.def.GraphElement] event 'transition' on 'Transition(StructuredActivity.Begin-Assign)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:05,570 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-enter' on 'Assign(11452f4)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:05,570 DEBUG [org.jbpm.bpel.graph.basic.Assign] copying: token=Token(/primary/null/primary), value=[ns:EmEventId: null] | 2007-03-08 13:28:05,570 DEBUG [org.jbpm.bpel.graph.basic.Assign] copying: token=Token(/primary/null/primary), value=[ns:ServiceFlowId: null] | 2007-03-08 13:28:05,580 DEBUG [org.jbpm.bpel.graph.basic.Assign] copying: token=Token(/primary/null/primary), value=SimpleCompensate - Outer Work | 2007-03-08 13:28:05,580 DEBUG [org.jbpm.bpel.graph.basic.Assign] copying: token=Token(/primary/null/primary), value=INFO | 2007-03-08 13:28:05,580 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-leave' on 'Assign(11452f4)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:05,580 DEBUG [org.jbpm.graph.def.GraphElement] event 'transition' on 'Transition(Assign-StructuredActivity.End)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:05,580 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-enter' on 'Invoke(111a76c)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:05,580 DEBUG [org.jbpm.bpel.integration.jms.IntegrationControl] initialized partner reference: instance=org.jbpm.bpel.integration.exe.PartnerLinkInstance@113e259[name=CommonLoggingPL,id=268], reference=org.jbpm.bpel.endpointref.wsa.WsaEndpointReference@1123d8b[address=<null>,portType={http://www.eclipse.org/alf/logging}ALFLoggingService] | 2007-03-08 13:28:05,580 DEBUG [org.jbpm.bpel.integration.catalog.URLCatalog] found candidate service: name={http://www.eclipse.org/alf/logging}ALFLoggingService, definitionURI=file:/D:/jboss-4.0.5.ejb3/build/output/jboss-4.0.5.GA-ejb3/server/default/tmp/deploy/tmp10243simplecompensate-exp.war/WEB-INF/wsdl/WSDL/ALFLoggingService.wsdl, portType={http://www.eclipse.org/alf/logging}ALFLoggingService | 2007-03-08 13:28:05,580 DEBUG [org.jbpm.bpel.endpointref.SoapEndpointReference] found candidate port: name=ALFLoggingService, address=http://localhost:8085/ALFEventManager/services/ALFLoggingService, service={http://www.eclipse.org/alf/logging}ALFLoggingService, portType={http://www.eclipse.org/alf/logging}ALFLoggingService | 2007-03-08 13:28:05,580 DEBUG [org.jbpm.bpel.integration.jms.IntegrationControl] selected partner port: instance=org.jbpm.bpel.integration.exe.PartnerLinkInstance@113e259[name=CommonLoggingPL,id=268], port=ALFLoggingService | 2007-03-08 13:28:05,630 DEBUG [javax.xml.soap.FactoryLoader] Load from Service API META-INF/services/javax.xml.soap.MessageFactory: org.jboss.ws.core.soap.MessageFactoryImpl | 2007-03-08 13:28:05,630 DEBUG [org.jboss.ws.core.soap.SOAPConnectionImpl] Get locator for: http://localhost:8085/ALFEventManager/services/ALFLoggingService | 2007-03-08 13:28:05,630 DEBUG [org.jboss.remoting.transport.http.HTTPClientInvoker] connect called for: org.jboss.remoting.transport.http.HTTPClientInvoker@1cf1934 | 2007-03-08 13:28:05,630 TRACE [jbossws.SOAPMessage] Remoting meta data: {HEADER={SOAPAction="", Content-Type=text/xml; charset=UTF-8}, NoThrowOnError=true} | 2007-03-08 13:28:05,630 TRACE [jbossws.SOAPMessage] Outgoing SOAPMessage | <env:Envelope xmlns:env='http://schemas.xmlsoap.org/soap/envelope/'> | <env:Header/> | <env:Body> | <defaultNS:logString xmlns:defaultNS='http://www.eclipse.org/alf/logging'> | <ns3:eventId xmlns:ns='http://www.eclipse.org/alf/schema/EventBase/1' xmlns:ns3='http://www.eclipse.org/alf/logging' xmlns:soapenv='http://schemas.xmlsoap.org/soap/envelope/'>34&l... | <ns3:serviceFlowId xmlns:ns='http://www.eclipse.org/alf/schema/EventBase/1' xmlns:ns3='http://www.eclipse.org/alf/logging' xmlns:soapenv='http://schemas.xmlsoap.org/soap/envelope/'>3543... | <ns3:logMessage xmlns:ns3='http://www.eclipse.org/alf/logging'>SimpleCompensate - Outer Work</ns3:logMessage> | <ns3:logLevel xmlns:ns3='http://www.eclipse.org/alf/logging'>INFO</ns3:lo... | </defaultNS:logString> | </env:Body> | </env:Envelope> | 2007-03-08 13:28:05,630 DEBUG [org.jboss.remoting.transport.http.HTTPClientInvoker] Setting request header with SOAPAction : "" | 2007-03-08 13:28:05,630 DEBUG [org.jboss.remoting.transport.http.HTTPClientInvoker] Setting request header with Content-Type : text/xml; charset=UTF-8 | 2007-03-08 13:28:07,162 DEBUG [org.jboss.ws.core.soap.SOAPMessageUnMarshaller] getMimeHeaders from: {ResponseCodeMessage=OK, null=[HTTP/1.1 200 OK], Date=[Thu, 08 Mar 2007 21:28:07 GMT], Content-Type=[text/xml;charset=utf-8], Server=[Apache-Coyote/1.1], HEADER={SOAPAction="", Content-Type=text/xml; charset=UTF-8}, Transfer-Encoding=[chunked], NoThrowOnError=true, ResponseCode=200} | 2007-03-08 13:28:07,162 DEBUG [org.jboss.ws.core.soap.MessageFactoryImpl] createMessage: [contentType=text/xml; charset=utf-8] | 2007-03-08 13:28:07,162 DEBUG [org.jboss.remoting.transport.http.HTTPClientInvoker] disconnect called for: org.jboss.remoting.transport.http.HTTPClientInvoker@1cf1934 | 2007-03-08 13:28:07,162 DEBUG [org.jboss.remoting.InvokerRegistry] destroying client for locator: InvokerLocator [http://127.0.0.1:8085/ALFEventManager/services/ALFLoggingService?datatype...], invoker:org.jboss.remoting.transport.http.HTTPClientInvoker@1cf1934, remaining list:{} | 2007-03-08 13:28:07,162 DEBUG [org.jboss.remoting.InvokerRegistry] destroying client for locator: InvokerLocator [http://127.0.0.1:8085/ALFEventManager/services/ALFLoggingService?datatype...], invoker:null, remaining list:{} | 2007-03-08 13:28:07,162 TRACE [jbossws.SOAPMessage] Incoming Response SOAPMessage | <soapenv:Envelope xmlns:soapenv='http://schemas.xmlsoap.org/soap/envelope/' xmlns:xsd='http://www.w3.org/2001/XMLSchema' xmlns:xsi='http://www.w3.org/2001/XMLSchema-instance'> | <soapenv:Header> | <Dummy soapenv:actor='http://schemas.xmlsoap.org/soap/actor/next' soapenv:mustUnderstand='0' xmlns=''/> | </soapenv:Header> | <soapenv:Body> | <logStringResponse xmlns='http://www.eclipse.org/alf/logging'/> | </soapenv:Body> | </soapenv:Envelope> | 2007-03-08 13:28:07,162 DEBUG [org.jbpm.bpel.integration.jms.JmsIntegrationService] invoked: partnerLink=CommonLoggingPL, operation=logString, output={parameters=[defaultNS:logStringResponse: null]} | 2007-03-08 13:28:07,162 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-leave' on 'Invoke(111a76c)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:07,172 DEBUG [org.jbpm.graph.def.GraphElement] event 'transition' on 'Transition(Invoke-StructuredActivity.End)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:07,172 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-enter' on 'Scope(21be6)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:07,172 DEBUG [org.jbpm.bpel.graph.exe.ScopeInstance] state change to 'performingPrimaryActivity' on 'Scope(21be6)' for 'Token(/primary/null/primary/null)' | 2007-03-08 13:28:07,172 DEBUG [org.jbpm.context.exe.VariableContainer] create variable 's:instance' in 'TokenVariableMap1245c4f' with value 'org.jbpm.bpel.graph.exe.ScopeInstance@28785c[name=<null>,token=/primary/null/primary/null,state=performingPrimaryActivity,id=0]' | 2007-03-08 13:28:07,172 WARN [org.hibernate.engine.StatefulPersistenceContext.ProxyWarnLog] Narrowing proxy to class org.jbpm.bpel.graph.def.CompositeActivity - this operation breaks == | 2007-03-08 13:28:07,172 WARN [org.hibernate.engine.StatefulPersistenceContext.ProxyWarnLog] Narrowing proxy to class org.jbpm.bpel.graph.def.CompositeActivity - this operation breaks == | 2007-03-08 13:28:07,172 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-enter' on 'StructuredActivity$Begin(9112ad)' for 'Token(/primary/null/primary/null/primary)' | 2007-03-08 13:28:07,172 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-leave' on 'StructuredActivity$Begin(9112ad)' for 'Token(/primary/null/primary/null/primary)' | 2007-03-08 13:28:07,172 DEBUG [org.jbpm.graph.def.GraphElement] event 'transition' on 'Transition(StructuredActivity.Begin-Assign)' for 'Token(/primary/null/primary/null/primary)' | 2007-03-08 13:28:07,172 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-enter' on 'Assign(8a0152)' for 'Token(/primary/null/primary/null/primary)' | 2007-03-08 13:28:07,182 DEBUG [org.jbpm.bpel.graph.basic.Assign] copying: token=Token(/primary/null/primary/null/primary), value=SimpleCompensate - Inner Work | 2007-03-08 13:28:07,182 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-leave' on 'Assign(8a0152)' for 'Token(/primary/null/primary/null/primary)' | 2007-03-08 13:28:07,182 DEBUG [org.jbpm.graph.def.GraphElement] event 'transition' on 'Transition(Assign-StructuredActivity.End)' for 'Token(/primary/null/primary/null/primary)' | 2007-03-08 13:28:07,182 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-enter' on 'Invoke(1f8a98)' for 'Token(/primary/null/primary/null/primary)' | 2007-03-08 13:28:07,182 DEBUG [javax.xml.soap.FactoryLoader] Load from Service API META-INF/services/javax.xml.soap.MessageFactory: org.jboss.ws.core.soap.MessageFactoryImpl | 2007-03-08 13:28:07,222 DEBUG [org.jboss.ws.core.soap.SOAPConnectionImpl] Get locator for: http://localhost:8085/ALFEventManager/services/ALFLoggingService | 2007-03-08 13:28:07,222 DEBUG [org.jboss.remoting.transport.http.HTTPClientInvoker] connect called for: org.jboss.remoting.transport.http.HTTPClientInvoker@11c7571 | 2007-03-08 13:28:07,222 TRACE [jbossws.SOAPMessage] Remoting meta data: {HEADER={SOAPAction="", Content-Type=text/xml; charset=UTF-8}, NoThrowOnError=true} | 2007-03-08 13:28:07,222 TRACE [jbossws.SOAPMessage] Outgoing SOAPMessage | <env:Envelope xmlns:env='http://schemas.xmlsoap.org/soap/envelope/'> | <env:Header/> | <env:Body> | <defaultNS:logString xmlns:defaultNS='http://www.eclipse.org/alf/logging'> | <ns3:eventId xmlns:ns='http://www.eclipse.org/alf/schema/EventBase/1' xmlns:ns3='http://www.eclipse.org/alf/logging' xmlns:soapenv='http://schemas.xmlsoap.org/soap/envelope/'>34&l... | <ns3:serviceFlowId xmlns:ns='http://www.eclipse.org/alf/schema/EventBase/1' xmlns:ns3='http://www.eclipse.org/alf/logging' xmlns:soapenv='http://schemas.xmlsoap.org/soap/envelope/'>3543... | <ns3:logMessage xmlns:ns3='http://www.eclipse.org/alf/logging'>SimpleCompensate - Inner Work</ns3:logMessage> | <ns3:logLevel xmlns:ns3='http://www.eclipse.org/alf/logging'>INFO</ns3:lo... | </defaultNS:logString> | </env:Body> | </env:Envelope> | 2007-03-08 13:28:07,222 DEBUG [org.jboss.remoting.transport.http.HTTPClientInvoker] Setting request header with SOAPAction : "" | 2007-03-08 13:28:07,222 DEBUG [org.jboss.remoting.transport.http.HTTPClientInvoker] Setting request header with Content-Type : text/xml; charset=UTF-8 | 2007-03-08 13:28:07,693 DEBUG [org.jboss.ws.core.soap.SOAPMessageUnMarshaller] getMimeHeaders from: {ResponseCodeMessage=OK, null=[HTTP/1.1 200 OK], Date=[Thu, 08 Mar 2007 21:28:07 GMT], Content-Type=[text/xml;charset=utf-8], Server=[Apache-Coyote/1.1], HEADER={SOAPAction="", Content-Type=text/xml; charset=UTF-8}, Transfer-Encoding=[chunked], NoThrowOnError=true, ResponseCode=200} | 2007-03-08 13:28:07,693 DEBUG [org.jboss.ws.core.soap.MessageFactoryImpl] createMessage: [contentType=text/xml; charset=utf-8] | 2007-03-08 13:28:07,693 DEBUG [org.jboss.remoting.transport.http.HTTPClientInvoker] disconnect called for: org.jboss.remoting.transport.http.HTTPClientInvoker@11c7571 | 2007-03-08 13:28:07,693 DEBUG [org.jboss.remoting.InvokerRegistry] destroying client for locator: InvokerLocator [http://127.0.0.1:8085/ALFEventManager/services/ALFLoggingService?datatype...], invoker:org.jboss.remoting.transport.http.HTTPClientInvoker@11c7571, remaining list:{} | 2007-03-08 13:28:07,693 DEBUG [org.jboss.remoting.InvokerRegistry] destroying client for locator: InvokerLocator [http://127.0.0.1:8085/ALFEventManager/services/ALFLoggingService?datatype...], invoker:null, remaining list:{} | 2007-03-08 13:28:07,693 TRACE [jbossws.SOAPMessage] Incoming Response SOAPMessage | <soapenv:Envelope xmlns:soapenv='http://schemas.xmlsoap.org/soap/envelope/' xmlns:xsd='http://www.w3.org/2001/XMLSchema' xmlns:xsi='http://www.w3.org/2001/XMLSchema-instance'> | <soapenv:Header> | <Dummy soapenv:actor='http://schemas.xmlsoap.org/soap/actor/next' soapenv:mustUnderstand='0' xmlns=''/> | </soapenv:Header> | <soapenv:Body> | <logStringResponse xmlns='http://www.eclipse.org/alf/logging'/> | </soapenv:Body> | </soapenv:Envelope> | 2007-03-08 13:28:07,693 DEBUG [org.jbpm.bpel.integration.jms.JmsIntegrationService] invoked: partnerLink=CommonLoggingPL, operation=logString, output={parameters=[defaultNS:logStringResponse: null]} | 2007-03-08 13:28:07,693 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-leave' on 'Invoke(1f8a98)' for 'Token(/primary/null/primary/null/primary)' | 2007-03-08 13:28:07,693 DEBUG [org.jbpm.graph.def.GraphElement] event 'transition' on 'Transition(Invoke-StructuredActivity.End)' for 'Token(/primary/null/primary/null/primary)' | 2007-03-08 13:28:07,693 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-enter' on 'StructuredActivity$End(182c145)' for 'Token(/primary/null/primary/null/primary)' | 2007-03-08 13:28:07,693 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-leave' on 'StructuredActivity$End(182c145)' for 'Token(/primary/null/primary/null/primary)' | 2007-03-08 13:28:07,693 DEBUG [org.jbpm.bpel.graph.exe.ScopeInstance] state change to 'completed' on 'Scope(21be6)' for 'Token(/primary/null/primary/null)' | 2007-03-08 13:28:07,693 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-leave' on 'Scope(21be6)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:07,693 DEBUG [org.jbpm.graph.def.GraphElement] event 'transition' on 'Transition(Scope-StructuredActivity.End)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:07,693 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-enter' on 'Throw(116cf35)' for 'Token(/primary/null/primary)' | 2007-03-08 13:28:07,703 DEBUG [org.jbpm.bpel.graph.scope.FaultActionHandler] handling fault: org.jbpm.bpel.graph.exe.ScopeInstance@15b26b[name=<null>,token=/primary/null,state=performingPrimaryActivity,id=0] | org.jbpm.bpel.graph.exe.BpelFaultException: org.jbpm.bpel.graph.exe.FaultInstance@10f5aca[name=SimpleCompensateExampleFault,id=0] | at org.jbpm.bpel.graph.basic.Throw.execute(Throw.java:60) | at org.jbpm.bpel.graph.def.Activity.enter(Activity.java:105) | at sun.reflect.GeneratedMethodAccessor146.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:205) | at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java) | at org.jbpm.graph.def.Transition.take(Transition.java:151) | at org.jbpm.graph.def.Node.leave(Node.java:393) | at org.jbpm.bpel.graph.def.Activity.leave(Activity.java:184) | at org.jbpm.graph.exe.ExecutionContext.leaveNode(ExecutionContext.java:120) | at org.jbpm.bpel.graph.exe.ScopeInstance.notifyCompletion(ScopeInstance.java:338) | at org.jbpm.bpel.graph.exe.state.EndedState.enterCompleted(EndedState.java:62) | at org.jbpm.bpel.graph.exe.state.ActiveState$1.completed(ActiveState.java:35) | at org.jbpm.bpel.graph.exe.ScopeInstance.completed(ScopeInstance.java:145) | at org.jbpm.bpel.graph.def.Activity.leave(Activity.java:203) | 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:205) | at org.jbpm.bpel.graph.struct.StructuredActivity$End_$$_javassist_76.leave(StructuredActivity$End_$$_javassist_76.java) | at org.jbpm.bpel.graph.struct.StructuredActivity.leave(StructuredActivity.java:62) | 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:205) | at org.jbpm.bpel.graph.def.CompositeActivity_$$_javassist_156.leave(CompositeActivity_$$_javassist_156.java) | at org.jbpm.bpel.graph.struct.StructuredActivity$End.execute(StructuredActivity.java:246) | at org.jbpm.bpel.graph.def.Activity.enter(Activity.java:105) | at sun.reflect.GeneratedMethodAccessor148.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:205) | at org.jbpm.bpel.graph.struct.StructuredActivity$End_$$_javassist_76.enter(StructuredActivity$End_$$_javassist_76.java) | at org.jbpm.graph.def.Transition.take(Transition.java:151) | at org.jbpm.graph.def.Node.leave(Node.java:393) | at org.jbpm.bpel.graph.def.Activity.leave(Activity.java:184) | at org.jbpm.bpel.graph.basic.Invoke.execute(Invoke.java:47) | at org.jbpm.bpel.graph.def.Activity.enter(Activity.java:105) | at sun.reflect.GeneratedMethodAccessor146.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:205) | at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java) | at org.jbpm.graph.def.Transition.take(Transition.java:151) | at org.jbpm.graph.def.Node.leave(Node.java:393) | at org.jbpm.bpel.graph.def.Activity.leave(Activity.java:184) | at org.jbpm.bpel.graph.basic.Assign.execute(Assign.java:55) | at org.jbpm.bpel.graph.def.Activity.enter(Activity.java:105) | at sun.reflect.GeneratedMethodAccessor146.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:205) | at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java) | at org.jbpm.graph.def.Transition.take(Transition.java:151) | at org.jbpm.graph.def.Node.leave(Node.java:393) | 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:205) | at org.jbpm.bpel.graph.struct.StructuredActivity$Begin_$$_javassist_9.leave(StructuredActivity$Begin_$$_javassist_9.java) | at org.jbpm.bpel.graph.struct.StructuredActivity.execute(StructuredActivity.java:58) | 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:205) | at org.jbpm.bpel.graph.def.CompositeActivity_$$_javassist_156.execute(CompositeActivity_$$_javassist_156.java) | at org.jbpm.bpel.graph.struct.StructuredActivity$Begin.leave(StructuredActivity.java:222) | at org.jbpm.graph.def.Node.execute(Node.java:349) | at org.jbpm.bpel.graph.def.Activity.enter(Activity.java:105) | at sun.reflect.GeneratedMethodAccessor148.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:205) | at org.jbpm.bpel.graph.struct.StructuredActivity$Begin_$$_javassist_9.enter(StructuredActivity$Begin_$$_javassist_9.java) | at org.jbpm.bpel.graph.struct.StructuredActivity.enter(StructuredActivity.java:54) | at sun.reflect.GeneratedMethodAccessor148.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:205) | at org.jbpm.bpel.graph.def.Activity_$$_javassist_159.enter(Activity_$$_javassist_159.java) | at org.jbpm.bpel.graph.scope.Scope.execute(Scope.java:108) | at org.jbpm.bpel.graph.def.Activity.enter(Activity.java:105) | at sun.reflect.GeneratedMethodAccessor146.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:205) | at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java) | at org.jbpm.graph.def.Transition.take(Transition.java:151) | at org.jbpm.graph.def.Node.leave(Node.java:393) | at org.jbpm.bpel.graph.def.Activity.leave(Activity.java:184) | at org.jbpm.bpel.graph.basic.Invoke.execute(Invoke.java:47) | at org.jbpm.bpel.graph.def.Activity.enter(Activity.java:105) | at sun.reflect.GeneratedMethodAccessor146.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:205) | at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java) | at org.jbpm.graph.def.Transition.take(Transition.java:151) | at org.jbpm.graph.def.Node.leave(Node.java:393) | at org.jbpm.bpel.graph.def.Activity.leave(Activity.java:184) | at org.jbpm.bpel.graph.basic.Assign.execute(Assign.java:55) | at org.jbpm.bpel.graph.def.Activity.enter(Activity.java:105) | at sun.reflect.GeneratedMethodAccessor146.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:205) | at org.jbpm.graph.def.Node_$$_javassist_47.enter(Node_$$_javassist_47.java) | at org.jbpm.graph.def.Transition.take(Transition.java:151) | at org.jbpm.graph.def.Node.leave(Node.java:393) | 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:205) | at org.jbpm.bpel.graph.struct.StructuredActivity$Begin_$$_javassist_9.leave(StructuredActivity$Begin_$$_javassist_9.java) | at org.jbpm.bpel.graph.struct.StructuredActivity.execute(StructuredActivity.java:58) | 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:205) | at org.jbpm.bpel.graph.def.CompositeActivity_$$_javassist_156.execute(CompositeActivity_$$_javassist_156.java) | at org.jbpm.bpel.graph.struct.StructuredActivity$Begin.leave(StructuredActivity.java:222) | at org.jbpm.graph.def.Node.execute(Node.java:349) | at org.jbpm.bpel.graph.def.Activity.enter(Activity.java:105) | at sun.reflect.GeneratedMethodAccessor148.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:205) | at org.jbpm.bpel.graph.struct.StructuredActivity$Begin_$$_javassist_9.enter(StructuredActivity$Begin_$$_javassist_9.java) | at org.jbpm.bpel.graph.struct.StructuredActivity.enter(StructuredActivity.java:54) | at sun.reflect.GeneratedMethodAccessor148.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:205) | at org.jbpm.bpel.graph.def.Activity_$$_javassist_159.enter(Activity_$$_javassist_159.java) | at org.jbpm.bpel.graph.scope.Scope.execute(Scope.java:108) | at org.jbpm.bpel.graph.def.Activity.enter(Activity.java:105) | at org.jbpm.graph.def.Transition.take(Transition.java:151) | at org.jbpm.graph.def.Node.leave(Node.java:393) | at org.jbpm.bpel.graph.def.Activity.leave(Activity.java:184) | at org.jbpm.bpel.graph.struct.ProcessInstanceStarter.visit(ProcessInstanceStarter.java:66) | at org.jbpm.bpel.graph.basic.Receive.accept(Receive.java:81) | 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:205) | at org.jbpm.bpel.graph.basic.Receive_$$_javassist_17.accept(Receive_$$_javassist_17.java) | at org.jbpm.bpel.graph.struct.ProcessInstanceStarter.visit(ProcessInstanceStarter.java:100) | at org.jbpm.bpel.graph.struct.Sequence.accept(Sequence.java:104) | at sun.reflect.GeneratedMethodAccessor139.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:205) | at org.jbpm.bpel.graph.def.Activity_$$_javassist_159.accept(Activity_$$_javassist_159.java) | at org.jbpm.bpel.graph.struct.ProcessInstanceStarter.visit(ProcessInstanceStarter.java:54) | at org.jbpm.bpel.graph.def.BpelDefinition.messageReceived(BpelDefinition.java:111) | at org.jbpm.bpel.integration.jms.StartListener.onMessage(StartListener.java:124) | at org.jboss.mq.SpyMessageConsumer.run(SpyMessageConsumer.java:696) | at java.lang.Thread.run(Thread.java:595) | 2007-03-08 13:28:07,723 DEBUG [org.jbpm.bpel.graph.exe.ScopeInstance] state change to 'terminatingPrimaryActivityOnFault' on 'Scope(121572b)' for 'Token(/primary/null)' | 2007-03-08 13:28:07,733 DEBUG [org.jbpm.bpel.graph.exe.ScopeInstance] state change to 'faultingWithoutHandler' on 'Scope(121572b)' for 'Token(/primary/null)' | 2007-03-08 13:28:07,733 WARN [org.hibernate.engine.StatefulPersistenceContext.ProxyWarnLog] Narrowing proxy to class org.jbpm.bpel.graph.def.Activity - this operation breaks == | 2007-03-08 13:28:07,733 WARN [org.hibernate.engine.StatefulPersistenceContext.ProxyWarnLog] Narrowing proxy to class org.jbpm.bpel.graph.def.Activity - this operation breaks == | 2007-03-08 13:28:07,733 WARN [org.hibernate.engine.StatefulPersistenceContext.ProxyWarnLog] Narrowing proxy to class org.jbpm.bpel.graph.def.Activity - this operation breaks == | 2007-03-08 13:28:07,733 WARN [org.hibernate.engine.StatefulPersistenceContext.ProxyWarnLog] Narrowing proxy to class org.jbpm.bpel.graph.def.Activity - this operation breaks == | 2007-03-08 13:28:07,733 WARN [org.hibernate.engine.StatefulPersistenceContext.ProxyWarnLog] Narrowing proxy to class org.jbpm.bpel.graph.def.Activity - this operation breaks == | 2007-03-08 13:28:07,733 DEBUG [org.jbpm.bpel.graph.exe.ScopeInstance] state change to 'faulted' on 'Scope(121572b)' for 'Token(/primary/null)' | 2007-03-08 13:28:07,733 DEBUG [org.jbpm.bpel.graph.exe.ScopeInstance] state change to 'terminatingPrimaryActivityOnFault' on 'BpelDefinition$GlobalScope(4fa1cd)' for 'Token(/)' | 2007-03-08 13:28:07,733 DEBUG [org.jbpm.bpel.graph.exe.ScopeInstance] state change to 'faultingWithoutHandler' on 'BpelDefinition$GlobalScope(4fa1cd)' for 'Token(/)' | 2007-03-08 13:28:07,773 DEBUG [org.jbpm.bpel.graph.exe.ScopeInstance] state change to 'faulted' on 'BpelDefinition$GlobalScope(4fa1cd)' for 'Token(/)' | 2007-03-08 13:28:07,773 DEBUG [org.jbpm.svc.Services] executing default save operations | Is something wrong with BPEL? This sample is tested on ActiveBPEL and it works there. Thanks, Meghana View the original post : http://www.jboss.com/index.html?module=bb&op=viewtopic&p=4026440#... Reply to the post : http://www.jboss.com/index.html?module=bb&op=posting&mode=reply&a...