You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@ode.apache.org by Michael Dondrup <Mi...@uni.no> on 2009/12/17 16:52:11 UTC

Asynchronous Example fails with ODE 2

Hi,

I appreciate very much the example of asynchronous service invocation given here. I am currently testing this with ODE 2 beta. 
I have successfully deployed both processes in ODE 2 after changing the the SOAP addresses in the wsdls to http://localhost:8080/ode/processes/[....
I call the service at http://localhost:8080/ode/processes/LoanProcessService using SoapUI, then after a few seconds I get an exception back.

Am I doing something wrong and has anybody got this working? Any help is appreciated.

Best
Michael


Request:

<soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://wso2.org/bps/samples/loan_process/schema">
   <soapenv:Header/>
   <soapenv:Body>
      <sch:LoanRequest>
         <sch:CustomerInfo>
            <!--type: string-->
            <sch:Name>gero et</sch:Name>
            <!--type: string-->
            <sch:Email>sonoras imperio</sch:Email>
            <!--type: CustomerIDType-->
            <sch:CustomerID>quae divum incedo</sch:CustomerID>
            <!--type: int-->
            <sch:CreditRating>3</sch:CreditRating>
         </sch:CustomerInfo>
         <sch:LoanInfo>
            <!--type: double-->
            <sch:Amount>1000</sch:Amount>
            <!--type: int-->
            <sch:Years>3</sch:Years>
         </sch:LoanInfo>
      </sch:LoanRequest>
   </soapenv:Body>
</soapenv:Envelope>

Response:
<soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
   <soapenv:Body>
      <soapenv:Fault xmlns:java="java:package org.apache.ode.axis2">
         <faultcode>java:org.apache.ode.axis2.OdeFault</faultcode>
         <faultstring>Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest caused an exception.</faultstring>
         <detail>
            <Exception>org.apache.ode.axis2.OdeFault: Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest caused an exception.
	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:135)
	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:67)
	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:50)
	at org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
	at java.lang.Thread.run(Thread.java:637)
Caused by: org.apache.ode.axis2.OdeFault: Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest timed out.
	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:121)
	... 22 more</Exception>
         </detail>
      </soapenv:Fault>
   </soapenv:Body>
</soapenv:Envelope>

This seems to be the real source of error
ERROR - GeronimoLog.error(108) | 
java.lang.NullPointerException
	at org.apache.ode.axis2.hooks.ODEAxisServiceDispatcher.findService(ODEAxisServiceDispatcher.java:80)
	at org.apache.axis2.engine.AbstractDispatcher.invoke(AbstractDispatcher.java:91)



And here is the complete catalina log of the interaction:


DEBUG - GeronimoLog.debug(66) | The system is checking for the operation using the following WSAAction: 
DEBUG - GeronimoLog.debug(66) | Checking for Operation using SOAP message body's first child's local name : LoanRequest
DEBUG - GeronimoLog.debug(66) | Received request message for LoanProcessService.{http://wso2.org/bps/samples/LoanProcess}laonRequest
DEBUG - GeronimoLog.debug(66) | ODE routed to operation Operation: name=laonRequest
style=REQUEST_RESPONSE,1
Input: name=input
Message: name={http://wso2.org/bps/samples/LoanProcess}laonRequestRequest
Part: name=part
elementName={http://wso2.org/bps/samples/loan_process/schema}LoanRequest
Output: name=output
Message: name={http://wso2.org/bps/samples/LoanProcess}laonRequestResponse
Part: name=part
elementName={http://wso2.org/bps/samples/loan_process/schema}LoanOffer from service {http://wso2.org/bps/samples/LoanProcess}LoanProcessService
DEBUG - GeronimoLog.debug(66) | Invoking ODE using MEX {MyRoleMex#hqejbhcnphr4u55emnjqir [Client null] calling {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)}
DEBUG - GeronimoLog.debug(66) | Message content:  <?xml version="1.0" encoding="UTF-8"?>
<message><part><LoanRequest xmlns="http://wso2.org/bps/samples/loan_process/schema" xmlns:sch="http://wso2.org/bps/samples/loan_process/schema" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
         <CustomerInfo>
            
            <Name>gero et</Name>
            
            <Email>sonoras imperio</Email>
            
            <CustomerID>quae divum incedo</CustomerID>
            
            <CreditRating>3</CreditRating>
         </CustomerInfo>
         <LoanInfo>
            
            <Amount>1000</Amount>
            
            <Years>3</Years>
         </LoanInfo>
      </LoanRequest></part></message>
DEBUG - GeronimoLog.debug(66) | invoke() EPR= null ==> ODEProcess[{http://wso2.org/bps/samples/LoanProcess}LoanProcess-9]
DEBUG - GeronimoLog.debug(66) | INPUTMSG: 42.laonRequest: MSG RCVD keys=[{CorrelationKey setId=41, values=[quae divum incedo]}] mySessionId=null partnerSessionId=null
DEBUG - GeronimoLog.debug(66) | INPUTMSG: 42.laonRequest: routing failed, CREATING NEW INSTANCE
DEBUG - GeronimoLog.debug(66) | enqueue: for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806: org.apache.ode.bpel.engine.BpelInstanceWorker$1@4d3e20dc
DEBUG - GeronimoLog.debug(66) | enqueuRunnable for process {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9: {BpelInstanceWorker for {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806}
DEBUG - GeronimoLog.debug(66) | Starting worker thread Thread[ODEServerImpl-13,5,main] for instance IID {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806
DEBUG - GeronimoLog.debug(66) | Doing work for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806 in thread Thread[ODEServerImpl-13,5,main]
DEBUG - GeronimoLog.debug(66) | Doing work for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806 in thread Thread[ODEServerImpl-12,5,main]
DEBUG - GeronimoLog.debug(66) | SELECT: 19: USING CORRELATOR 42.laonRequest
DEBUG - GeronimoLog.debug(66) | SELECT: 19: CHECKING for NEW INSTANCE match
DEBUG - GeronimoLog.debug(66) | INPUTMSGMATCH: Changing process instance state from ready to active
DEBUG - GeronimoLog.debug(66) | SELECT: 19: FOUND match for NEW instance mexRef=org.apache.ode.dao.jpa.MessageExchangeDAOImpl@6c62aa33
DEBUG - GeronimoLog.debug(66) | INVOKING PARTNER: partnerLink={PartnerLinkInstance partnerLinkDecl=OPartnerLink#44,scopeInstanceId=860}, op=getCustomerSSN channel=30)
DEBUG - GeronimoLog.debug(66) | Resolving endpoint reference <?xml version="1.0" encoding="UTF-8"?>
<service-ref xmlns="http://docs.oasis-open.org/wsbpel/2.0/serviceref"><EndpointReference xmlns="http://www.w3.org/2005/08/addressing"><Metadata><ServiceName xmlns="http://www.w3.org/2006/05/addressing/wsdl" EndpointName="CustomerInfoPort" xmlns:servicens="http://wso2.org/bps/samples/CustomerInfo">servicens:CustomerInfoService</ServiceName></Metadata><Address>http://localhost:8080/ode/processes/CustomerInfoService</Address></EndpointReference></service-ref>
DEBUG - GeronimoLog.debug(66) | Setting myRoleMex session ids for p2p interaction, mySession null - partnerSess null
DEBUG - GeronimoLog.debug(66) | INVOKE PARTNER (SEP): sessionId=null partnerSessionId=null
DEBUG - GeronimoLog.debug(66) | schedulingRunnable for process {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9: org.apache.ode.bpel.engine.PartnerLinkPartnerRoleImpl$UnreliableInvoker@1a8202f4
DEBUG - GeronimoLog.debug(66) | Creating invocation check event for mexid hqejbhcnphr4u55emnjqiv
DEBUG - GeronimoLog.debug(66) | CACHE SAVE: #1 for instance 806
DEBUG - GeronimoLog.debug(66) | Finished work for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806 in thread Thread[ODEServerImpl-12,5,main]
DEBUG - GeronimoLog.debug(66) | Finished work for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806 in thread Thread[ODEServerImpl-13,5,main]
DEBUG - GeronimoLog.debug(66) | Worker thread Thread[ODEServerImpl-13,5,main] for instance IID 806 ran out of work. 
DEBUG - GeronimoLog.debug(66) | Invoking a partner operation: getCustomerSSN
DEBUG - GeronimoLog.debug(66) | The service to invoke is the external service {http://wso2.org/bps/samples/CustomerInfo}CustomerInfoService:CustomerInfoPort
DEBUG - GeronimoLog.debug(66) | Resolving endpoint reference <?xml version="1.0" encoding="UTF-8"?>
<service-ref xmlns="http://docs.oasis-open.org/wsbpel/2.0/serviceref"><EndpointReference xmlns="http://www.w3.org/2005/08/addressing"><Metadata><ServiceName EndpointName="CustomerInfoPort" xmlns="http://www.w3.org/2006/05/addressing/wsdl" xmlns:servicens="http://wso2.org/bps/samples/CustomerInfo">servicens:CustomerInfoService</ServiceName></Metadata><Address>http://localhost:8080/ode/processes/CustomerInfoService</Address></EndpointReference></service-ref>
DEBUG - GeronimoLog.debug(66) | My-Role EPR not specified, SEP will not be used.
DEBUG - GeronimoLog.debug(66) | Axis2 sending message to http://localhost:8080/ode/processes/CustomerInfoService using MEX {PartnerRoleMex#hqejbhcnphr4u55emnjqiv [PID null] calling org.apache.ode.il.epr.WSAEndpoint@1d9f0336.getCustomerSSN(...)}
DEBUG - GeronimoLog.debug(66) | Message: <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><CustomerInfo xmlns="http://wso2.org/bps/samples/loan_process/schema">
                            <Name>gero et</Name>
                            <Email>sonoras imperio</Email>
                            <CustomerID>quae divum incedo</CustomerID>
                            <CreditRating>3</CreditRating>
                        </CustomerInfo></soapenv:Body></soapenv:Envelope>
DEBUG - GeronimoLog.debug(66) | Sending stateful TO epr in message header using session null
DEBUG - GeronimoLog.debug(66) | Sending a message containing wsa endpoints in headers for session passing.
DEBUG - GeronimoLog.debug(66) | <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><addr:To xmlns:addr="http://www.w3.org/2005/08/addressing">http://localhost:8080/ode/processes/CustomerInfoService</addr:To><addr:Action xmlns:addr="http://www.w3.org/2005/08/addressing"></addr:Action><addr:ReplyTo xmlns:addr="http://www.w3.org/2005/08/addressing"><addr:Address>http://www.w3.org/2005/08/addressing/anonymous</addr:Address></addr:ReplyTo><addr:MessageID xmlns:addr="http://www.w3.org/2005/08/addressing">uuid:hqejbhcnphr4u55emnjqix</addr:MessageID></soapenv:Header><soapenv:Body><CustomerInfo xmlns="http://wso2.org/bps/samples/loan_process/schema">
                            <Name>gero et</Name>
                            <Email>sonoras imperio</Email>
                            <CustomerID>quae divum incedo</CustomerID>
                            <CreditRating>3</CreditRating>
                        </CustomerInfo></soapenv:Body></soapenv:Envelope>
DEBUG - GeronimoLog.debug(66) | Checking for Service using target endpoint address : http://localhost:8080/ode/processes/CustomerInfoService
DEBUG - GeronimoLog.debug(66) | Found service in registry from name CustomerInfoService: null
ERROR - GeronimoLog.error(108) | 
java.lang.NullPointerException
	at org.apache.ode.axis2.hooks.ODEAxisServiceDispatcher.findService(ODEAxisServiceDispatcher.java:80)
	at org.apache.axis2.engine.AbstractDispatcher.invoke(AbstractDispatcher.java:91)
	at org.apache.axis2.engine.Phase.invoke(Phase.java:317)
	at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:264)
	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:163)
	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
	at java.lang.Thread.run(Thread.java:637)
DEBUG - GeronimoLog.debug(66) | Service response:
<?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><soapenv:Fault><faultcode>soapenv:Server</faultcode><faultstring>java.lang.NullPointerException</faultstring><detail><Exception>org.apache.axis2.AxisFault: java.lang.NullPointerException
	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:195)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
	at java.lang.Thread.run(Thread.java:637)
Caused by: java.lang.NullPointerException
	at org.apache.ode.axis2.hooks.ODEAxisServiceDispatcher.findService(ODEAxisServiceDispatcher.java:80)
	at org.apache.axis2.engine.AbstractDispatcher.invoke(AbstractDispatcher.java:91)
	at org.apache.axis2.engine.Phase.invoke(Phase.java:317)
	at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:264)
	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:163)
	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
	... 16 more
</Exception></detail></soapenv:Fault></soapenv:Body></soapenv:Envelope>
DEBUG - GeronimoLog.debug(66) | Received response for MEX {PartnerRoleMex#hqejbhcnphr4u55emnjqiv [PID null] calling org.apache.ode.il.epr.WSAEndpoint@1d9f0336.getCustomerSSN(...)}
WARN - GeronimoLog.warn(92) | Fault response: faultType=(unkown)
<?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><soapenv:Fault><faultcode>soapenv:Server</faultcode><faultstring>java.lang.NullPointerException</faultstring><detail><Exception>org.apache.axis2.AxisFault: java.lang.NullPointerException
	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:195)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
	at java.lang.Thread.run(Thread.java:637)
Caused by: java.lang.NullPointerException
	at org.apache.ode.axis2.hooks.ODEAxisServiceDispatcher.findService(ODEAxisServiceDispatcher.java:80)
	at org.apache.axis2.engine.AbstractDispatcher.invoke(AbstractDispatcher.java:91)
	at org.apache.axis2.engine.Phase.invoke(Phase.java:317)
	at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:264)
	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:163)
	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
	... 16 more
</Exception></detail></soapenv:Fault></soapenv:Body></soapenv:Envelope>
DEBUG - GeronimoLog.debug(66) | replyWithFailure mex=hqejbhcnphr4u55emnjqiv
DEBUG - GeronimoLog.debug(66) | enqueue: for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806: org.apache.ode.bpel.engine.BpelServerImpl$TransactedRunnable@3b293677
DEBUG - GeronimoLog.debug(66) | enqueuRunnable for process {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9: {BpelInstanceWorker for {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806}
DEBUG - GeronimoLog.debug(66) | Starting worker thread Thread[ODEServerImpl-14,5,main] for instance IID {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806
DEBUG - GeronimoLog.debug(66) | Doing work for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806 in thread Thread[ODEServerImpl-14,5,main]
DEBUG - GeronimoLog.debug(66) | <invoke> response for mexid hqejbhcnphr4u55emnjqiv and channel 30
INFO - GeronimoLog.info(79) | ActivityRecovery: Registering activity 11, failure reason:  on channel 31
DEBUG - GeronimoLog.debug(66) | CACHE SAVE: #2 for instance 806
DEBUG - GeronimoLog.debug(66) | Finished work for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806 in thread Thread[ODEServerImpl-14,5,main]
DEBUG - GeronimoLog.debug(66) | Worker thread Thread[ODEServerImpl-14,5,main] for instance IID 806 ran out of work. 
ERROR - GeronimoLog.error(108) | Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest timed out.
java.util.concurrent.TimeoutException
	at org.apache.ode.bpel.engine.UnreliableMyRoleMessageExchangeImpl$ResponseFuture.get(UnreliableMyRoleMessageExchangeImpl.java:99)
	at org.apache.ode.bpel.engine.UnreliableMyRoleMessageExchangeImpl$ResponseFuture.get(UnreliableMyRoleMessageExchangeImpl.java:76)
	at org.apache.ode.bpel.engine.UnreliableMyRoleMessageExchangeImpl.invokeBlocking(UnreliableMyRoleMessageExchangeImpl.java:66)
	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:117)
	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:67)
	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:50)
	at org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
	at java.lang.Thread.run(Thread.java:637)
ERROR - GeronimoLog.error(108) | Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest caused an exception.
org.apache.ode.axis2.OdeFault: Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest timed out.
	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:121)
	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:67)
	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:50)
	at org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
	at java.lang.Thread.run(Thread.java:637)
DEBUG - GeronimoLog.debug(66) | Releasing mex hqejbhcnphr4u55emnjqir
ERROR - GeronimoLog.error(108) | Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest caused an exception.
org.apache.ode.axis2.OdeFault: Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest caused an exception.
	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:135)
	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:67)
	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:50)
	at org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
	at java.lang.Thread.run(Thread.java:637)
Caused by: org.apache.ode.axis2.OdeFault: Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest timed out.
	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:121)
	... 22 more






























