You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@ode.apache.org by Surendar <su...@7strata.com> on 2009/04/02 13:45:42 UTC

Error while calling the CXF Service from Apache ode

Hi all,

I am trying to call the CXF service from ode, wher my flow is like this

1. Receive the input
2.Assign the input to operation1 in cxf service as input
3. invoke the operation1 of cxf service,
4.Assign the output of the operation1 to input of the operation2 of cxf 
service(Here iam getting the problem) as follows


DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: 
lock(iid=201, time=1MICROSECONDS)
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: 
lock(iid=201, time=1MICROSECONDS)-->GRANTED
INFO - GeronimoLog.info(79) | Received a scheduled job event for 
inactive process null; rescheduling job hqejbhcnphr45xe6x8a1ft for 
2/4/09 5:11 PM
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
DEBUG - GeronimoLog.debug(66) | Received request message for 
EmployeeArtifactService.{http://employee.process.com}process
DEBUG - GeronimoLog.debug(66) | Starting transaction.
DEBUG - GeronimoLog.debug(66) | Routed: svcQname 
{http://employee.process.com}EmployeeArtifactService --> 
BpelProcess[{http://employee.process.com}EmployeeProcess-7]
DEBUG - GeronimoLog.debug(66) | ODE routed to operation Operation: 
name=process
style=REQUEST_RESPONSE,1
Input: name=null
Message: name={http://employee.process.com}EmployeeProcessRequestMessage
Part: name=payload
elementName={http://employee.process.com}EmployeeProcessRequest
Output: name=null
Message: name={http://employee.process.com}EmployeeProcessResponseMessage
Part: name=payload
elementName={http://employee.process.com}EmployeeProcessResponse from 
service {http://employee.process.com}EmployeeArtifactService
DEBUG - GeronimoLog.debug(66) | Invoking ODE using MEX 
{MyRoleMex#hqejbhcnphr45xgkgkqmc7 [Client hqejbhcnphr45xgkgkqmc6] 
calling {http://employee.process.com}EmployeeArtifactService.process(...)}
DEBUG - GeronimoLog.debug(66) | Message content:  <?xml version="1.0" 
encoding="UTF-8"?>
<message><payload><EmployeeProcessRequest 
xmlns="http://employee.process.com" 
xmlns:q0="http://employee.process.com" 
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" 
xmlns:xsd="http://www.w3.org/2001/XMLSchema" 
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance">
<input>121</input>
</EmployeeProcessRequest></payload></message>
DEBUG - GeronimoLog.debug(66) | Routed: svcQname 
{http://employee.process.com}EmployeeArtifactService --> 
BpelProcess[{http://employee.process.com}EmployeeProcess-7]
DEBUG - GeronimoLog.debug(66) | invoke() EPR= null ==> 
BpelProcess[{http://employee.process.com}EmployeeProcess-7]
DEBUG - GeronimoLog.debug(66) | Commiting ODE MEX 
{MyRoleMex#hqejbhcnphr45xgkgkqmc7 [Client hqejbhcnphr45xgkgkqmc6] 
calling {http://employee.process.com}EmployeeArtifactService.process(...)}
DEBUG - GeronimoLog.debug(66) | Commiting transaction.
DEBUG - GeronimoLog.debug(66) | >> 
handleWorkEvent(jobData={type=INVOKE_INTERNAL, 
mexid=hqejbhcnphr45xgkgkqmc7, 
pid={http://employee.process.com}EmployeeProcess-7})
DEBUG - GeronimoLog.debug(66) | InvokeInternal event for mexid 
hqejbhcnphr45xgkgkqmc7
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: 36.process: MSG RCVD keys=[] 
mySessionId=null partnerSessionId=null
DEBUG - GeronimoLog.debug(66) | INPUTMSG: 36.process: routing failed, 
CREATING NEW INSTANCE
DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for 
instance 2501. INDEXED STATE={}
DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: USING 
CORRELATOR 36.process
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#hqejbhcnphr45xgkgkqmc7 [Client 
hqejbhcnphr45xgkgkqmc6] calling 
{http://employee.process.com}EmployeeArtifactService.process(...)}
DEBUG - GeronimoLog.debug(66) | INVOKING PARTNER: 
partnerLink={PartnerLinkInstance 
partnerLinkDecl=OPartnerLink#37,scopeInstanceId=2551}, 
op=getEmployeeObject channel=InvokeResponseChannel#20)
DEBUG - GeronimoLog.debug(66) | INVOKE PARTNER (SEP): sessionId=null 
partnerSessionId=null
DEBUG - GeronimoLog.debug(66) | Routed: svcQname 
{http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/}EmployeeImplService 
--> null
DEBUG - GeronimoLog.debug(66) | Invoking a partner operation: 
getEmployeeObject
DEBUG - GeronimoLog.debug(66) | The service to invoke is the external 
service 
{http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/}EmployeeImplService:EmployeeImplPort
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="EmployeeImplPort" 
xmlns:servicens="http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/">servicens:EmployeeImplService</ServiceName></Metadata><Address>http://localhost:8989/rcsimsservice/rcsimsservice</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:8989/rcsimsservice/rcsimsservice using MEX 
{PartnerRoleMex#hqejbhcnphr45xgkgkqmca [PID 
{http://employee.process.com}EmployeeProcess-7] calling 
org.apache.ode.bpel.epr.WSAEndpoint@75a30f.getEmployeeObject(...)}
DEBUG - GeronimoLog.debug(66) | Message: <?xml version='1.0' 
encoding='utf-8'?><soapenv:Envelope 
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><getEmployeeObjectRequest 
xmlns="http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/">
  <value>121</value>
</getEmployeeObjectRequest></soapenv:Body></soapenv:Envelope>
DEBUG - GeronimoLog.debug(66) | 
org.apache.ode.axis2.SoapExternalService$CachedOptions$1@ec44cb has been 
modified
DEBUG - GeronimoLog.debug(66) | Translating IL Properties for Axis2
DEBUG - GeronimoLog.debug(66) | replyAsync mex=hqejbhcnphr45xgkgkqmca
DEBUG - GeronimoLog.debug(66) | Setting execution state on instance 2501
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:8989/rcsimsservice/rcsimsservice</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:hqejbhcnphr45xgkgkqmcb</addr:MessageID></soapenv:Header><soapenv:Body><getEmployeeObjectRequest 
xmlns="http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/">
  <value>121</value>
</getEmployeeObjectRequest></soapenv:Body></soapenv:Envelope>
DEBUG - GeronimoLog.debug(66) | Service response:
<?xml version='1.0' encoding='utf-8'?><soap:Envelope 
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><soap:Body><ns2:getEmployeeObjectResponse 
xmlns:ns2="http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/"><employeeObjectreturn><empID>0</empID><empName>Surendar</empName><salary>100000.0</salary></employeeObjectreturn></ns2:getEmployeeObjectResponse></soap:Body></soap:Envelope>
DEBUG - GeronimoLog.debug(66) | Received response for MEX 
{PartnerRoleMex#hqejbhcnphr45xgkgkqmca [PID 
{http://employee.process.com}EmployeeProcess-7] calling 
null.getEmployeeObject(...)}
INFO - GeronimoLog.info(79) | Response:
<?xml version="1.0" encoding="UTF-8"?>
<message><parameters><getEmployeeObjectResponse 
xmlns="http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/" 
xmlns:ns2="http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/" 
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/"><employeeObjectreturn 
xmlns=""><empID>0</empID><empName>Surendar</empName><salary>100000.0</salary></employeeObjectreturn></getEmployeeObjectResponse></parameters></message>
DEBUG - GeronimoLog.debug(66) | reply mex=hqejbhcnphr45xgkgkqmca
DEBUG - GeronimoLog.debug(66) | create work event for 
mex=hqejbhcnphr45xgkgkqmca
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: 
lock(iid=2501, time=1MICROSECONDS)
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: 
lock(iid=2501, time=1MICROSECONDS)-->GRANTED
DEBUG - GeronimoLog.debug(66) | >> 
handleWorkEvent(jobData={type=INVOKE_RESPONSE, 
mexid=hqejbhcnphr45xgkgkqmca, channel=20, iid=2501})
DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for 
instance 2501. INDEXED 
STATE={OSequence#38-main::2=[SEQUENCE(self=(OSequence#38-main,TerminationChannel#3,ParentScopeChannel#5), 
linkframe=org.apache.ode.bpel.runtime.LinkFrame@47e53a, 
remaining=[{OScope 'InvokeEmpReq' id=52}, {OAssign : AssignToDept, 
joinCondition=null}, {OScope 'InvokeDeptReq' id=68}, {OAssign : 
AssignReply, joinCondition=null}, OReply#84-replyOutput])], 
OInvoke#53-InvokeEmpReq::12=[INVOKE(...)], {OScope 
'__PROCESS_SCOPE:EmployeeProcess' id=3}::0=[ACTIVE(...)], {OScope 
'__PROCESS_SCOPE:EmployeeProcess' id=3}::0=[SCOPE(...)], 
OSequence#38-main::1=[ACTIVITYGUARD(...)], {OScope 'InvokeEmpReq' 
id=52}::10=[ACTIVE(...)], {OScope 'InvokeEmpReq' 
id=52}::10=[SCOPE(...)], {OScope 'InvokeEmpReq' 
id=52}::9=[ACTIVITYGUARD(...)], 
OInvoke#53-InvokeEmpReq::11=[ACTIVITYGUARD(...)]}
DEBUG - GeronimoLog.debug(66) | InvokeResponse event for iid 2501
DEBUG - GeronimoLog.debug(66) | Invoking message response for mexid 
hqejbhcnphr45xgkgkqmca and channel 20
DEBUG - GeronimoLog.debug(66) | Triggering response
*ERROR - GeronimoLog.error(104) | Assignment Fault: 
{http://docs.oasis-open.org/wsbpel/2.0/process/executable}selectionFailure,lineNo=151,faultExplanation=No 
results for expression: {OXPath10Expression emp:employeeObjectreturn}*
DEBUG - GeronimoLog.debug(66) | ProcessImpl completed with fault 
'{http://docs.oasis-open.org/wsbpel/2.0/process/executable}selectionFailure'
DEBUG - GeronimoLog.debug(66) | Processing an async reply from service 
{http://employee.process.com}EmployeeArtifactService
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=2501)
DEBUG - GeronimoLog.debug(66) | Received myrole mex response callback
DEBUG - GeronimoLog.debug(66) | Handling response for MEX 
{MyRoleMex#hqejbhcnphr45xgkgkqmc7 [Client hqejbhcnphr45xgkgkqmc6] 
calling {http://employee.process.com}EmployeeArtifactService.process(...)}
DEBUG - GeronimoLog.debug(66) | Starting transaction.
DEBUG - GeronimoLog.debug(66) | Fault response message: 
{http://docs.oasis-open.org/wsbpel/2.0/process/executable}selectionFailure
DEBUG - GeronimoLog.debug(66) | Returning fault: <?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 
xmlns:axis2ns1="http://docs.oasis-open.org/wsbpel/2.0/process/executable">axis2ns1:selectionFailure</faultstring><detail 
/></soapenv:Fault></soapenv:Body></soapenv:Envelope>
DEBUG - GeronimoLog.debug(66) | Releasing mex hqejbhcnphr45xgkgkqmc7
DEBUG - GeronimoLog.debug(66) | Comitting transaction.
DEBUG - GeronimoLog.debug(66) | Reply for 
EmployeeArtifactService.{http://employee.process.com}process
DEBUG - GeronimoLog.debug(66) | Reply message <?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 
xmlns:axis2ns1="http://docs.oasis-open.org/wsbpel/2.0/process/executable">axis2ns1:selectionFailure</faultstring><detail 
/></soapenv:Fault></soapenv:Body></soapenv:Envelope>
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: 
lock(iid=201, time=1MICROSECONDS)
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: 
lock(iid=201, time=1MICROSECONDS)-->GRANTED
INFO - GeronimoLog.info(79) | Received a scheduled job event for 
inactive process null; rescheduling job hqejbhcnphr45xgkgkqmc5 for 
2/4/09 5:12 PM
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: 
lock(iid=201, time=1MICROSECONDS)
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: 
lock(iid=201, time=1MICROSECONDS)-->GRANTED
INFO - GeronimoLog.info(79) | Received a scheduled job event for 
inactive process null; rescheduling job hqejbhcnphr45xgkgkqmcd for 
2/4/09 5:13 PM
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: 
lock(iid=201, time=1MICROSECONDS)
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: 
lock(iid=201, time=1MICROSECONDS)-->GRANTED
INFO - GeronimoLog.info(79) | Received a scheduled job event for 
inactive process null; rescheduling job hqejbhcnphr45xgkgkqmce for 
2/4/09 5:14 PM
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: 
lock(iid=201, time=1MICROSECONDS)
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: 
lock(iid=201, time=1MICROSECONDS)-->GRANTED
INFO - GeronimoLog.info(79) | Received a scheduled job event for 
inactive process null; rescheduling job hqejbhcnphr45xgkgkqmcf for 
2/4/09 5:15 PM
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)


I too attach my bpel project with this mail.


with regards

Surendar V



Re: Error while calling the CXF Service from Apache ode

Posted by Matthieu Riou <ma...@gmail.com>.
On Thu, Apr 2, 2009 at 4:45 AM, Surendar <su...@7strata.com> wrote:

> Hi all,
>
> I am trying to call the CXF service from ode, wher my flow is like this
>
> 1. Receive the input
> 2.Assign the input to operation1 in cxf service as input
> 3. invoke the operation1 of cxf service,
> 4.Assign the output of the operation1 to input of the operation2 of cxf
> service(Here iam getting the problem) as follows
>

You're getting the following selectionFailure (logged as error):

ERROR - GeronimoLog.error(104) | Assignment Fault: {
http://docs.oasis-open.org/wsbpel/2.0/process/executable}selectionFailure,lineNo=151,faultExplanation=No<http://docs.oasis-open.org/wsbpel/2.0/process/executable%7DselectionFailure,lineNo=151,faultExplanation=No>results
for expression: {OXPath10Expression emp:employeeObjectreturn}

So the <from> in the following assign doesn't select anything:

           <bpel:copy>
                <bpel:from part="parameters" variable="empoutput">
                    <bpel:query
queryLanguage="urn:oasis:names:tc:wsbpel:2.0:sublang:xpath1.0"><![CDATA[emp:employeeObjectreturn]]></bpel:query>
                </bpel:from>
                <bpel:to part="parameters" variable="apprisalinput">
                    <bpel:query
queryLanguage="urn:oasis:names:tc:wsbpel:2.0:sublang:xpath1.0"><![CDATA[emp:employees]]></bpel:query>
                </bpel:to>
            </bpel:copy>

The message you get back from your service call is:

<message><parameters><getEmployeeObjectResponse xmlns="
http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/" xmlns:ns2="
http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/" xmlns:soap="
http://schemas.xmlsoap.org/soap/envelope/"><employeeObjectreturn
xmlns=""><empID>0</empID><empName>Surendar</empName><salary>100000.0</salary></employeeObjectreturn></getEmployeeObjectResponse></parameters></message>

I don't see any emp:employees element in here, which explains the selection
failure.

Thanks,
Matthieu


>
>
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1MICROSECONDS)
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1MICROSECONDS)-->GRANTED
> INFO - GeronimoLog.info(79) | Received a scheduled job event for inactive
> process null; rescheduling job hqejbhcnphr45xe6x8a1ft for 2/4/09 5:11 PM
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
> DEBUG - GeronimoLog.debug(66) | Received request message for
> EmployeeArtifactService.{http://employee.process.com}process
> DEBUG - GeronimoLog.debug(66) | Starting transaction.
> DEBUG - GeronimoLog.debug(66) | Routed: svcQname {
> http://employee.process.com}EmployeeArtifactService --> BpelProcess[{
> http://employee.process.com}EmployeeProcess-7]
> DEBUG - GeronimoLog.debug(66) | ODE routed to operation Operation:
> name=process
> style=REQUEST_RESPONSE,1
> Input: name=null
> Message: name={http://employee.process.com}EmployeeProcessRequestMessage
> Part: name=payload
> elementName={http://employee.process.com}EmployeeProcessRequest
> Output: name=null
> Message: name={http://employee.process.com}EmployeeProcessResponseMessage
> Part: name=payload
> elementName={http://employee.process.com}EmployeeProcessResponse from
> service {http://employee.process.com}EmployeeArtifactService
> DEBUG - GeronimoLog.debug(66) | Invoking ODE using MEX
> {MyRoleMex#hqejbhcnphr45xgkgkqmc7 [Client hqejbhcnphr45xgkgkqmc6] calling {
> http://employee.process.com}EmployeeArtifactService.process(...)}
> DEBUG - GeronimoLog.debug(66) | Message content:  <?xml version="1.0"
> encoding="UTF-8"?>
> <message><payload><EmployeeProcessRequest xmlns="
> http://employee.process.com" xmlns:q0="http://employee.process.com"
> xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:xsd="
> http://www.w3.org/2001/XMLSchema" xmlns:xsi="
> http://www.w3.org/2001/XMLSchema-instance">
> <input>121</input>
> </EmployeeProcessRequest></payload></message>
> DEBUG - GeronimoLog.debug(66) | Routed: svcQname {
> http://employee.process.com}EmployeeArtifactService --> BpelProcess[{
> http://employee.process.com}EmployeeProcess-7]
> DEBUG - GeronimoLog.debug(66) | invoke() EPR= null ==> BpelProcess[{
> http://employee.process.com}EmployeeProcess-7]
> DEBUG - GeronimoLog.debug(66) | Commiting ODE MEX
> {MyRoleMex#hqejbhcnphr45xgkgkqmc7 [Client hqejbhcnphr45xgkgkqmc6] calling {
> http://employee.process.com}EmployeeArtifactService.process(...)}
> DEBUG - GeronimoLog.debug(66) | Commiting transaction.
> DEBUG - GeronimoLog.debug(66) | >>
> handleWorkEvent(jobData={type=INVOKE_INTERNAL, mexid=hqejbhcnphr45xgkgkqmc7,
> pid={http://employee.process.com}EmployeeProcess-7})
> DEBUG - GeronimoLog.debug(66) | InvokeInternal event for mexid
> hqejbhcnphr45xgkgkqmc7
> 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: 36.process: MSG RCVD keys=[]
> mySessionId=null partnerSessionId=null
> DEBUG - GeronimoLog.debug(66) | INPUTMSG: 36.process: routing failed,
> CREATING NEW INSTANCE
> DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for instance
> 2501. INDEXED STATE={}
> DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: USING
> CORRELATOR 36.process
> 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#hqejbhcnphr45xgkgkqmc7 [Client
> hqejbhcnphr45xgkgkqmc6] calling {http://employee.process.com
> }EmployeeArtifactService.process(...)}
> DEBUG - GeronimoLog.debug(66) | INVOKING PARTNER:
> partnerLink={PartnerLinkInstance
> partnerLinkDecl=OPartnerLink#37,scopeInstanceId=2551}, op=getEmployeeObject
> channel=InvokeResponseChannel#20)
> DEBUG - GeronimoLog.debug(66) | INVOKE PARTNER (SEP): sessionId=null
> partnerSessionId=null
> DEBUG - GeronimoLog.debug(66) | Routed: svcQname {
> http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/}EmployeeImplService<http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/%7DEmployeeImplService>--> null
> DEBUG - GeronimoLog.debug(66) | Invoking a partner operation:
> getEmployeeObject
> DEBUG - GeronimoLog.debug(66) | The service to invoke is the external
> service {
> http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/}EmployeeImplService:EmployeeImplPort<http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/%7DEmployeeImplService:EmployeeImplPort>
> 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="EmployeeImplPort" xmlns:servicens="
> http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/
> ">servicens:EmployeeImplService</ServiceName></Metadata><Address>
> http://localhost:8989/rcsimsservice/rcsimsservice
> </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:8989/rcsimsservice/rcsimsservice using MEX
> {PartnerRoleMex#hqejbhcnphr45xgkgkqmca [PID {http://employee.process.com}EmployeeProcess-7]
> calling org.apache.ode.bpel.epr.WSAEndpoint@75a30f.getEmployeeObject(...)}
> DEBUG - GeronimoLog.debug(66) | Message: <?xml version='1.0'
> encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="
> http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><getEmployeeObjectRequest
> xmlns="http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/">
>  <value>121</value>
> </getEmployeeObjectRequest></soapenv:Body></soapenv:Envelope>
> DEBUG - GeronimoLog.debug(66) |
> org.apache.ode.axis2.SoapExternalService$CachedOptions$1@ec44cb has been
> modified
> DEBUG - GeronimoLog.debug(66) | Translating IL Properties for Axis2
> DEBUG - GeronimoLog.debug(66) | replyAsync mex=hqejbhcnphr45xgkgkqmca
> DEBUG - GeronimoLog.debug(66) | Setting execution state on instance 2501
> 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:8989/rcsimsservice/rcsimsservice</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:hqejbhcnphr45xgkgkqmcb</addr:MessageID></soapenv:Header><soapenv:Body><getEmployeeObjectRequest
> xmlns="http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/">
>  <value>121</value>
> </getEmployeeObjectRequest></soapenv:Body></soapenv:Envelope>
> DEBUG - GeronimoLog.debug(66) | Service response:
> <?xml version='1.0' encoding='utf-8'?><soap:Envelope xmlns:soap="
> http://schemas.xmlsoap.org/soap/envelope/"><soap:Body><ns2:getEmployeeObjectResponse
> xmlns:ns2="http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/
> "><employeeObjectreturn><empID>0</empID><empName>Surendar</empName><salary>100000.0</salary></employeeObjectreturn></ns2:getEmployeeObjectResponse></soap:Body></soap:Envelope>
> DEBUG - GeronimoLog.debug(66) | Received response for MEX
> {PartnerRoleMex#hqejbhcnphr45xgkgkqmca [PID {http://employee.process.com}EmployeeProcess-7]
> calling null.getEmployeeObject(...)}
> INFO - GeronimoLog.info(79) | Response:
> <?xml version="1.0" encoding="UTF-8"?>
> <message><parameters><getEmployeeObjectResponse xmlns="
> http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/" xmlns:ns2="
> http://emp.rcs.service.rapidserver.rapid.sevenstrata.com/" xmlns:soap="
> http://schemas.xmlsoap.org/soap/envelope/"><employeeObjectreturn
> xmlns=""><empID>0</empID><empName>Surendar</empName><salary>100000.0</salary></employeeObjectreturn></getEmployeeObjectResponse></parameters></message>
> DEBUG - GeronimoLog.debug(66) | reply mex=hqejbhcnphr45xgkgkqmca
> DEBUG - GeronimoLog.debug(66) | create work event for
> mex=hqejbhcnphr45xgkgkqmca
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=2501,
> time=1MICROSECONDS)
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=2501,
> time=1MICROSECONDS)-->GRANTED
> DEBUG - GeronimoLog.debug(66) | >>
> handleWorkEvent(jobData={type=INVOKE_RESPONSE, mexid=hqejbhcnphr45xgkgkqmca,
> channel=20, iid=2501})
> DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for instance
> 2501. INDEXED
> STATE={OSequence#38-main::2=[SEQUENCE(self=(OSequence#38-main,TerminationChannel#3,ParentScopeChannel#5),
> linkframe=org.apache.ode.bpel.runtime.LinkFrame@47e53a, remaining=[{OScope
> 'InvokeEmpReq' id=52}, {OAssign : AssignToDept, joinCondition=null}, {OScope
> 'InvokeDeptReq' id=68}, {OAssign : AssignReply, joinCondition=null},
> OReply#84-replyOutput])], OInvoke#53-InvokeEmpReq::12=[INVOKE(...)], {OScope
> '__PROCESS_SCOPE:EmployeeProcess' id=3}::0=[ACTIVE(...)], {OScope
> '__PROCESS_SCOPE:EmployeeProcess' id=3}::0=[SCOPE(...)],
> OSequence#38-main::1=[ACTIVITYGUARD(...)], {OScope 'InvokeEmpReq'
> id=52}::10=[ACTIVE(...)], {OScope 'InvokeEmpReq' id=52}::10=[SCOPE(...)],
> {OScope 'InvokeEmpReq' id=52}::9=[ACTIVITYGUARD(...)],
> OInvoke#53-InvokeEmpReq::11=[ACTIVITYGUARD(...)]}
> DEBUG - GeronimoLog.debug(66) | InvokeResponse event for iid 2501
> DEBUG - GeronimoLog.debug(66) | Invoking message response for mexid
> hqejbhcnphr45xgkgkqmca and channel 20
> DEBUG - GeronimoLog.debug(66) | Triggering response
> *ERROR - GeronimoLog.error(104) | Assignment Fault: {
> http://docs.oasis-open.org/wsbpel/2.0/process/executable}selectionFailure,lineNo=151,faultExplanation=No<http://docs.oasis-open.org/wsbpel/2.0/process/executable%7DselectionFailure,lineNo=151,faultExplanation=No>results for expression: {OXPath10Expression emp:employeeObjectreturn}*
> DEBUG - GeronimoLog.debug(66) | ProcessImpl completed with fault '{
> http://docs.oasis-open.org/wsbpel/2.0/process/executable}selectionFailure<http://docs.oasis-open.org/wsbpel/2.0/process/executable%7DselectionFailure>
> '
> DEBUG - GeronimoLog.debug(66) | Processing an async reply from service {
> http://employee.process.com}EmployeeArtifactService
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]:
> unlock(iid=2501)
> DEBUG - GeronimoLog.debug(66) | Received myrole mex response callback
> DEBUG - GeronimoLog.debug(66) | Handling response for MEX
> {MyRoleMex#hqejbhcnphr45xgkgkqmc7 [Client hqejbhcnphr45xgkgkqmc6] calling {
> http://employee.process.com}EmployeeArtifactService.process(...)}
> DEBUG - GeronimoLog.debug(66) | Starting transaction.
> DEBUG - GeronimoLog.debug(66) | Fault response message: {
> http://docs.oasis-open.org/wsbpel/2.0/process/executable}selectionFailure<http://docs.oasis-open.org/wsbpel/2.0/process/executable%7DselectionFailure>
> DEBUG - GeronimoLog.debug(66) | Returning fault: <?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
> xmlns:axis2ns1="http://docs.oasis-open.org/wsbpel/2.0/process/executable">axis2ns1:selectionFailure</faultstring><detail
> /></soapenv:Fault></soapenv:Body></soapenv:Envelope>
> DEBUG - GeronimoLog.debug(66) | Releasing mex hqejbhcnphr45xgkgkqmc7
> DEBUG - GeronimoLog.debug(66) | Comitting transaction.
> DEBUG - GeronimoLog.debug(66) | Reply for EmployeeArtifactService.{
> http://employee.process.com}process
> DEBUG - GeronimoLog.debug(66) | Reply message <?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
> xmlns:axis2ns1="http://docs.oasis-open.org/wsbpel/2.0/process/executable">axis2ns1:selectionFailure</faultstring><detail
> /></soapenv:Fault></soapenv:Body></soapenv:Envelope>
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1MICROSECONDS)
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1MICROSECONDS)-->GRANTED
> INFO - GeronimoLog.info(79) | Received a scheduled job event for inactive
> process null; rescheduling job hqejbhcnphr45xgkgkqmc5 for 2/4/09 5:12 PM
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1MICROSECONDS)
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1MICROSECONDS)-->GRANTED
> INFO - GeronimoLog.info(79) | Received a scheduled job event for inactive
> process null; rescheduling job hqejbhcnphr45xgkgkqmcd for 2/4/09 5:13 PM
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1MICROSECONDS)
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1MICROSECONDS)-->GRANTED
> INFO - GeronimoLog.info(79) | Received a scheduled job event for inactive
> process null; rescheduling job hqejbhcnphr45xgkgkqmce for 2/4/09 5:14 PM
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1MICROSECONDS)
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1MICROSECONDS)-->GRANTED
> INFO - GeronimoLog.info(79) | Received a scheduled job event for inactive
> process null; rescheduling job hqejbhcnphr45xgkgkqmcf for 2/4/09 5:15 PM
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
>
>
> I too attach my bpel project with this mail.
>
>
> with regards
>
> Surendar V
>
>
>