Am Nov 15, 2009 um 5:27 PM schrieb Markus Piff:

> Thank you kindly!
> 
> Cheers
> Markus
> 
> On Thu, Nov 12, 2009 at 5:43 AM, Milinda Pathirage
> <mi...@gmail.com> wrote:
>> Hi Markus,
>> 
>> Look at the following BPEL samples we have created for WSO2 BPS.
>> 
>> Asynchronous BPEL :
>> https://wso2.org/repos/wso2/branches/bps/1.1.0/product/modules/samples/src/main/resources/bpel/2.0/LoanService/
>> 
>> BPEL Process which calls above async process:
>> https://wso2.org/repos/wso2/branches/bps/1.1.0/product/modules/samples/src/main/resources/bpel/2.0/LoanProcess/
>> 
>> 
>> Thanks
>> Milinda
>> 
>> 
>> On Wed, Nov 11, 2009 at 6:47 PM, Markus Piff <ma...@gmail.com> wrote:
>> 
>>> Hi,
>>> 
>>> I'm currently engaged in working on an asynchronous bpel process,
>>> however at the time of this writing I haven't managed to create a
>>> working example.
>>> Therefore it would be great if someone had a working example, which
>>> he/she could provide.
>>> 
>>> Cheers
>>> Markus
>>> 
>> 
>> 
>> 
>> --
>> Milinda Pathirage
>> Senior Software Engineer & Product Manager WSO2 BPS; http://wso2.org/bps
>> WSO2 Inc.; http://wso2.com
>> E-mail: milinda@wso2.com, milinda.pathirage@gmail.com
>> Web: http://mpathirage.com
>> Blog: http://blog.mpathirage.com
>> 


Re: Asynchronous Example fails with ODE 2 (both 1.3.3 and 2 beta)

Posted by Håkon Sagehaug <ha...@uni.no>.
Hi Michael,

This might be a mac problem, see this [1] and this [2]


[1]http://codebrane.com/blog/?p=355
[2]
http://markmail.org/message/zsuul7vggbx77lg4#query:Dangling%20meta%20character%20%27*%27%20near%20index%200%20*.local+page:1+mid:7qa6aydag7bdpyjb+state:results

2009/12/18 Michael Dondrup <Mi...@uni.no>

> Hi,
> I have further analyzed the problem and it appears to be a bug in ODE that
> should be fixed first. I tried ODE 1.3.3 and it gives me a slightly
> different error
> ...
> message: java.util.regex.PatternSyntaxException: Dangling meta character
> '*' near index 0
> *.local
> ...
> The processes seem to be pretty valid and of course there is no '*' in any
> of the files, that's why I assume it's a bug, i think a typo missing a '\' .
> Or possibly a locale problem?
> can anybody confirm this, or has this example working?
>
> I put out the processes for your reference:
> http://www.bccs.uni.no/~mdo041/ode_processes/<http://www.bccs.uni.no/%7Emdo041/ode_processes/>
>
>
> I am using ODE 1.3.3, tomcat 5.5.28, MacOS 10.6
> Here is the log:
>
> INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs: []
> DEBUG - GeronimoLog.debug(66) | Checking for Operation using SOAP message
> body's first child's local name : LoanRequest
> DEBUG - GeronimoLog.debug(66) | Received request message for
> LoanProcessService.{http://wso2.org/bps/samples/LoanProcess}laonRequest<http://wso2.org/bps/samples/LoanProcess%7DlaonRequest>
> DEBUG - GeronimoLog.debug(66) | Starting transaction.
> DEBUG - GeronimoLog.debug(66) | Routed: svcQname {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService>--> [BpelProcess[{
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-1<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-1>
> ]]
> DEBUG - GeronimoLog.debug(66) | ODE routed to operation Operation:
> name=laonRequest
> style=REQUEST_RESPONSE,1
> Input: name=input
> Message: name={http://wso2.org/bps/samples/LoanProcess}laonRequestRequest<http://wso2.org/bps/samples/LoanProcess%7DlaonRequestRequest>
> Part: name=part
> elementName={http://wso2.org/bps/samples/loan_process/schema}LoanRequest<http://wso2.org/bps/samples/loan_process/schema%7DLoanRequest>
> Output: name=output
> Message: name={http://wso2.org/bps/samples/LoanProcess}laonRequestResponse<http://wso2.org/bps/samples/LoanProcess%7DlaonRequestResponse>
> Part: name=part
> elementName={http://wso2.org/bps/samples/loan_process/schema}LoanOffer<http://wso2.org/bps/samples/loan_process/schema%7DLoanOffer>from service {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService>
> DEBUG - GeronimoLog.debug(66) | SET MEX property isTwoWay = true
> DEBUG - GeronimoLog.debug(66) | Invoking ODE using MEX
> {MyRoleMex#hqejbhcnphr4u5nem8hvlm [Client hqejbhcnphr4u5nem8hvll] calling {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest%28...%29>
> }
> DEBUG - GeronimoLog.debug(66) | Message content:  <?xml version="1.0"
> encoding="UTF-8"?>
> <message><part><LoanRequest xmlns="
> http://wso2.org/bps/samples/loan_process/schema" xmlns:sch="
> http://wso2.org/bps/samples/loan_process/schema" xmlns:soap="
> http://www.w3.org/2003/05/soap-envelope">
>         <CustomerInfo>
>
>            <Name>gero et</Name>
>
>            <Email>sonoras imperio</Email>
>
>            <CustomerID>dkjflskdjfkahgjkhsfla</CustomerID>
>
>            <CreditRating>100</CreditRating>
>         </CustomerInfo>
>         <LoanInfo>
>
>            <Amount>100</Amount>
>
>            <Years>3</Years>
>         </LoanInfo>
>      </LoanRequest></part></message>
> DEBUG - GeronimoLog.debug(66) | invoke() EPR= null ==> BpelProcess[{
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-1<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-1>
> ]
> DEBUG - GeronimoLog.debug(66) | Commiting ODE MEX
> {MyRoleMex#hqejbhcnphr4u5nem8hvlm [Client hqejbhcnphr4u5nem8hvll] calling {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest%28...%29>
> }
> DEBUG - GeronimoLog.debug(66) | Commiting transaction.
> DEBUG - GeronimoLog.debug(66) | handleWorkEvent: InvokeInternal event for
> mexid hqejbhcnphr4u5nem8hvlm
> DEBUG - GeronimoLog.debug(66) | >>
> handleWorkEvent(jobData={mexid=hqejbhcnphr4u5nem8hvlm, pid={
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-1<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-1>,
> type=INVOKE_INTERNAL})
> DEBUG - GeronimoLog.debug(66) | InvokeInternal event for mexid
> hqejbhcnphr4u5nem8hvlm
> DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.myRoleSessionId = null
> DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.myRoleSessionId = null
> DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.partnerRoleSessionId = null
> DEBUG - GeronimoLog.debug(66) | INPUTMSG: Client.laonRequest: MSG RCVD
> keys=[] mySessionId=null partnerSessionId=null
> DEBUG - GeronimoLog.debug(66) | INPUTMSG: Client.laonRequest: routing
> failed, CREATING NEW INSTANCE
> DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for instance
> 254. INDEXED STATE={}
> DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: USING
> CORRELATOR Client.laonRequest
> DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: CHECKING for
> NEW INSTANCE match
> DEBUG - GeronimoLog.debug(66) | INPUTMSGMATCH: Changing process instance
> state from ready to active
> DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: FOUND match
> for NEW instance mexRef={MyRoleMex#hqejbhcnphr4u5nem8hvlm [Client
> hqejbhcnphr4u5nem8hvll] calling {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest%28...%29>
> }
> DEBUG - GeronimoLog.debug(66) | INVOKING PARTNER:
> partnerLink={PartnerLinkInstance
> partnerLinkDecl=OPartnerLink#44,scopeInstanceId=307}, op=getCustomerSSN
> channel=InvokeResponseChannel#20)
> DEBUG - GeronimoLog.debug(66) | INVOKE PARTNER (SEP): sessionId=null
> partnerSessionId=null
> DEBUG - GeronimoLog.debug(66) | SET MEX property activityId = 77
> DEBUG - GeronimoLog.debug(66) | Routed: svcQname {
> http://wso2.org/bps/samples/CustomerInfo}CustomerInfoService<http://wso2.org/bps/samples/CustomerInfo%7DCustomerInfoService>--> null
> DEBUG - GeronimoLog.debug(66) | Creating invocation check event in 180000ms
> for mexid hqejbhcnphr4u5nem8hvlr
> DEBUG - GeronimoLog.debug(66) | SET MEX property invokeCheckJobId =
> hqejbhcnphr4u5nem8hvls
> DEBUG - GeronimoLog.debug(66) | Invoking a partner operation:
> getCustomerSSN
> DEBUG - GeronimoLog.debug(66) | The service to invoke is the external
> service {
> http://wso2.org/bps/samples/CustomerInfo}CustomerInfoService:CustomerInfoPort<http://wso2.org/bps/samples/CustomerInfo%7DCustomerInfoService:CustomerInfoPort>
> DEBUG - GeronimoLog.debug(66) | Create a new ServiceClient for
> axis_service_for_{
> http://wso2.org/bps/samples/CustomerInfo}CustomerInfoService#CustomerInfoPort_hqejbhcnphr4u5nem8hvl0<http://wso2.org/bps/samples/CustomerInfo%7DCustomerInfoService#CustomerInfoPort_hqejbhcnphr4u5nem8hvl0>
> DEBUG - GeronimoLog.debug(66) | Resolving endpoint reference <?xml
> version="1.0" encoding="UTF-8"?>
> <service-ref xmlns="http://docs.oasis-open.org/wsbpel/2.0/serviceref"><EndpointReference
> xmlns="http://www.w3.org/2005/08/addressing"><Metadata><ServiceName
> xmlns="http://www.w3.org/2006/05/addressing/wsdl"
> EndpointName="CustomerInfoPort" xmlns:servicens="
> http://wso2.org/bps/samples/CustomerInfo
> ">servicens:CustomerInfoService</ServiceName></Metadata><Address>
> http://localhost:8080/ode/processes/CustomerInfoService
> </Address></EndpointReference></service-ref>
> DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.partnerRoleSessionId = null
> DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.myRoleSessionId = null
> DEBUG - GeronimoLog.debug(66) | My-Role EPR not specified, SEP will not be
> used.
> DEBUG - GeronimoLog.debug(66) | Axis2 sending message to
> http://localhost:8080/ode/processes/CustomerInfoService using MEX
> {PartnerRoleMex#hqejbhcnphr4u5nem8hvlr [PID {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-1<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-1>]
> calling org.apache.ode.bpel.epr.WSAEndpoint@2e510e35.getCustomerSSN(...)}
> DEBUG - GeronimoLog.debug(66) | Message: <?xml version='1.0'
> encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="
> http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><CustomerInfo
> xmlns="http://wso2.org/bps/samples/loan_process/schema">
>                            <ns3:Name xmlns:ns3="
> http://wso2.org/bps/samples/loan_process/schema">gero et</ns3:Name>
>                            <ns3:Email xmlns:ns3="
> http://wso2.org/bps/samples/loan_process/schema">sonoras
> imperio</ns3:Email>
>                            <ns3:CustomerID xmlns:ns3="
> http://wso2.org/bps/samples/loan_process/schema
> ">dkjflskdjfkahgjkhsfla</ns3:CustomerID>
>                            <ns3:CreditRating xmlns:ns3="
> http://wso2.org/bps/samples/loan_process/schema">100</ns3:CreditRating>
>                        </CustomerInfo></soapenv:Body></soapenv:Envelope>
> DEBUG - GeronimoLog.debug(66) | replyAsync mex=hqejbhcnphr4u5nem8hvlr
> DEBUG - GeronimoLog.debug(66) | Setting execution state on instance 254
> DEBUG - GeronimoLog.debug(66) | Sending stateful TO epr in message header
> using session null
> DEBUG - GeronimoLog.debug(66) | Sending a message containing wsa endpoints
> in headers for session passing.
> DEBUG - GeronimoLog.debug(66) | <?xml version='1.0'
> encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="
> http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><addr:To
> xmlns:addr="http://www.w3.org/2005/08/addressing">
> http://localhost:8080/ode/processes/CustomerInfoService</addr:To><addr:Action
> xmlns:addr="http://www.w3.org/2005/08/addressing"></addr:Action><addr:ReplyTo
> xmlns:addr="http://www.w3.org/2005/08/addressing"><addr:Address>
> http://www.w3.org/2005/08/addressing/anonymous</addr:Address></addr:ReplyTo><addr:MessageID
> xmlns:addr="http://www.w3.org/2005/08/addressing">uuid:hqejbhcnphr4u5nem8hvlt</addr:MessageID></soapenv:Header><soapenv:Body><CustomerInfo
> xmlns="http://wso2.org/bps/samples/loan_process/schema">
>                            <ns3:Name xmlns:ns3="
> http://wso2.org/bps/samples/loan_process/schema">gero et</ns3:Name>
>                            <ns3:Email xmlns:ns3="
> http://wso2.org/bps/samples/loan_process/schema">sonoras
> imperio</ns3:Email>
>                            <ns3:CustomerID xmlns:ns3="
> http://wso2.org/bps/samples/loan_process/schema
> ">dkjflskdjfkahgjkhsfla</ns3:CustomerID>
>                            <ns3:CreditRating xmlns:ns3="
> http://wso2.org/bps/samples/loan_process/schema">100</ns3:CreditRating>
>                        </CustomerInfo></soapenv:Body></soapenv:Envelope>
> ERROR - GeronimoLog.error(108) | Error sending message
> (mex={PartnerRoleMex#hqejbhcnphr4u5nem8hvlr [PID {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-1<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-1>]
> calling org.apache.ode.bpel.epr.WSAEndpoint@2e510e35.getCustomerSSN(...)}):
> Dangling meta character '*' near index 0
> *.local
> ^
> java.util.regex.PatternSyntaxException: Dangling meta character '*' near
> index 0
> *.local
> ^
>        at java.util.regex.Pattern.error(Pattern.java:1713)
>        at java.util.regex.Pattern.sequence(Pattern.java:1878)
>        at java.util.regex.Pattern.expr(Pattern.java:1752)
>        at java.util.regex.Pattern.compile(Pattern.java:1460)
>        at java.util.regex.Pattern.<init>(Pattern.java:1133)
>        at java.util.regex.Pattern.compile(Pattern.java:823)
>        at java.util.regex.Pattern.matches(Pattern.java:928)
>        at java.lang.String.matches(String.java:2090)
>        at
> org.apache.axis2.transport.http.ProxyConfiguration.validateNonProxyHosts(ProxyConfiguration.java:261)
>        at
> org.apache.axis2.transport.http.ProxyConfiguration.isProxyEnabled(ProxyConfiguration.java:223)
>        at
> org.apache.axis2.transport.http.AbstractHTTPSender.getHostConfiguration(AbstractHTTPSender.java:271)
>        at
> org.apache.axis2.transport.http.AbstractHTTPSender.executeMethod(AbstractHTTPSender.java:502)
>        at
> org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:191)
>        at
> org.apache.axis2.transport.http.HTTPSender.send(HTTPSender.java:77)
>        at
> org.apache.axis2.transport.http.CommonsHTTPTransportSender.writeMessageWithCommons(CommonsHTTPTransportSender.java:327)
>        at
> org.apache.axis2.transport.http.CommonsHTTPTransportSender.invoke(CommonsHTTPTransportSender.java:206)
>        at org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:396)
>        at
> org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:374)
>        at
> org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:211)
>        at
> org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
>        at
> org.apache.ode.axis2.SoapExternalService$1$1.call(SoapExternalService.java:201)
>        at
> java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
>        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
>        at
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
>        at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
>        at java.lang.Thread.run(Thread.java:637)
> DEBUG - GeronimoLog.debug(66) | replyWithFailure mex=hqejbhcnphr4u5nem8hvlr
> failureType=COMMUNICATION_ERROR description=Error sending message
> (mex={PartnerRoleMex#hqejbhcnphr4u5nem8hvlr [PID {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-1<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-1>]
> calling org.apache.ode.bpel.epr.WSAEndpoint@2e510e35.getCustomerSSN(...)}):
> Dangling meta character '*' near index 0
> *.local
> ^ details=null
> DEBUG - GeronimoLog.debug(66) | create work event for
> mex=hqejbhcnphr4u5nem8hvlr
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-4,5,main]: lock(iid=254,
> time=1MICROSECONDS)
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-4,5,main]: lock(iid=254,
> time=1MICROSECONDS)-->GRANTED
> DEBUG - GeronimoLog.debug(66) | >>
> handleWorkEvent(jobData={mexid=hqejbhcnphr4u5nem8hvlr, iid=254,
> type=INVOKE_RESPONSE, channel=20})
> DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for instance
> 254. INDEXED
> STATE={OSequence#47-sequence-activity-line-42::2=[SEQUENCE(self=(OSequence#47-sequence-activity-line-42,TerminationChannel#3,ParentScopeChannel#5),
> linkframe=org.apache.ode.bpel.runtime.LinkFrame@1552dc6d,
> remaining=[{OScope 'InvokeCustomerInfo' id=76}, {OAssign : Assign2,
> joinCondition=null}, {OScope 'InvokeCreditRating' id=93}, {OAssign :
> Assign3, joinCondition=null}, OFlow#159-LoanOfferFlow, {OAssign :
> PrepareOutput, joinCondition=null}, {OAssign : AssignDILoanOffer,
> joinCondition=null}, OReply#202-ReplyWithOffer])],
> OInvoke#77-InvokeCustomerInfo::12=[INVOKE(...)], {OScope
> 'InvokeCustomerInfo' id=76}::10=[SCOPE(...)],
> OSequence#47-sequence-activity-line-42::1=[ACTIVITYGUARD(...)], {OScope
> 'InvokeCustomerInfo' id=76}::10=[ACTIVE(...)],
> OInvoke#77-InvokeCustomerInfo::11=[ACTIVITYGUARD(...)], {OScope
> '__PROCESS_SCOPE:LoanProcess' id=15}::0=[SCOPE(...)], {OScope
> 'InvokeCustomerInfo' id=76}::9=[ACTIVITYGUARD(...)], {OScope
> '__PROCESS_SCOPE:LoanProcess' id=15}::0=[ACTIVE(...)]}
> DEBUG - GeronimoLog.debug(66) | InvokeResponse event for iid 254
> DEBUG - GeronimoLog.debug(66) | Invoking message response for mexid
> hqejbhcnphr4u5nem8hvlr and channel 20
> DEBUG - GeronimoLog.debug(66) | Triggering response
> ERROR - GeronimoLog.error(104) | Failure during invoke: Error sending
> message (mex={PartnerRoleMex#hqejbhcnphr4u5nem8hvlr [PID {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-1<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-1>]
> calling org.apache.ode.bpel.epr.WSAEndpoint@2e510e35.getCustomerSSN(...)}):
> Dangling meta character '*' near index 0
> *.local
> ^
> INFO - GeronimoLog.info(79) | ActivityRecovery: Registering activity 11,
> failure reason: Error sending message
> (mex={PartnerRoleMex#hqejbhcnphr4u5nem8hvlr [PID {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-1<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-1>]
> calling org.apache.ode.bpel.epr.WSAEndpoint@2e510e35.getCustomerSSN(...)}):
> Dangling meta character '*' near index 0
> *.local
> ^ on channel 21
> DEBUG - GeronimoLog.debug(66) | Setting execution state on instance 254
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-4,5,main]: unlock(iid=254)
> DEBUG - GeronimoLog.debug(66) | Received myrole mex response callback
> DEBUG - GeronimoLog.debug(66) | Handling response for MEX
> {MyRoleMex#hqejbhcnphr4u5nem8hvlm [Client hqejbhcnphr4u5nem8hvll] calling {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest%28...%29>
> }
> DEBUG - GeronimoLog.debug(66) | Starting transaction.
> DEBUG - GeronimoLog.debug(66) | Failure response message: null
> WARN - GeronimoLog.warn(96) | MEX produced a fault
> {MyRoleMex#hqejbhcnphr4u5nem8hvlm [Client hqejbhcnphr4u5nem8hvll] calling {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest%28...%29>
> }
> org.apache.ode.axis2.OdeFault: Message exchange failure due to: Error
> sending message (mex={PartnerRoleMex#hqejbhcnphr4u5nem8hvlr [PID {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-1<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-1>]
> calling org.apache.ode.bpel.epr.WSAEndpoint@2e510e35.getCustomerSSN(...)}):
> Dangling meta character '*' near index 0
> *.local
> ^
>        at
> org.apache.ode.axis2.util.SoapMessageConverter.createOdeFault(SoapMessageConverter.java:570)
>        at org.apache.ode.axis2.ODEService.onResponse(ODEService.java:282)
>        at
> org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:189)
>        at
> org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:69)
>        at
> org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:52)
>        at
> org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:96)
>        at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:145)
>        at
> org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
>        at
> org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:120)
>        at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
>        at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
>        at
> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
>        at
> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
>        at
> org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
>        at
> org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
>        at
> org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
>        at
> org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
>        at
> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
>        at
> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
>        at
> org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
>        at
> org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
>        at
> org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
>        at
> org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
>        at
> org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
>        at java.lang.Thread.run(Thread.java:637)
> DEBUG - GeronimoLog.debug(66) | Releasing mex hqejbhcnphr4u5nem8hvlm
> DEBUG - GeronimoLog.debug(66) | Comitting transaction.
>
>
>
>
> Michael Dondrup
> Post-doctoral researcher
> Uni BCCS
> Thormøhlensgate 55, N-5008 Bergen, Norway
> Phone: +47 55584157 Fax: +47 55584295
> Please note my new phone number
>
>
>
> Am Dec 17, 2009 um 4:52 PM schrieb Michael Dondrup:
>
> > Hi,
> >
> > I appreciate very much the example of asynchronous service invocation
> given here. I am currently testing this with ODE 2 beta.
> > I have successfully deployed both processes in ODE 2 after changing the
> the SOAP addresses in the wsdls to http://localhost:8080/ode/processes/[..<http://localhost:8080/ode/processes/%5B..>
> ..
> > I call the service at
> http://localhost:8080/ode/processes/LoanProcessService using SoapUI, then
> after a few seconds I get an exception back.
> >
> > Am I doing something wrong and has anybody got this working? Any help is
> appreciated.
> >
> > Best
> > Michael
> >
> >
> > Request:
> >
> > <soapenv:Envelope xmlns:soapenv="
> http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="
> http://wso2.org/bps/samples/loan_process/schema">
> >   <soapenv:Header/>
> >   <soapenv:Body>
> >      <sch:LoanRequest>
> >         <sch:CustomerInfo>
> >            <!--type: string-->
> >            <sch:Name>gero et</sch:Name>
> >            <!--type: string-->
> >            <sch:Email>sonoras imperio</sch:Email>
> >            <!--type: CustomerIDType-->
> >            <sch:CustomerID>quae divum incedo</sch:CustomerID>
> >            <!--type: int-->
> >            <sch:CreditRating>3</sch:CreditRating>
> >         </sch:CustomerInfo>
> >         <sch:LoanInfo>
> >            <!--type: double-->
> >            <sch:Amount>1000</sch:Amount>
> >            <!--type: int-->
> >            <sch:Years>3</sch:Years>
> >         </sch:LoanInfo>
> >      </sch:LoanRequest>
> >   </soapenv:Body>
> > </soapenv:Envelope>
> >
> > Response:
> > <soapenv:Envelope xmlns:soapenv="
> http://schemas.xmlsoap.org/soap/envelope/">
> >   <soapenv:Body>
> >      <soapenv:Fault xmlns:java="java:package org.apache.ode.axis2">
> >         <faultcode>java:org.apache.ode.axis2.OdeFault</faultcode>
> >         <faultstring>Call to {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest>caused an exception.</faultstring>
> >         <detail>
> >            <Exception>org.apache.ode.axis2.OdeFault: Call to {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest>caused an exception.
> >       at
> org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:135)
> >       at
> org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:67)
> >       at
> org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:50)
> >       at
> org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
> >       at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
> >       at
> org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> >       at
> org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> >       at
> org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> >       at
> org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> >       at
> org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> >       at
> org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> >       at
> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> >       at
> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> >       at
> org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> >       at
> org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> >       at
> org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> >       at
> org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> >       at
> org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> >       at java.lang.Thread.run(Thread.java:637)
> > Caused by: org.apache.ode.axis2.OdeFault: Call to {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest>timed out.
> >       at
> org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:121)
> >       ... 22 more</Exception>
> >         </detail>
> >      </soapenv:Fault>
> >   </soapenv:Body>
> > </soapenv:Envelope>
> >
> > This seems to be the real source of error
> > ERROR - GeronimoLog.error(108) |
> > java.lang.NullPointerException
> >       at
> org.apache.ode.axis2.hooks.ODEAxisServiceDispatcher.findService(ODEAxisServiceDispatcher.java:80)
> >       at
> org.apache.axis2.engine.AbstractDispatcher.invoke(AbstractDispatcher.java:91)
> >
> >
> >
> > And here is the complete catalina log of the interaction:
> >
> >
> > DEBUG - GeronimoLog.debug(66) | The system is checking for the operation
> using the following WSAAction:
> > DEBUG - GeronimoLog.debug(66) | Checking for Operation using SOAP message
> body's first child's local name : LoanRequest
> > DEBUG - GeronimoLog.debug(66) | Received request message for
> LoanProcessService.{http://wso2.org/bps/samples/LoanProcess}laonRequest<http://wso2.org/bps/samples/LoanProcess%7DlaonRequest>
> > DEBUG - GeronimoLog.debug(66) | ODE routed to operation Operation:
> name=laonRequest
> > style=REQUEST_RESPONSE,1
> > Input: name=input
> > Message: name={
> http://wso2.org/bps/samples/LoanProcess}laonRequestRequest<http://wso2.org/bps/samples/LoanProcess%7DlaonRequestRequest>
> > Part: name=part
> > elementName={http://wso2.org/bps/samples/loan_process/schema}LoanRequest<http://wso2.org/bps/samples/loan_process/schema%7DLoanRequest>
> > Output: name=output
> > Message: name={
> http://wso2.org/bps/samples/LoanProcess}laonRequestResponse<http://wso2.org/bps/samples/LoanProcess%7DlaonRequestResponse>
> > Part: name=part
> > elementName={http://wso2.org/bps/samples/loan_process/schema}LoanOffer<http://wso2.org/bps/samples/loan_process/schema%7DLoanOffer>from service {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService>
> > DEBUG - GeronimoLog.debug(66) | Invoking ODE using MEX
> {MyRoleMex#hqejbhcnphr4u55emnjqir [Client null] calling {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest%28...%29>
> }
> > DEBUG - GeronimoLog.debug(66) | Message content:  <?xml version="1.0"
> encoding="UTF-8"?>
> > <message><part><LoanRequest xmlns="
> http://wso2.org/bps/samples/loan_process/schema" xmlns:sch="
> http://wso2.org/bps/samples/loan_process/schema" xmlns:soapenv="
> http://schemas.xmlsoap.org/soap/envelope/">
> >         <CustomerInfo>
> >
> >            <Name>gero et</Name>
> >
> >            <Email>sonoras imperio</Email>
> >
> >            <CustomerID>quae divum incedo</CustomerID>
> >
> >            <CreditRating>3</CreditRating>
> >         </CustomerInfo>
> >         <LoanInfo>
> >
> >            <Amount>1000</Amount>
> >
> >            <Years>3</Years>
> >         </LoanInfo>
> >      </LoanRequest></part></message>
> > DEBUG - GeronimoLog.debug(66) | invoke() EPR= null ==> ODEProcess[{
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9>
> ]
> > DEBUG - GeronimoLog.debug(66) | INPUTMSG: 42.laonRequest: MSG RCVD
> keys=[{CorrelationKey setId=41, values=[quae divum incedo]}]
> mySessionId=null partnerSessionId=null
> > DEBUG - GeronimoLog.debug(66) | INPUTMSG: 42.laonRequest: routing failed,
> CREATING NEW INSTANCE
> > DEBUG - GeronimoLog.debug(66) | enqueue: for instance {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9#806>:
> org.apache.ode.bpel.engine.BpelInstanceWorker$1@4d3e20dc
> > DEBUG - GeronimoLog.debug(66) | enqueuRunnable for process {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9>:
> {BpelInstanceWorker for {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9#806>
> }
> > DEBUG - GeronimoLog.debug(66) | Starting worker thread
> Thread[ODEServerImpl-13,5,main] for instance IID {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9#806>
> > DEBUG - GeronimoLog.debug(66) | Doing work for instance {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9#806>in thread Thread[ODEServerImpl-13,5,main]
> > DEBUG - GeronimoLog.debug(66) | Doing work for instance {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9#806>in thread Thread[ODEServerImpl-12,5,main]
> > DEBUG - GeronimoLog.debug(66) | SELECT: 19: USING CORRELATOR
> 42.laonRequest
> > DEBUG - GeronimoLog.debug(66) | SELECT: 19: CHECKING for NEW INSTANCE
> match
> > DEBUG - GeronimoLog.debug(66) | INPUTMSGMATCH: Changing process instance
> state from ready to active
> > DEBUG - GeronimoLog.debug(66) | SELECT: 19: FOUND match for NEW instance
> mexRef=org.apache.ode.dao.jpa.MessageExchangeDAOImpl@6c62aa33
> > DEBUG - GeronimoLog.debug(66) | INVOKING PARTNER:
> partnerLink={PartnerLinkInstance
> partnerLinkDecl=OPartnerLink#44,scopeInstanceId=860}, op=getCustomerSSN
> channel=30)
> > DEBUG - GeronimoLog.debug(66) | Resolving endpoint reference <?xml
> version="1.0" encoding="UTF-8"?>
> > <service-ref xmlns="http://docs.oasis-open.org/wsbpel/2.0/serviceref"><EndpointReference
> xmlns="http://www.w3.org/2005/08/addressing"><Metadata><ServiceName
> xmlns="http://www.w3.org/2006/05/addressing/wsdl"
> EndpointName="CustomerInfoPort" xmlns:servicens="
> http://wso2.org/bps/samples/CustomerInfo
> ">servicens:CustomerInfoService</ServiceName></Metadata><Address>
> http://localhost:8080/ode/processes/CustomerInfoService
> </Address></EndpointReference></service-ref>
> > DEBUG - GeronimoLog.debug(66) | Setting myRoleMex session ids for p2p
> interaction, mySession null - partnerSess null
> > DEBUG - GeronimoLog.debug(66) | INVOKE PARTNER (SEP): sessionId=null
> partnerSessionId=null
> > DEBUG - GeronimoLog.debug(66) | schedulingRunnable for process {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9>:
> org.apache.ode.bpel.engine.PartnerLinkPartnerRoleImpl$UnreliableInvoker@1a8202f4
> > DEBUG - GeronimoLog.debug(66) | Creating invocation check event for mexid
> hqejbhcnphr4u55emnjqiv
> > DEBUG - GeronimoLog.debug(66) | CACHE SAVE: #1 for instance 806
> > DEBUG - GeronimoLog.debug(66) | Finished work for instance {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9#806>in thread Thread[ODEServerImpl-12,5,main]
> > DEBUG - GeronimoLog.debug(66) | Finished work for instance {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9#806>in thread Thread[ODEServerImpl-13,5,main]
> > DEBUG - GeronimoLog.debug(66) | Worker thread
> Thread[ODEServerImpl-13,5,main] for instance IID 806 ran out of work.
> > DEBUG - GeronimoLog.debug(66) | Invoking a partner operation:
> getCustomerSSN
> > DEBUG - GeronimoLog.debug(66) | The service to invoke is the external
> service {
> http://wso2.org/bps/samples/CustomerInfo}CustomerInfoService:CustomerInfoPort<http://wso2.org/bps/samples/CustomerInfo%7DCustomerInfoService:CustomerInfoPort>
> > DEBUG - GeronimoLog.debug(66) | Resolving endpoint reference <?xml
> version="1.0" encoding="UTF-8"?>
> > <service-ref xmlns="http://docs.oasis-open.org/wsbpel/2.0/serviceref"><EndpointReference
> xmlns="http://www.w3.org/2005/08/addressing"><Metadata><ServiceName
> EndpointName="CustomerInfoPort" xmlns="
> http://www.w3.org/2006/05/addressing/wsdl" xmlns:servicens="
> http://wso2.org/bps/samples/CustomerInfo
> ">servicens:CustomerInfoService</ServiceName></Metadata><Address>
> http://localhost:8080/ode/processes/CustomerInfoService
> </Address></EndpointReference></service-ref>
> > DEBUG - GeronimoLog.debug(66) | My-Role EPR not specified, SEP will not
> be used.
> > DEBUG - GeronimoLog.debug(66) | Axis2 sending message to
> http://localhost:8080/ode/processes/CustomerInfoService using MEX
> {PartnerRoleMex#hqejbhcnphr4u55emnjqiv [PID null] calling
> org.apache.ode.il.epr.WSAEndpoint@1d9f0336.getCustomerSSN(...)}
> > DEBUG - GeronimoLog.debug(66) | Message: <?xml version='1.0'
> encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="
> http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><CustomerInfo
> xmlns="http://wso2.org/bps/samples/loan_process/schema">
> >                            <Name>gero et</Name>
> >                            <Email>sonoras imperio</Email>
> >                            <CustomerID>quae divum incedo</CustomerID>
> >                            <CreditRating>3</CreditRating>
> >                        </CustomerInfo></soapenv:Body></soapenv:Envelope>
> > DEBUG - GeronimoLog.debug(66) | Sending stateful TO epr in message header
> using session null
> > DEBUG - GeronimoLog.debug(66) | Sending a message containing wsa
> endpoints in headers for session passing.
> > DEBUG - GeronimoLog.debug(66) | <?xml version='1.0'
> encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="
> http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><addr:To
> xmlns:addr="http://www.w3.org/2005/08/addressing">
> http://localhost:8080/ode/processes/CustomerInfoService</addr:To><addr:Action
> xmlns:addr="http://www.w3.org/2005/08/addressing"></addr:Action><addr:ReplyTo
> xmlns:addr="http://www.w3.org/2005/08/addressing"><addr:Address>
> http://www.w3.org/2005/08/addressing/anonymous</addr:Address></addr:ReplyTo><addr:MessageID
> xmlns:addr="http://www.w3.org/2005/08/addressing">uuid:hqejbhcnphr4u55emnjqix</addr:MessageID></soapenv:Header><soapenv:Body><CustomerInfo
> xmlns="http://wso2.org/bps/samples/loan_process/schema">
> >                            <Name>gero et</Name>
> >                            <Email>sonoras imperio</Email>
> >                            <CustomerID>quae divum incedo</CustomerID>
> >                            <CreditRating>3</CreditRating>
> >                        </CustomerInfo></soapenv:Body></soapenv:Envelope>
> > DEBUG - GeronimoLog.debug(66) | Checking for Service using target
> endpoint address : http://localhost:8080/ode/processes/CustomerInfoService
> > DEBUG - GeronimoLog.debug(66) | Found service in registry from name
> CustomerInfoService: null
> > ERROR - GeronimoLog.error(108) |
> > java.lang.NullPointerException
> >       at
> org.apache.ode.axis2.hooks.ODEAxisServiceDispatcher.findService(ODEAxisServiceDispatcher.java:80)
> >       at
> org.apache.axis2.engine.AbstractDispatcher.invoke(AbstractDispatcher.java:91)
> >       at org.apache.axis2.engine.Phase.invoke(Phase.java:317)
> >       at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:264)
> >       at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:163)
> >       at
> org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> >       at
> org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> >       at
> org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> >       at
> org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> >       at
> org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> >       at
> org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> >       at
> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> >       at
> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> >       at
> org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> >       at
> org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> >       at
> org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> >       at
> org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> >       at
> org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> >       at java.lang.Thread.run(Thread.java:637)
> > DEBUG - GeronimoLog.debug(66) | Service response:
> > <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="
> http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><soapenv:Fault><faultcode>soapenv:Server</faultcode><faultstring>java.lang.NullPointerException</faultstring><detail><Exception>org.apache.axis2.AxisFault:
> java.lang.NullPointerException
> >       at
> org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:195)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> >       at
> org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> >       at
> org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> >       at
> org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> >       at
> org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> >       at
> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> >       at
> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> >       at
> org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> >       at
> org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> >       at
> org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> >       at
> org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> >       at
> org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> >       at java.lang.Thread.run(Thread.java:637)
> > Caused by: java.lang.NullPointerException
> >       at
> org.apache.ode.axis2.hooks.ODEAxisServiceDispatcher.findService(ODEAxisServiceDispatcher.java:80)
> >       at
> org.apache.axis2.engine.AbstractDispatcher.invoke(AbstractDispatcher.java:91)
> >       at org.apache.axis2.engine.Phase.invoke(Phase.java:317)
> >       at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:264)
> >       at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:163)
> >       at
> org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> >       at
> org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> >       ... 16 more
> > </Exception></detail></soapenv:Fault></soapenv:Body></soapenv:Envelope>
> > DEBUG - GeronimoLog.debug(66) | Received response for MEX
> {PartnerRoleMex#hqejbhcnphr4u55emnjqiv [PID null] calling
> org.apache.ode.il.epr.WSAEndpoint@1d9f0336.getCustomerSSN(...)}
> > WARN - GeronimoLog.warn(92) | Fault response: faultType=(unkown)
> > <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="
> http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><soapenv:Fault><faultcode>soapenv:Server</faultcode><faultstring>java.lang.NullPointerException</faultstring><detail><Exception>org.apache.axis2.AxisFault:
> java.lang.NullPointerException
> >       at
> org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:195)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> >       at
> org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> >       at
> org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> >       at
> org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> >       at
> org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> >       at
> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> >       at
> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> >       at
> org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> >       at
> org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> >       at
> org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> >       at
> org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> >       at
> org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> >       at java.lang.Thread.run(Thread.java:637)
> > Caused by: java.lang.NullPointerException
> >       at
> org.apache.ode.axis2.hooks.ODEAxisServiceDispatcher.findService(ODEAxisServiceDispatcher.java:80)
> >       at
> org.apache.axis2.engine.AbstractDispatcher.invoke(AbstractDispatcher.java:91)
> >       at org.apache.axis2.engine.Phase.invoke(Phase.java:317)
> >       at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:264)
> >       at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:163)
> >       at
> org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> >       at
> org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> >       ... 16 more
> > </Exception></detail></soapenv:Fault></soapenv:Body></soapenv:Envelope>
> > DEBUG - GeronimoLog.debug(66) | replyWithFailure
> mex=hqejbhcnphr4u55emnjqiv
> > DEBUG - GeronimoLog.debug(66) | enqueue: for instance {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9#806>:
> org.apache.ode.bpel.engine.BpelServerImpl$TransactedRunnable@3b293677
> > DEBUG - GeronimoLog.debug(66) | enqueuRunnable for process {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9>:
> {BpelInstanceWorker for {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9#806>
> }
> > DEBUG - GeronimoLog.debug(66) | Starting worker thread
> Thread[ODEServerImpl-14,5,main] for instance IID {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9#806>
> > DEBUG - GeronimoLog.debug(66) | Doing work for instance {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9#806>in thread Thread[ODEServerImpl-14,5,main]
> > DEBUG - GeronimoLog.debug(66) | <invoke> response for mexid
> hqejbhcnphr4u55emnjqiv and channel 30
> > INFO - GeronimoLog.info(79) | ActivityRecovery: Registering activity 11,
> failure reason:  on channel 31
> > DEBUG - GeronimoLog.debug(66) | CACHE SAVE: #2 for instance 806
> > DEBUG - GeronimoLog.debug(66) | Finished work for instance {
> http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806<http://wso2.org/bps/samples/LoanProcess%7DLoanProcess-9#806>in thread Thread[ODEServerImpl-14,5,main]
> > DEBUG - GeronimoLog.debug(66) | Worker thread
> Thread[ODEServerImpl-14,5,main] for instance IID 806 ran out of work.
> > ERROR - GeronimoLog.error(108) | Call to {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest>timed out.
> > java.util.concurrent.TimeoutException
> >       at
> org.apache.ode.bpel.engine.UnreliableMyRoleMessageExchangeImpl$ResponseFuture.get(UnreliableMyRoleMessageExchangeImpl.java:99)
> >       at
> org.apache.ode.bpel.engine.UnreliableMyRoleMessageExchangeImpl$ResponseFuture.get(UnreliableMyRoleMessageExchangeImpl.java:76)
> >       at
> org.apache.ode.bpel.engine.UnreliableMyRoleMessageExchangeImpl.invokeBlocking(UnreliableMyRoleMessageExchangeImpl.java:66)
> >       at
> org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:117)
> >       at
> org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:67)
> >       at
> org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:50)
> >       at
> org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
> >       at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
> >       at
> org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> >       at
> org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> >       at
> org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> >       at
> org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> >       at
> org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> >       at
> org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> >       at
> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> >       at
> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> >       at
> org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> >       at
> org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> >       at
> org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> >       at
> org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> >       at
> org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> >       at java.lang.Thread.run(Thread.java:637)
> > ERROR - GeronimoLog.error(108) | Call to {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest>caused an exception.
> > org.apache.ode.axis2.OdeFault: Call to {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest>timed out.
> >       at
> org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:121)
> >       at
> org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:67)
> >       at
> org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:50)
> >       at
> org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
> >       at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
> >       at
> org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> >       at
> org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> >       at
> org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> >       at
> org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> >       at
> org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> >       at
> org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> >       at
> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> >       at
> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> >       at
> org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> >       at
> org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> >       at
> org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> >       at
> org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> >       at
> org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> >       at java.lang.Thread.run(Thread.java:637)
> > DEBUG - GeronimoLog.debug(66) | Releasing mex hqejbhcnphr4u55emnjqir
> > ERROR - GeronimoLog.error(108) | Call to {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest>caused an exception.
> > org.apache.ode.axis2.OdeFault: Call to {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest>caused an exception.
> >       at
> org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:135)
> >       at
> org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:67)
> >       at
> org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:50)
> >       at
> org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
> >       at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
> >       at
> org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> >       at
> org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> >       at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> >       at
> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> >       at
> org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> >       at
> org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> >       at
> org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> >       at
> org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> >       at
> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> >       at
> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> >       at
> org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> >       at
> org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> >       at
> org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> >       at
> org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> >       at
> org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> >       at java.lang.Thread.run(Thread.java:637)
> > Caused by: org.apache.ode.axis2.OdeFault: Call to {
> http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest<http://wso2.org/bps/samples/LoanProcess%7DLoanProcessService.laonRequest>timed out.
> >       at
> org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:121)
> >       ... 22 more
> >
> >
> > Am Nov 15, 2009 um 5:27 PM schrieb Markus Piff:
> >
> >> Thank you kindly!
> >>
> >> Cheers
> >> Markus
> >>
> >> On Thu, Nov 12, 2009 at 5:43 AM, Milinda Pathirage
> >> <mi...@gmail.com> wrote:
> >>> Hi Markus,
> >>>
> >>> Look at the following BPEL samples we have created for WSO2 BPS.
> >>>
> >>> Asynchronous BPEL :
> >>>
> https://wso2.org/repos/wso2/branches/bps/1.1.0/product/modules/samples/src/main/resources/bpel/2.0/LoanService/
> >>>
> >>> BPEL Process which calls above async process:
> >>>
> https://wso2.org/repos/wso2/branches/bps/1.1.0/product/modules/samples/src/main/resources/bpel/2.0/LoanProcess/
> >>>
> >>>
> >>> Thanks
> >>> Milinda
> >>>
> >>>
> >>> On Wed, Nov 11, 2009 at 6:47 PM, Markus Piff <ma...@gmail.com>
> wrote:
> >>>
> >>>> Hi,
> >>>>
> >>>> I'm currently engaged in working on an asynchronous bpel process,
> >>>> however at the time of this writing I haven't managed to create a
> >>>> working example.
> >>>> Therefore it would be great if someone had a working example, which
> >>>> he/she could provide.
> >>>>
> >>>> Cheers
> >>>> Markus
> >>>>
> >>>
> >>>
> >>>
> >>> --
> >>> Milinda Pathirage
> >>> Senior Software Engineer & Product Manager WSO2 BPS;
> http://wso2.org/bps
> >>> WSO2 Inc.; http://wso2.com
> >>> E-mail: milinda@wso2.com, milinda.pathirage@gmail.com
> >>> Web: http://mpathirage.com
> >>> Blog: http://blog.mpathirage.com
> >>>
> >
>
>


-- 
Håkon Sagehaug, Scientific Programmer
Parallab, Bergen Center for Computational Science(BCCS)
Uni BCCS/Uni Research
Hakon.Sagehaug@uni.no, phone +47 55584125

Re: Asynchronous Example fails with ODE 2 (both 1.3.3 and 2 beta)

Posted by Michael Dondrup <Mi...@uni.no>.
Hi, 
I have further analyzed the problem and it appears to be a bug in ODE that should be fixed first. I tried ODE 1.3.3 and it gives me a slightly different error
...
message: java.util.regex.PatternSyntaxException: Dangling meta character '*' near index 0
*.local
...
The processes seem to be pretty valid and of course there is no '*' in any of the files, that's why I assume it's a bug, i think a typo missing a '\' .
Or possibly a locale problem?
can anybody confirm this, or has this example working?

I put out the processes for your reference:
http://www.bccs.uni.no/~mdo041/ode_processes/


I am using ODE 1.3.3, tomcat 5.5.28, MacOS 10.6
Here is the log:

INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs: []
DEBUG - GeronimoLog.debug(66) | Checking for Operation using SOAP message body's first child's local name : LoanRequest
DEBUG - GeronimoLog.debug(66) | Received request message for LoanProcessService.{http://wso2.org/bps/samples/LoanProcess}laonRequest
DEBUG - GeronimoLog.debug(66) | Starting transaction.
DEBUG - GeronimoLog.debug(66) | Routed: svcQname {http://wso2.org/bps/samples/LoanProcess}LoanProcessService --> [BpelProcess[{http://wso2.org/bps/samples/LoanProcess}LoanProcess-1]]
DEBUG - GeronimoLog.debug(66) | ODE routed to operation Operation: name=laonRequest
style=REQUEST_RESPONSE,1
Input: name=input
Message: name={http://wso2.org/bps/samples/LoanProcess}laonRequestRequest
Part: name=part
elementName={http://wso2.org/bps/samples/loan_process/schema}LoanRequest
Output: name=output
Message: name={http://wso2.org/bps/samples/LoanProcess}laonRequestResponse
Part: name=part
elementName={http://wso2.org/bps/samples/loan_process/schema}LoanOffer from service {http://wso2.org/bps/samples/LoanProcess}LoanProcessService
DEBUG - GeronimoLog.debug(66) | SET MEX property isTwoWay = true
DEBUG - GeronimoLog.debug(66) | Invoking ODE using MEX {MyRoleMex#hqejbhcnphr4u5nem8hvlm [Client hqejbhcnphr4u5nem8hvll] calling {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)}
DEBUG - GeronimoLog.debug(66) | Message content:  <?xml version="1.0" encoding="UTF-8"?>
<message><part><LoanRequest xmlns="http://wso2.org/bps/samples/loan_process/schema" xmlns:sch="http://wso2.org/bps/samples/loan_process/schema" xmlns:soap="http://www.w3.org/2003/05/soap-envelope">
         <CustomerInfo>
            
            <Name>gero et</Name>
            
            <Email>sonoras imperio</Email>
            
            <CustomerID>dkjflskdjfkahgjkhsfla</CustomerID>
            
            <CreditRating>100</CreditRating>
         </CustomerInfo>
         <LoanInfo>
            
            <Amount>100</Amount>
            
            <Years>3</Years>
         </LoanInfo>
      </LoanRequest></part></message>
DEBUG - GeronimoLog.debug(66) | invoke() EPR= null ==> BpelProcess[{http://wso2.org/bps/samples/LoanProcess}LoanProcess-1]
DEBUG - GeronimoLog.debug(66) | Commiting ODE MEX {MyRoleMex#hqejbhcnphr4u5nem8hvlm [Client hqejbhcnphr4u5nem8hvll] calling {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)}
DEBUG - GeronimoLog.debug(66) | Commiting transaction.
DEBUG - GeronimoLog.debug(66) | handleWorkEvent: InvokeInternal event for mexid hqejbhcnphr4u5nem8hvlm
DEBUG - GeronimoLog.debug(66) | >> handleWorkEvent(jobData={mexid=hqejbhcnphr4u5nem8hvlm, pid={http://wso2.org/bps/samples/LoanProcess}LoanProcess-1, type=INVOKE_INTERNAL})
DEBUG - GeronimoLog.debug(66) | InvokeInternal event for mexid hqejbhcnphr4u5nem8hvlm
DEBUG - GeronimoLog.debug(66) | GET MEX property org.apache.ode.bpel.myRoleSessionId = null
DEBUG - GeronimoLog.debug(66) | GET MEX property org.apache.ode.bpel.myRoleSessionId = null
DEBUG - GeronimoLog.debug(66) | GET MEX property org.apache.ode.bpel.partnerRoleSessionId = null
DEBUG - GeronimoLog.debug(66) | INPUTMSG: Client.laonRequest: MSG RCVD keys=[] mySessionId=null partnerSessionId=null
DEBUG - GeronimoLog.debug(66) | INPUTMSG: Client.laonRequest: routing failed, CREATING NEW INSTANCE
DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for instance 254. INDEXED STATE={}
DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: USING CORRELATOR Client.laonRequest
DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: CHECKING for NEW INSTANCE match
DEBUG - GeronimoLog.debug(66) | INPUTMSGMATCH: Changing process instance state from ready to active
DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: FOUND match for NEW instance mexRef={MyRoleMex#hqejbhcnphr4u5nem8hvlm [Client hqejbhcnphr4u5nem8hvll] calling {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)}
DEBUG - GeronimoLog.debug(66) | INVOKING PARTNER: partnerLink={PartnerLinkInstance partnerLinkDecl=OPartnerLink#44,scopeInstanceId=307}, op=getCustomerSSN channel=InvokeResponseChannel#20)
DEBUG - GeronimoLog.debug(66) | INVOKE PARTNER (SEP): sessionId=null partnerSessionId=null
DEBUG - GeronimoLog.debug(66) | SET MEX property activityId = 77
DEBUG - GeronimoLog.debug(66) | Routed: svcQname {http://wso2.org/bps/samples/CustomerInfo}CustomerInfoService --> null
DEBUG - GeronimoLog.debug(66) | Creating invocation check event in 180000ms for mexid hqejbhcnphr4u5nem8hvlr
DEBUG - GeronimoLog.debug(66) | SET MEX property invokeCheckJobId = hqejbhcnphr4u5nem8hvls
DEBUG - GeronimoLog.debug(66) | Invoking a partner operation: getCustomerSSN
DEBUG - GeronimoLog.debug(66) | The service to invoke is the external service {http://wso2.org/bps/samples/CustomerInfo}CustomerInfoService:CustomerInfoPort
DEBUG - GeronimoLog.debug(66) | Create a new ServiceClient for axis_service_for_{http://wso2.org/bps/samples/CustomerInfo}CustomerInfoService#CustomerInfoPort_hqejbhcnphr4u5nem8hvl0
DEBUG - GeronimoLog.debug(66) | Resolving endpoint reference <?xml version="1.0" encoding="UTF-8"?>
<service-ref xmlns="http://docs.oasis-open.org/wsbpel/2.0/serviceref"><EndpointReference xmlns="http://www.w3.org/2005/08/addressing"><Metadata><ServiceName xmlns="http://www.w3.org/2006/05/addressing/wsdl" EndpointName="CustomerInfoPort" xmlns:servicens="http://wso2.org/bps/samples/CustomerInfo">servicens:CustomerInfoService</ServiceName></Metadata><Address>http://localhost:8080/ode/processes/CustomerInfoService</Address></EndpointReference></service-ref>
DEBUG - GeronimoLog.debug(66) | GET MEX property org.apache.ode.bpel.partnerRoleSessionId = null
DEBUG - GeronimoLog.debug(66) | GET MEX property org.apache.ode.bpel.myRoleSessionId = null
DEBUG - GeronimoLog.debug(66) | My-Role EPR not specified, SEP will not be used.
DEBUG - GeronimoLog.debug(66) | Axis2 sending message to http://localhost:8080/ode/processes/CustomerInfoService using MEX {PartnerRoleMex#hqejbhcnphr4u5nem8hvlr [PID {http://wso2.org/bps/samples/LoanProcess}LoanProcess-1] calling org.apache.ode.bpel.epr.WSAEndpoint@2e510e35.getCustomerSSN(...)}
DEBUG - GeronimoLog.debug(66) | Message: <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><CustomerInfo xmlns="http://wso2.org/bps/samples/loan_process/schema">
                            <ns3:Name xmlns:ns3="http://wso2.org/bps/samples/loan_process/schema">gero et</ns3:Name>
                            <ns3:Email xmlns:ns3="http://wso2.org/bps/samples/loan_process/schema">sonoras imperio</ns3:Email>
                            <ns3:CustomerID xmlns:ns3="http://wso2.org/bps/samples/loan_process/schema">dkjflskdjfkahgjkhsfla</ns3:CustomerID>
                            <ns3:CreditRating xmlns:ns3="http://wso2.org/bps/samples/loan_process/schema">100</ns3:CreditRating>
                        </CustomerInfo></soapenv:Body></soapenv:Envelope>
DEBUG - GeronimoLog.debug(66) | replyAsync mex=hqejbhcnphr4u5nem8hvlr
DEBUG - GeronimoLog.debug(66) | Setting execution state on instance 254
DEBUG - GeronimoLog.debug(66) | Sending stateful TO epr in message header using session null
DEBUG - GeronimoLog.debug(66) | Sending a message containing wsa endpoints in headers for session passing.
DEBUG - GeronimoLog.debug(66) | <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><addr:To xmlns:addr="http://www.w3.org/2005/08/addressing">http://localhost:8080/ode/processes/CustomerInfoService</addr:To><addr:Action xmlns:addr="http://www.w3.org/2005/08/addressing"></addr:Action><addr:ReplyTo xmlns:addr="http://www.w3.org/2005/08/addressing"><addr:Address>http://www.w3.org/2005/08/addressing/anonymous</addr:Address></addr:ReplyTo><addr:MessageID xmlns:addr="http://www.w3.org/2005/08/addressing">uuid:hqejbhcnphr4u5nem8hvlt</addr:MessageID></soapenv:Header><soapenv:Body><CustomerInfo xmlns="http://wso2.org/bps/samples/loan_process/schema">
                            <ns3:Name xmlns:ns3="http://wso2.org/bps/samples/loan_process/schema">gero et</ns3:Name>
                            <ns3:Email xmlns:ns3="http://wso2.org/bps/samples/loan_process/schema">sonoras imperio</ns3:Email>
                            <ns3:CustomerID xmlns:ns3="http://wso2.org/bps/samples/loan_process/schema">dkjflskdjfkahgjkhsfla</ns3:CustomerID>
                            <ns3:CreditRating xmlns:ns3="http://wso2.org/bps/samples/loan_process/schema">100</ns3:CreditRating>
                        </CustomerInfo></soapenv:Body></soapenv:Envelope>
ERROR - GeronimoLog.error(108) | Error sending message (mex={PartnerRoleMex#hqejbhcnphr4u5nem8hvlr [PID {http://wso2.org/bps/samples/LoanProcess}LoanProcess-1] calling org.apache.ode.bpel.epr.WSAEndpoint@2e510e35.getCustomerSSN(...)}): Dangling meta character '*' near index 0
*.local
^
java.util.regex.PatternSyntaxException: Dangling meta character '*' near index 0
*.local
^
	at java.util.regex.Pattern.error(Pattern.java:1713)
	at java.util.regex.Pattern.sequence(Pattern.java:1878)
	at java.util.regex.Pattern.expr(Pattern.java:1752)
	at java.util.regex.Pattern.compile(Pattern.java:1460)
	at java.util.regex.Pattern.<init>(Pattern.java:1133)
	at java.util.regex.Pattern.compile(Pattern.java:823)
	at java.util.regex.Pattern.matches(Pattern.java:928)
	at java.lang.String.matches(String.java:2090)
	at org.apache.axis2.transport.http.ProxyConfiguration.validateNonProxyHosts(ProxyConfiguration.java:261)
	at org.apache.axis2.transport.http.ProxyConfiguration.isProxyEnabled(ProxyConfiguration.java:223)
	at org.apache.axis2.transport.http.AbstractHTTPSender.getHostConfiguration(AbstractHTTPSender.java:271)
	at org.apache.axis2.transport.http.AbstractHTTPSender.executeMethod(AbstractHTTPSender.java:502)
	at org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:191)
	at org.apache.axis2.transport.http.HTTPSender.send(HTTPSender.java:77)
	at org.apache.axis2.transport.http.CommonsHTTPTransportSender.writeMessageWithCommons(CommonsHTTPTransportSender.java:327)
	at org.apache.axis2.transport.http.CommonsHTTPTransportSender.invoke(CommonsHTTPTransportSender.java:206)
	at org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:396)
	at org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:374)
	at org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:211)
	at org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
	at org.apache.ode.axis2.SoapExternalService$1$1.call(SoapExternalService.java:201)
	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
	at java.util.concurrent.FutureTask.run(FutureTask.java:138)
	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
	at java.lang.Thread.run(Thread.java:637)
DEBUG - GeronimoLog.debug(66) | replyWithFailure mex=hqejbhcnphr4u5nem8hvlr failureType=COMMUNICATION_ERROR description=Error sending message (mex={PartnerRoleMex#hqejbhcnphr4u5nem8hvlr [PID {http://wso2.org/bps/samples/LoanProcess}LoanProcess-1] calling org.apache.ode.bpel.epr.WSAEndpoint@2e510e35.getCustomerSSN(...)}): Dangling meta character '*' near index 0
*.local
^ details=null
DEBUG - GeronimoLog.debug(66) | create work event for mex=hqejbhcnphr4u5nem8hvlr
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-4,5,main]: lock(iid=254, time=1MICROSECONDS)
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-4,5,main]: lock(iid=254, time=1MICROSECONDS)-->GRANTED
DEBUG - GeronimoLog.debug(66) | >> handleWorkEvent(jobData={mexid=hqejbhcnphr4u5nem8hvlr, iid=254, type=INVOKE_RESPONSE, channel=20})
DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for instance 254. INDEXED STATE={OSequence#47-sequence-activity-line-42::2=[SEQUENCE(self=(OSequence#47-sequence-activity-line-42,TerminationChannel#3,ParentScopeChannel#5), linkframe=org.apache.ode.bpel.runtime.LinkFrame@1552dc6d, remaining=[{OScope 'InvokeCustomerInfo' id=76}, {OAssign : Assign2, joinCondition=null}, {OScope 'InvokeCreditRating' id=93}, {OAssign : Assign3, joinCondition=null}, OFlow#159-LoanOfferFlow, {OAssign : PrepareOutput, joinCondition=null}, {OAssign : AssignDILoanOffer, joinCondition=null}, OReply#202-ReplyWithOffer])], OInvoke#77-InvokeCustomerInfo::12=[INVOKE(...)], {OScope 'InvokeCustomerInfo' id=76}::10=[SCOPE(...)], OSequence#47-sequence-activity-line-42::1=[ACTIVITYGUARD(...)], {OScope 'InvokeCustomerInfo' id=76}::10=[ACTIVE(...)], OInvoke#77-InvokeCustomerInfo::11=[ACTIVITYGUARD(...)], {OScope '__PROCESS_SCOPE:LoanProcess' id=15}::0=[SCOPE(...)], {OScope 'InvokeCustomerInfo' id=76}::9=[ACTIVITYGUARD(...)], {OScope '__PROCESS_SCOPE:LoanProcess' id=15}::0=[ACTIVE(...)]}
DEBUG - GeronimoLog.debug(66) | InvokeResponse event for iid 254
DEBUG - GeronimoLog.debug(66) | Invoking message response for mexid hqejbhcnphr4u5nem8hvlr and channel 20
DEBUG - GeronimoLog.debug(66) | Triggering response
ERROR - GeronimoLog.error(104) | Failure during invoke: Error sending message (mex={PartnerRoleMex#hqejbhcnphr4u5nem8hvlr [PID {http://wso2.org/bps/samples/LoanProcess}LoanProcess-1] calling org.apache.ode.bpel.epr.WSAEndpoint@2e510e35.getCustomerSSN(...)}): Dangling meta character '*' near index 0
*.local
^
INFO - GeronimoLog.info(79) | ActivityRecovery: Registering activity 11, failure reason: Error sending message (mex={PartnerRoleMex#hqejbhcnphr4u5nem8hvlr [PID {http://wso2.org/bps/samples/LoanProcess}LoanProcess-1] calling org.apache.ode.bpel.epr.WSAEndpoint@2e510e35.getCustomerSSN(...)}): Dangling meta character '*' near index 0
*.local
^ on channel 21
DEBUG - GeronimoLog.debug(66) | Setting execution state on instance 254
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-4,5,main]: unlock(iid=254)
DEBUG - GeronimoLog.debug(66) | Received myrole mex response callback
DEBUG - GeronimoLog.debug(66) | Handling response for MEX {MyRoleMex#hqejbhcnphr4u5nem8hvlm [Client hqejbhcnphr4u5nem8hvll] calling {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)}
DEBUG - GeronimoLog.debug(66) | Starting transaction.
DEBUG - GeronimoLog.debug(66) | Failure response message: null
WARN - GeronimoLog.warn(96) | MEX produced a fault {MyRoleMex#hqejbhcnphr4u5nem8hvlm [Client hqejbhcnphr4u5nem8hvll] calling {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)}
org.apache.ode.axis2.OdeFault: Message exchange failure due to: Error sending message (mex={PartnerRoleMex#hqejbhcnphr4u5nem8hvlr [PID {http://wso2.org/bps/samples/LoanProcess}LoanProcess-1] calling org.apache.ode.bpel.epr.WSAEndpoint@2e510e35.getCustomerSSN(...)}): Dangling meta character '*' near index 0
*.local
^
	at org.apache.ode.axis2.util.SoapMessageConverter.createOdeFault(SoapMessageConverter.java:570)
	at org.apache.ode.axis2.ODEService.onResponse(ODEService.java:282)
	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:189)
	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:69)
	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:52)
	at org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:96)
	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:145)
	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:120)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
	at java.lang.Thread.run(Thread.java:637)
DEBUG - GeronimoLog.debug(66) | Releasing mex hqejbhcnphr4u5nem8hvlm
DEBUG - GeronimoLog.debug(66) | Comitting transaction.




Michael Dondrup
Post-doctoral researcher
Uni BCCS
Thormøhlensgate 55, N-5008 Bergen, Norway
Phone: +47 55584157 Fax: +47 55584295
Please note my new phone number



Am Dec 17, 2009 um 4:52 PM schrieb Michael Dondrup:

> Hi,
> 
> I appreciate very much the example of asynchronous service invocation given here. I am currently testing this with ODE 2 beta. 
> I have successfully deployed both processes in ODE 2 after changing the the SOAP addresses in the wsdls to http://localhost:8080/ode/processes/[....
> I call the service at http://localhost:8080/ode/processes/LoanProcessService using SoapUI, then after a few seconds I get an exception back.
> 
> Am I doing something wrong and has anybody got this working? Any help is appreciated.
> 
> Best
> Michael
> 
> 
> Request:
> 
> <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://wso2.org/bps/samples/loan_process/schema">
>   <soapenv:Header/>
>   <soapenv:Body>
>      <sch:LoanRequest>
>         <sch:CustomerInfo>
>            <!--type: string-->
>            <sch:Name>gero et</sch:Name>
>            <!--type: string-->
>            <sch:Email>sonoras imperio</sch:Email>
>            <!--type: CustomerIDType-->
>            <sch:CustomerID>quae divum incedo</sch:CustomerID>
>            <!--type: int-->
>            <sch:CreditRating>3</sch:CreditRating>
>         </sch:CustomerInfo>
>         <sch:LoanInfo>
>            <!--type: double-->
>            <sch:Amount>1000</sch:Amount>
>            <!--type: int-->
>            <sch:Years>3</sch:Years>
>         </sch:LoanInfo>
>      </sch:LoanRequest>
>   </soapenv:Body>
> </soapenv:Envelope>
> 
> Response:
> <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
>   <soapenv:Body>
>      <soapenv:Fault xmlns:java="java:package org.apache.ode.axis2">
>         <faultcode>java:org.apache.ode.axis2.OdeFault</faultcode>
>         <faultstring>Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest caused an exception.</faultstring>
>         <detail>
>            <Exception>org.apache.ode.axis2.OdeFault: Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest caused an exception.
> 	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:135)
> 	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:67)
> 	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:50)
> 	at org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
> 	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
> 	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> 	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> 	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> 	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> 	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> 	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> 	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> 	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> 	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> 	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> 	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> 	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> 	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> 	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> 	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> 	at java.lang.Thread.run(Thread.java:637)
> Caused by: org.apache.ode.axis2.OdeFault: Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest timed out.
> 	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:121)
> 	... 22 more</Exception>
>         </detail>
>      </soapenv:Fault>
>   </soapenv:Body>
> </soapenv:Envelope>
> 
> This seems to be the real source of error
> ERROR - GeronimoLog.error(108) | 
> java.lang.NullPointerException
> 	at org.apache.ode.axis2.hooks.ODEAxisServiceDispatcher.findService(ODEAxisServiceDispatcher.java:80)
> 	at org.apache.axis2.engine.AbstractDispatcher.invoke(AbstractDispatcher.java:91)
> 
> 
> 
> And here is the complete catalina log of the interaction:
> 
> 
> DEBUG - GeronimoLog.debug(66) | The system is checking for the operation using the following WSAAction: 
> DEBUG - GeronimoLog.debug(66) | Checking for Operation using SOAP message body's first child's local name : LoanRequest
> DEBUG - GeronimoLog.debug(66) | Received request message for LoanProcessService.{http://wso2.org/bps/samples/LoanProcess}laonRequest
> DEBUG - GeronimoLog.debug(66) | ODE routed to operation Operation: name=laonRequest
> style=REQUEST_RESPONSE,1
> Input: name=input
> Message: name={http://wso2.org/bps/samples/LoanProcess}laonRequestRequest
> Part: name=part
> elementName={http://wso2.org/bps/samples/loan_process/schema}LoanRequest
> Output: name=output
> Message: name={http://wso2.org/bps/samples/LoanProcess}laonRequestResponse
> Part: name=part
> elementName={http://wso2.org/bps/samples/loan_process/schema}LoanOffer from service {http://wso2.org/bps/samples/LoanProcess}LoanProcessService
> DEBUG - GeronimoLog.debug(66) | Invoking ODE using MEX {MyRoleMex#hqejbhcnphr4u55emnjqir [Client null] calling {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest(...)}
> DEBUG - GeronimoLog.debug(66) | Message content:  <?xml version="1.0" encoding="UTF-8"?>
> <message><part><LoanRequest xmlns="http://wso2.org/bps/samples/loan_process/schema" xmlns:sch="http://wso2.org/bps/samples/loan_process/schema" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/">
>         <CustomerInfo>
> 
>            <Name>gero et</Name>
> 
>            <Email>sonoras imperio</Email>
> 
>            <CustomerID>quae divum incedo</CustomerID>
> 
>            <CreditRating>3</CreditRating>
>         </CustomerInfo>
>         <LoanInfo>
> 
>            <Amount>1000</Amount>
> 
>            <Years>3</Years>
>         </LoanInfo>
>      </LoanRequest></part></message>
> DEBUG - GeronimoLog.debug(66) | invoke() EPR= null ==> ODEProcess[{http://wso2.org/bps/samples/LoanProcess}LoanProcess-9]
> DEBUG - GeronimoLog.debug(66) | INPUTMSG: 42.laonRequest: MSG RCVD keys=[{CorrelationKey setId=41, values=[quae divum incedo]}] mySessionId=null partnerSessionId=null
> DEBUG - GeronimoLog.debug(66) | INPUTMSG: 42.laonRequest: routing failed, CREATING NEW INSTANCE
> DEBUG - GeronimoLog.debug(66) | enqueue: for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806: org.apache.ode.bpel.engine.BpelInstanceWorker$1@4d3e20dc
> DEBUG - GeronimoLog.debug(66) | enqueuRunnable for process {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9: {BpelInstanceWorker for {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806}
> DEBUG - GeronimoLog.debug(66) | Starting worker thread Thread[ODEServerImpl-13,5,main] for instance IID {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806
> DEBUG - GeronimoLog.debug(66) | Doing work for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806 in thread Thread[ODEServerImpl-13,5,main]
> DEBUG - GeronimoLog.debug(66) | Doing work for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806 in thread Thread[ODEServerImpl-12,5,main]
> DEBUG - GeronimoLog.debug(66) | SELECT: 19: USING CORRELATOR 42.laonRequest
> DEBUG - GeronimoLog.debug(66) | SELECT: 19: CHECKING for NEW INSTANCE match
> DEBUG - GeronimoLog.debug(66) | INPUTMSGMATCH: Changing process instance state from ready to active
> DEBUG - GeronimoLog.debug(66) | SELECT: 19: FOUND match for NEW instance mexRef=org.apache.ode.dao.jpa.MessageExchangeDAOImpl@6c62aa33
> DEBUG - GeronimoLog.debug(66) | INVOKING PARTNER: partnerLink={PartnerLinkInstance partnerLinkDecl=OPartnerLink#44,scopeInstanceId=860}, op=getCustomerSSN channel=30)
> DEBUG - GeronimoLog.debug(66) | Resolving endpoint reference <?xml version="1.0" encoding="UTF-8"?>
> <service-ref xmlns="http://docs.oasis-open.org/wsbpel/2.0/serviceref"><EndpointReference xmlns="http://www.w3.org/2005/08/addressing"><Metadata><ServiceName xmlns="http://www.w3.org/2006/05/addressing/wsdl" EndpointName="CustomerInfoPort" xmlns:servicens="http://wso2.org/bps/samples/CustomerInfo">servicens:CustomerInfoService</ServiceName></Metadata><Address>http://localhost:8080/ode/processes/CustomerInfoService</Address></EndpointReference></service-ref>
> DEBUG - GeronimoLog.debug(66) | Setting myRoleMex session ids for p2p interaction, mySession null - partnerSess null
> DEBUG - GeronimoLog.debug(66) | INVOKE PARTNER (SEP): sessionId=null partnerSessionId=null
> DEBUG - GeronimoLog.debug(66) | schedulingRunnable for process {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9: org.apache.ode.bpel.engine.PartnerLinkPartnerRoleImpl$UnreliableInvoker@1a8202f4
> DEBUG - GeronimoLog.debug(66) | Creating invocation check event for mexid hqejbhcnphr4u55emnjqiv
> DEBUG - GeronimoLog.debug(66) | CACHE SAVE: #1 for instance 806
> DEBUG - GeronimoLog.debug(66) | Finished work for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806 in thread Thread[ODEServerImpl-12,5,main]
> DEBUG - GeronimoLog.debug(66) | Finished work for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806 in thread Thread[ODEServerImpl-13,5,main]
> DEBUG - GeronimoLog.debug(66) | Worker thread Thread[ODEServerImpl-13,5,main] for instance IID 806 ran out of work. 
> DEBUG - GeronimoLog.debug(66) | Invoking a partner operation: getCustomerSSN
> DEBUG - GeronimoLog.debug(66) | The service to invoke is the external service {http://wso2.org/bps/samples/CustomerInfo}CustomerInfoService:CustomerInfoPort
> DEBUG - GeronimoLog.debug(66) | Resolving endpoint reference <?xml version="1.0" encoding="UTF-8"?>
> <service-ref xmlns="http://docs.oasis-open.org/wsbpel/2.0/serviceref"><EndpointReference xmlns="http://www.w3.org/2005/08/addressing"><Metadata><ServiceName EndpointName="CustomerInfoPort" xmlns="http://www.w3.org/2006/05/addressing/wsdl" xmlns:servicens="http://wso2.org/bps/samples/CustomerInfo">servicens:CustomerInfoService</ServiceName></Metadata><Address>http://localhost:8080/ode/processes/CustomerInfoService</Address></EndpointReference></service-ref>
> DEBUG - GeronimoLog.debug(66) | My-Role EPR not specified, SEP will not be used.
> DEBUG - GeronimoLog.debug(66) | Axis2 sending message to http://localhost:8080/ode/processes/CustomerInfoService using MEX {PartnerRoleMex#hqejbhcnphr4u55emnjqiv [PID null] calling org.apache.ode.il.epr.WSAEndpoint@1d9f0336.getCustomerSSN(...)}
> DEBUG - GeronimoLog.debug(66) | Message: <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><CustomerInfo xmlns="http://wso2.org/bps/samples/loan_process/schema">
>                            <Name>gero et</Name>
>                            <Email>sonoras imperio</Email>
>                            <CustomerID>quae divum incedo</CustomerID>
>                            <CreditRating>3</CreditRating>
>                        </CustomerInfo></soapenv:Body></soapenv:Envelope>
> DEBUG - GeronimoLog.debug(66) | Sending stateful TO epr in message header using session null
> DEBUG - GeronimoLog.debug(66) | Sending a message containing wsa endpoints in headers for session passing.
> DEBUG - GeronimoLog.debug(66) | <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header><addr:To xmlns:addr="http://www.w3.org/2005/08/addressing">http://localhost:8080/ode/processes/CustomerInfoService</addr:To><addr:Action xmlns:addr="http://www.w3.org/2005/08/addressing"></addr:Action><addr:ReplyTo xmlns:addr="http://www.w3.org/2005/08/addressing"><addr:Address>http://www.w3.org/2005/08/addressing/anonymous</addr:Address></addr:ReplyTo><addr:MessageID xmlns:addr="http://www.w3.org/2005/08/addressing">uuid:hqejbhcnphr4u55emnjqix</addr:MessageID></soapenv:Header><soapenv:Body><CustomerInfo xmlns="http://wso2.org/bps/samples/loan_process/schema">
>                            <Name>gero et</Name>
>                            <Email>sonoras imperio</Email>
>                            <CustomerID>quae divum incedo</CustomerID>
>                            <CreditRating>3</CreditRating>
>                        </CustomerInfo></soapenv:Body></soapenv:Envelope>
> DEBUG - GeronimoLog.debug(66) | Checking for Service using target endpoint address : http://localhost:8080/ode/processes/CustomerInfoService
> DEBUG - GeronimoLog.debug(66) | Found service in registry from name CustomerInfoService: null
> ERROR - GeronimoLog.error(108) | 
> java.lang.NullPointerException
> 	at org.apache.ode.axis2.hooks.ODEAxisServiceDispatcher.findService(ODEAxisServiceDispatcher.java:80)
> 	at org.apache.axis2.engine.AbstractDispatcher.invoke(AbstractDispatcher.java:91)
> 	at org.apache.axis2.engine.Phase.invoke(Phase.java:317)
> 	at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:264)
> 	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:163)
> 	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> 	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> 	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> 	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> 	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> 	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> 	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> 	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> 	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> 	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> 	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> 	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> 	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> 	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> 	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> 	at java.lang.Thread.run(Thread.java:637)
> DEBUG - GeronimoLog.debug(66) | Service response:
> <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><soapenv:Fault><faultcode>soapenv:Server</faultcode><faultstring>java.lang.NullPointerException</faultstring><detail><Exception>org.apache.axis2.AxisFault: java.lang.NullPointerException
> 	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:195)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> 	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> 	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> 	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> 	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> 	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> 	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> 	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> 	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> 	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> 	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> 	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> 	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> 	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> 	at java.lang.Thread.run(Thread.java:637)
> Caused by: java.lang.NullPointerException
> 	at org.apache.ode.axis2.hooks.ODEAxisServiceDispatcher.findService(ODEAxisServiceDispatcher.java:80)
> 	at org.apache.axis2.engine.AbstractDispatcher.invoke(AbstractDispatcher.java:91)
> 	at org.apache.axis2.engine.Phase.invoke(Phase.java:317)
> 	at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:264)
> 	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:163)
> 	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> 	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> 	... 16 more
> </Exception></detail></soapenv:Fault></soapenv:Body></soapenv:Envelope>
> DEBUG - GeronimoLog.debug(66) | Received response for MEX {PartnerRoleMex#hqejbhcnphr4u55emnjqiv [PID null] calling org.apache.ode.il.epr.WSAEndpoint@1d9f0336.getCustomerSSN(...)}
> WARN - GeronimoLog.warn(92) | Fault response: faultType=(unkown)
> <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><soapenv:Fault><faultcode>soapenv:Server</faultcode><faultstring>java.lang.NullPointerException</faultstring><detail><Exception>org.apache.axis2.AxisFault: java.lang.NullPointerException
> 	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:195)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> 	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> 	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> 	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> 	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> 	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> 	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> 	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> 	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> 	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> 	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> 	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> 	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> 	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> 	at java.lang.Thread.run(Thread.java:637)
> Caused by: java.lang.NullPointerException
> 	at org.apache.ode.axis2.hooks.ODEAxisServiceDispatcher.findService(ODEAxisServiceDispatcher.java:80)
> 	at org.apache.axis2.engine.AbstractDispatcher.invoke(AbstractDispatcher.java:91)
> 	at org.apache.axis2.engine.Phase.invoke(Phase.java:317)
> 	at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:264)
> 	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:163)
> 	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> 	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> 	... 16 more
> </Exception></detail></soapenv:Fault></soapenv:Body></soapenv:Envelope>
> DEBUG - GeronimoLog.debug(66) | replyWithFailure mex=hqejbhcnphr4u55emnjqiv
> DEBUG - GeronimoLog.debug(66) | enqueue: for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806: org.apache.ode.bpel.engine.BpelServerImpl$TransactedRunnable@3b293677
> DEBUG - GeronimoLog.debug(66) | enqueuRunnable for process {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9: {BpelInstanceWorker for {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806}
> DEBUG - GeronimoLog.debug(66) | Starting worker thread Thread[ODEServerImpl-14,5,main] for instance IID {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806
> DEBUG - GeronimoLog.debug(66) | Doing work for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806 in thread Thread[ODEServerImpl-14,5,main]
> DEBUG - GeronimoLog.debug(66) | <invoke> response for mexid hqejbhcnphr4u55emnjqiv and channel 30
> INFO - GeronimoLog.info(79) | ActivityRecovery: Registering activity 11, failure reason:  on channel 31
> DEBUG - GeronimoLog.debug(66) | CACHE SAVE: #2 for instance 806
> DEBUG - GeronimoLog.debug(66) | Finished work for instance {http://wso2.org/bps/samples/LoanProcess}LoanProcess-9#806 in thread Thread[ODEServerImpl-14,5,main]
> DEBUG - GeronimoLog.debug(66) | Worker thread Thread[ODEServerImpl-14,5,main] for instance IID 806 ran out of work. 
> ERROR - GeronimoLog.error(108) | Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest timed out.
> java.util.concurrent.TimeoutException
> 	at org.apache.ode.bpel.engine.UnreliableMyRoleMessageExchangeImpl$ResponseFuture.get(UnreliableMyRoleMessageExchangeImpl.java:99)
> 	at org.apache.ode.bpel.engine.UnreliableMyRoleMessageExchangeImpl$ResponseFuture.get(UnreliableMyRoleMessageExchangeImpl.java:76)
> 	at org.apache.ode.bpel.engine.UnreliableMyRoleMessageExchangeImpl.invokeBlocking(UnreliableMyRoleMessageExchangeImpl.java:66)
> 	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:117)
> 	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:67)
> 	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:50)
> 	at org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
> 	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
> 	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> 	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> 	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> 	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> 	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> 	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> 	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> 	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> 	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> 	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> 	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> 	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> 	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> 	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> 	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> 	at java.lang.Thread.run(Thread.java:637)
> ERROR - GeronimoLog.error(108) | Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest caused an exception.
> org.apache.ode.axis2.OdeFault: Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest timed out.
> 	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:121)
> 	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:67)
> 	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:50)
> 	at org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
> 	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
> 	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> 	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> 	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> 	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> 	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> 	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> 	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> 	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> 	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> 	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> 	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> 	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> 	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> 	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> 	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> 	at java.lang.Thread.run(Thread.java:637)
> DEBUG - GeronimoLog.debug(66) | Releasing mex hqejbhcnphr4u55emnjqir
> ERROR - GeronimoLog.error(108) | Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest caused an exception.
> org.apache.ode.axis2.OdeFault: Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest caused an exception.
> 	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:135)
> 	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:67)
> 	at org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:50)
> 	at org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
> 	at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
> 	at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> 	at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:647)
> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
> 	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
> 	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
> 	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
> 	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
> 	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
> 	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
> 	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
> 	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:174)
> 	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:873)
> 	at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
> 	at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
> 	at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
> 	at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
> 	at java.lang.Thread.run(Thread.java:637)
> Caused by: org.apache.ode.axis2.OdeFault: Call to {http://wso2.org/bps/samples/LoanProcess}LoanProcessService.laonRequest timed out.
> 	at org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:121)
> 	... 22 more
> 
> 
> Am Nov 15, 2009 um 5:27 PM schrieb Markus Piff:
> 
>> Thank you kindly!
>> 
>> Cheers
>> Markus
>> 
>> On Thu, Nov 12, 2009 at 5:43 AM, Milinda Pathirage
>> <mi...@gmail.com> wrote:
>>> Hi Markus,
>>> 
>>> Look at the following BPEL samples we have created for WSO2 BPS.
>>> 
>>> Asynchronous BPEL :
>>> https://wso2.org/repos/wso2/branches/bps/1.1.0/product/modules/samples/src/main/resources/bpel/2.0/LoanService/
>>> 
>>> BPEL Process which calls above async process:
>>> https://wso2.org/repos/wso2/branches/bps/1.1.0/product/modules/samples/src/main/resources/bpel/2.0/LoanProcess/
>>> 
>>> 
>>> Thanks
>>> Milinda
>>> 
>>> 
>>> On Wed, Nov 11, 2009 at 6:47 PM, Markus Piff <ma...@gmail.com> wrote:
>>> 
>>>> Hi,
>>>> 
>>>> I'm currently engaged in working on an asynchronous bpel process,
>>>> however at the time of this writing I haven't managed to create a
>>>> working example.
>>>> Therefore it would be great if someone had a working example, which
>>>> he/she could provide.
>>>> 
>>>> Cheers
>>>> Markus
>>>> 
>>> 
>>> 
>>> 
>>> --
>>> Milinda Pathirage
>>> Senior Software Engineer & Product Manager WSO2 BPS; http://wso2.org/bps
>>> WSO2 Inc.; http://wso2.com
>>> E-mail: milinda@wso2.com, milinda.pathirage@gmail.com
>>> Web: http://mpathirage.com
>>> Blog: http://blog.mpathirage.com
>>> 
>