You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@ode.apache.org by NGUYEN Cong Kinh <ng...@telecom-paristech.fr> on 2008/09/29 11:19:14 UTC
Asynchronous
Hi everybody,
I am using ode 1.2. I have a problem with Asynchronous. I see that the
process is stopped while using activity onAlarm on the activity Pick, if
not it infinitely runs. In addition, I see that message Correlation is
set. Could you help me to understand how I can solve this problem.
Thanks,
Kinh
DEBUG - GeronimoLog.debug(66) | >>
handleWorkEvent(jobData={ckey=35~http://www.t
si.enst.fr/~~elloumi/MediasDB/trailers/kill_bill_small.mp4,
correlatorId=36.say,
inmem=false, iid=201, type=MATCHER})
DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for
instance 201.
INDEXED STATE={{OScope 'Scope' id=56}::14=[SCOPE(...)],
OSequence#38-main::1=[A
CTIVITYGUARD(...)], OPickReceive#67-Pick::20=[PICK(...)],
OSequence#57-Sequence:
:15=[ACTIVITYGUARD(...)],
OSequence#38-main::2=[SEQUENCE(self=(OSequence#38-main
,TerminationChannel#3,ParentScopeChannel#5),
linkframe=org.apache.ode.bpel.runti
me.LinkFrame@1145e2e, remaining=[{OScope 'Scope' id=56}, {OScope
'callbackClient
' id=90}])], {OScope '__PROCESS_SCOPE:Test' id=20}::0=[ACTIVE(...)],
{OScope '__
PROCESS_SCOPE:Test' id=20}::0=[SCOPE(...)],
OPickReceive#67-Pick::19=[ACTIVITYGU
ARD(...)], {OScope 'Scope' id=56}::13=[ACTIVITYGUARD(...)],
OSequence#57-Sequenc
e::16=[SEQUENCE(self=(OSequence#57-Sequence,TerminationChannel#25,ParentScopeCha
nnel#27), linkframe=org.apache.ode.bpel.runtime.LinkFrame@1145e2e,
remaining=[OP
ickReceive#67-Pick])], {OScope 'Scope' id=56}::14=[ACTIVE(...)]}
DEBUG - GeronimoLog.debug(66) | Matcher event for iid 201
DEBUG - GeronimoLog.debug(66) | MatcherEvent handling:
correlatorId=36.say, ckey
={CorrelationKey setId=35,
values=[http://www.tsi.enst.fr/~elloumi/MediasDB/trai
lers/kill_bill_small.mp4]}
DEBUG - GeronimoLog.debug(66) | MatcherEvent handling: nothing to do, no
matchin
g message in DB
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
Here is my BPEL:
<?xml version="1.0" encoding="UTF-8"?>
<bpws:process exitOnStandardFault="yes" name="Test"
suppressJoinFailure="yes" targetNamespace="http://www.tsi.enst.fr"
xmlns:bpws="http://docs.oasis-open.org/wsbpel/2.0/process/executable"
xmlns:ns="http://www.tsi.enst.frArtifacts" xmlns:ns0="http://paam"
xmlns:ns1="UGGH" xmlns:tns="http://www.tsi.enst.fr">
<bpws:import importType="http://schemas.xmlsoap.org/wsdl/"
location="Test.wsdl" namespace="http://www.tsi.enst.fr"/>
<bpws:import importType="http://schemas.xmlsoap.org/wsdl/"
location="TestArtifacts.wsdl"
namespace="http://www.tsi.enst.frArtifacts"/>
<bpws:import importType="http://schemas.xmlsoap.org/wsdl/"
location="Video.wsdl" namespace="http://paam"/>
<bpws:import importType="http://schemas.xmlsoap.org/wsdl/"
location="TestArtifacts.wsdl" namespace="UGGH"/>
<bpws:partnerLinks>
<bpws:partnerLink initializePartnerRole="yes"
myRole="TestProvider" name="client"
partnerLinkType="tns:Test" partnerRole="TestRequester"/>
<bpws:partnerLink name="linkVideo"
partnerLinkType="ns1:partnerLinkVideo" partnerRole="videoRole"/>
</bpws:partnerLinks>
<bpws:variables>
<bpws:variable messageType="tns:TestRequestMessage" name="input"/>
<bpws:variable messageType="tns:TestResponseMessage" name="output"/>
<bpws:variable messageType="ns0:changeScaleResponse"
name="linkVideoResponse"/>
<bpws:variable messageType="ns0:changeScaleRequest"
name="linkVideoRequest"/>
<bpws:variable messageType="tns:sayRequestMessage"
name="clientResponse"/>
</bpws:variables>
<bpws:correlationSets>
<bpws:correlationSet name="CS" properties="ns1:stUrl"/>
</bpws:correlationSets>
<bpws:sequence name="main">
<bpws:receive createInstance="yes" name="receiveInput"
operation="initiate" partnerLink="client"
portType="tns:Test" variable="input"/>
<bpws:assign name="Assign" validate="no">
<bpws:copy>
<bpws:from>
<bpws:literal>
<tns:TestResponseMessage
xmlns:tns="http://www.tsi.enst.fr">
<tns:result/>
</tns:TestResponseMessage>
</bpws:literal>
</bpws:from>
<bpws:to part="payload" variable="output"/>
</bpws:copy>
<bpws:copy>
<bpws:from>
<bpws:literal>
<changeScaleRequest>
<stUrl>http://www.tsi.enst.fr/~elloumi/MediasDB/trailers/kill_bill_small.mp4</stUrl>
<width>200</width>
<height>200</height>
</changeScaleRequest>
</bpws:literal>
</bpws:from>
<bpws:to part="parameters" variable="linkVideoRequest"/>
</bpws:copy>
</bpws:assign>
<bpws:invoke inputVariable="linkVideoRequest" name="Invoke"
operation="changeScale" outputVariable="linkVideoResponse"
partnerLink="linkVideo" portType="ns0:Video">
<bpws:correlations>
<bpws:correlation initiate="yes" pattern="out" set="CS"/>
</bpws:correlations>
</bpws:invoke>
<bpws:scope name="Scope">
<bpws:sequence name="Sequence">
<bpws:assign name="Assign2" validate="no">
<bpws:copy>
<bpws:from>
<bpws:literal>
<sayRequestMessage>
<stUrl/>
</sayRequestMessage>
</bpws:literal>
</bpws:from>
<bpws:to part="payload" variable="clientResponse"/>
</bpws:copy>
<bpws:copy>
<bpws:from><![CDATA[$linkVideoRequest.parameters/stUrl]]></bpws:from>
<bpws:to><![CDATA[$clientResponse.payload/stUrl]]></bpws:to>
</bpws:copy>
</bpws:assign>
<bpws:pick createInstance="no" name="Pick">
<bpws:onMessage operation="say" partnerLink="client"
portType="tns:Test" variable="clientResponse">
<bpws:correlations>
<bpws:correlation initiate="no" set="CS"/>
</bpws:correlations>
<bpws:sequence name="Sequence1">
<bpws:assign name="Assign1" validate="no">
<bpws:copy>
<bpws:from><![CDATA[$linkVideoResponse.parameters/ns0:changeScaleReturn]]></bpws:from>
<bpws:to><![CDATA[$output.payload/tns:result]]></bpws:to>
</bpws:copy>
<bpws:copy>
<bpws:from><![CDATA[$output.payload/tns:result]]></bpws:from>
<bpws:to part="payload"
variable="output">
<bpws:query
queryLanguage="urn:oasis:names:tc:wsbpel:2.0:sublang:xpath1.0"><![CDATA[/tns:result]]></bpws:query>
</bpws:to>
</bpws:copy>
</bpws:assign>
</bpws:sequence>
</bpws:onMessage>
</bpws:pick>
</bpws:sequence>
</bpws:scope>
<bpws:invoke inputVariable="output" name="callbackClient"
operation="onResult" partnerLink="client"
portType="tns:TestCallback"/>
</bpws:sequence>
</bpws:process>
--
NGUYEN Cong Kinh
Re: Asynchronous
Posted by Matthieu Riou <ma...@offthelip.org>.
On Mon, Sep 29, 2008 at 2:19 AM, NGUYEN Cong Kinh <
nguyen@telecom-paristech.fr> wrote:
> Hi everybody,
>
> I am using ode 1.2. I have a problem with Asynchronous. I see that the
> process is stopped while using activity onAlarm on the activity Pick, if
> not it infinitely runs. In addition, I see that message Correlation is
> set. Could you help me to understand how I can solve this problem.
>
>From your logs I see the second message (for the 'say' operation) being
received, a correlation value is extracted but doesn't match any
pre-existing correlation value. So the message doesn't match what the pick
expects.
I'd need either the full log to see how the correlation value differ and
eventually the 2 messages you're sending.
Cheers,
Matthieu
>
> Thanks,
> Kinh
>
>
> DEBUG - GeronimoLog.debug(66) | >>
> handleWorkEvent(jobData={ckey=35~http://www.t
> si.enst.fr/~~elloumi/MediasDB/trailers/kill_bill_small.mp4<http://si.enst.fr/%7E%7Eelloumi/MediasDB/trailers/kill_bill_small.mp4>
> ,
> correlatorId=36.say,
> inmem=false, iid=201, type=MATCHER})
> DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for
> instance 201.
> INDEXED STATE={{OScope 'Scope' id=56}::14=[SCOPE(...)],
> OSequence#38-main::1=[A
> CTIVITYGUARD(...)], OPickReceive#67-Pick::20=[PICK(...)],
> OSequence#57-Sequence:
> :15=[ACTIVITYGUARD(...)],
> OSequence#38-main::2=[SEQUENCE(self=(OSequence#38-main
> ,TerminationChannel#3,ParentScopeChannel#5),
> linkframe=org.apache.ode.bpel.runti
> me.LinkFrame@1145e2e, remaining=[{OScope 'Scope' id=56}, {OScope
> 'callbackClient
> ' id=90}])], {OScope '__PROCESS_SCOPE:Test' id=20}::0=[ACTIVE(...)],
> {OScope '__
> PROCESS_SCOPE:Test' id=20}::0=[SCOPE(...)],
> OPickReceive#67-Pick::19=[ACTIVITYGU
> ARD(...)], {OScope 'Scope' id=56}::13=[ACTIVITYGUARD(...)],
> OSequence#57-Sequenc
>
> e::16=[SEQUENCE(self=(OSequence#57-Sequence,TerminationChannel#25,ParentScopeCha
> nnel#27), linkframe=org.apache.ode.bpel.runtime.LinkFrame@1145e2e,
> remaining=[OP
> ickReceive#67-Pick])], {OScope 'Scope' id=56}::14=[ACTIVE(...)]}
> DEBUG - GeronimoLog.debug(66) | Matcher event for iid 201
> DEBUG - GeronimoLog.debug(66) | MatcherEvent handling:
> correlatorId=36.say, ckey
> ={CorrelationKey setId=35,
> values=[http://www.tsi.enst.fr/~elloumi/MediasDB/trai
> lers/kill_bill_small.mp4<http://www.tsi.enst.fr/%7Eelloumi/MediasDB/trailers/kill_bill_small.mp4>
> ]}
> DEBUG - GeronimoLog.debug(66) | MatcherEvent handling: nothing to do, no
> matchin
> g message in DB
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
>
> Here is my BPEL:
>
> <?xml version="1.0" encoding="UTF-8"?>
> <bpws:process exitOnStandardFault="yes" name="Test"
> suppressJoinFailure="yes" targetNamespace="http://www.tsi.enst.fr"
> xmlns:bpws="http://docs.oasis-open.org/wsbpel/2.0/process/executable"
> xmlns:ns="http://www.tsi.enst.frArtifacts" xmlns:ns0="http://paam"
> xmlns:ns1="UGGH" xmlns:tns="http://www.tsi.enst.fr">
> <bpws:import importType="http://schemas.xmlsoap.org/wsdl/"
> location="Test.wsdl" namespace="http://www.tsi.enst.fr"/>
> <bpws:import importType="http://schemas.xmlsoap.org/wsdl/"
> location="TestArtifacts.wsdl"
> namespace="http://www.tsi.enst.frArtifacts"/>
> <bpws:import importType="http://schemas.xmlsoap.org/wsdl/"
> location="Video.wsdl" namespace="http://paam"/>
> <bpws:import importType="http://schemas.xmlsoap.org/wsdl/"
> location="TestArtifacts.wsdl" namespace="UGGH"/>
> <bpws:partnerLinks>
> <bpws:partnerLink initializePartnerRole="yes"
> myRole="TestProvider" name="client"
> partnerLinkType="tns:Test" partnerRole="TestRequester"/>
> <bpws:partnerLink name="linkVideo"
> partnerLinkType="ns1:partnerLinkVideo" partnerRole="videoRole"/>
> </bpws:partnerLinks>
> <bpws:variables>
> <bpws:variable messageType="tns:TestRequestMessage" name="input"/>
> <bpws:variable messageType="tns:TestResponseMessage" name="output"/>
> <bpws:variable messageType="ns0:changeScaleResponse"
> name="linkVideoResponse"/>
> <bpws:variable messageType="ns0:changeScaleRequest"
> name="linkVideoRequest"/>
> <bpws:variable messageType="tns:sayRequestMessage"
> name="clientResponse"/>
> </bpws:variables>
> <bpws:correlationSets>
> <bpws:correlationSet name="CS" properties="ns1:stUrl"/>
> </bpws:correlationSets>
> <bpws:sequence name="main">
> <bpws:receive createInstance="yes" name="receiveInput"
> operation="initiate" partnerLink="client"
> portType="tns:Test" variable="input"/>
> <bpws:assign name="Assign" validate="no">
> <bpws:copy>
> <bpws:from>
> <bpws:literal>
> <tns:TestResponseMessage
> xmlns:tns="http://www.tsi.enst.fr">
> <tns:result/>
> </tns:TestResponseMessage>
> </bpws:literal>
> </bpws:from>
> <bpws:to part="payload" variable="output"/>
> </bpws:copy>
> <bpws:copy>
> <bpws:from>
> <bpws:literal>
> <changeScaleRequest>
> <stUrl>
> http://www.tsi.enst.fr/~elloumi/MediasDB/trailers/kill_bill_small.mp4<http://www.tsi.enst.fr/%7Eelloumi/MediasDB/trailers/kill_bill_small.mp4>
> </stUrl>
> <width>200</width>
> <height>200</height>
> </changeScaleRequest>
> </bpws:literal>
> </bpws:from>
> <bpws:to part="parameters" variable="linkVideoRequest"/>
> </bpws:copy>
> </bpws:assign>
> <bpws:invoke inputVariable="linkVideoRequest" name="Invoke"
> operation="changeScale" outputVariable="linkVideoResponse"
> partnerLink="linkVideo" portType="ns0:Video">
> <bpws:correlations>
> <bpws:correlation initiate="yes" pattern="out" set="CS"/>
> </bpws:correlations>
> </bpws:invoke>
> <bpws:scope name="Scope">
> <bpws:sequence name="Sequence">
> <bpws:assign name="Assign2" validate="no">
> <bpws:copy>
> <bpws:from>
> <bpws:literal>
> <sayRequestMessage>
> <stUrl/>
> </sayRequestMessage>
> </bpws:literal>
> </bpws:from>
> <bpws:to part="payload" variable="clientResponse"/>
> </bpws:copy>
> <bpws:copy>
>
> <bpws:from><![CDATA[$linkVideoRequest.parameters/stUrl]]></bpws:from>
>
> <bpws:to><![CDATA[$clientResponse.payload/stUrl]]></bpws:to>
> </bpws:copy>
> </bpws:assign>
> <bpws:pick createInstance="no" name="Pick">
> <bpws:onMessage operation="say" partnerLink="client"
> portType="tns:Test" variable="clientResponse">
> <bpws:correlations>
> <bpws:correlation initiate="no" set="CS"/>
> </bpws:correlations>
> <bpws:sequence name="Sequence1">
> <bpws:assign name="Assign1" validate="no">
> <bpws:copy>
>
> <bpws:from><![CDATA[$linkVideoResponse.parameters/ns0:changeScaleReturn]]></bpws:from>
>
> <bpws:to><![CDATA[$output.payload/tns:result]]></bpws:to>
> </bpws:copy>
> <bpws:copy>
>
> <bpws:from><![CDATA[$output.payload/tns:result]]></bpws:from>
> <bpws:to part="payload"
> variable="output">
> <bpws:query
>
> queryLanguage="urn:oasis:names:tc:wsbpel:2.0:sublang:xpath1.0"><![CDATA[/tns:result]]></bpws:query>
> </bpws:to>
> </bpws:copy>
> </bpws:assign>
> </bpws:sequence>
> </bpws:onMessage>
> </bpws:pick>
> </bpws:sequence>
> </bpws:scope>
> <bpws:invoke inputVariable="output" name="callbackClient"
> operation="onResult" partnerLink="client"
> portType="tns:TestCallback"/>
> </bpws:sequence>
> </bpws:process>
>
>
> --
> NGUYEN Cong Kinh
Re: Asynchronous
Posted by Matthieu Riou <ma...@offthelip.org>.
On Mon, Sep 29, 2008 at 7:27 AM, NGUYEN Cong Kinh <
nguyen@telecom-paristech.fr> wrote:
> Hi Matthieu,
>
> Thank you for your helps. Here is full log:
>
So I see the first message triggering the process execution, the invoke that
sets the correlation key value to "
http://www.tsi.enst.fr/~elloumi/MediasDB/trailers/kill_bill_small.mp4" and
then the pick being activated. But I don't see any message coming in to
trigger that pick, so at least for what I have it looks normal. As long as
the engine doesn't get that message it won't complete the pick.
Btw a pick with a single onMessage is equivalent to a receive.
Cheers,
Matthieu
>
> DEBUG - GeronimoLog.debug(66) | Received one-way message for
> TestService.{http:/
> /www.tsi.enst.fr}initiate
> DEBUG - GeronimoLog.debug(66) | Starting transaction.
> DEBUG - GeronimoLog.debug(66) | Routed: svcQname
> {http://www.tsi.enst.fr}TestSer
> vice --> BpelProcess[{http://www.tsi.enst.fr}Test-1]
> DEBUG - GeronimoLog.debug(66) | ODE routed to operation Operation:
> name=initiate
>
> style=ONE_WAY,0
> Input: name=null
> Message: name={http://www.tsi.enst.fr}TestRequestMessage
> Part: name=payload
> elementName={http://www.tsi.enst.fr}TestRequest from service
> {http://www.tsi.ens
> t.fr}TestService
> DEBUG - GeronimoLog.debug(66) | Invoking ODE using MEX
> {MyRoleMex#hqejbhcnphr3mp
> 5lpfmt4a [Client hqejbhcnphr3mp5lpfmt49] calling
> {http://www.tsi.enst.fr}TestSer
> vice.initiate(...)}
> DEBUG - GeronimoLog.debug(66) | Message content: <?xml version="1.0"
> encoding="
> UTF-8"?>
> <message><payload><TestRequest xmlns="http://www.tsi.enst.fr"
> xmlns:q0="http://w
> ww.tsi.enst.fr" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"
> xmlns:
> xsd="http://www.w3.org/2001/XMLSchema"
> xmlns:xsi="http://www.w3.org/2001/XMLSche
> ma-instance <http://www.w3.org/2001/XMLSchema-instance>">
> <input>hello world</input>
> </TestRequest></payload></message>
> DEBUG - GeronimoLog.debug(66) | Routed: svcQname
> {http://www.tsi.enst.fr}TestSer
> vice --> BpelProcess[{http://www.tsi.enst.fr}Test-1]
> DEBUG - GeronimoLog.debug(66) | invoke() EPR= null ==>
> BpelProcess[{http://www.t
> si.enst.fr}Test-1]
> DEBUG - GeronimoLog.debug(66) | Commiting ODE MEX
> {MyRoleMex#hqejbhcnphr3mp5lpfm
> t4a [Client hqejbhcnphr3mp5lpfmt49] calling
> {http://www.tsi.enst.fr}TestService.
> initiate(...)}
> DEBUG - GeronimoLog.debug(66) | Commiting transaction.
> DEBUG - GeronimoLog.debug(66) | Releasing mex hqejbhcnphr3mp5lpfmt4a
> DEBUG - GeronimoLog.debug(66) | >>
> handleWorkEvent(jobData={mexid=hqejbhcnphr3mp
> 5lpfmt4a, pid={http://www.tsi.enst.fr}Test-1, type=INVOKE_INTERNAL})
> DEBUG - GeronimoLog.debug(66) | InvokeInternal event for mexid
> hqejbhcnphr3mp5lp
> fmt4a
> DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.myRoleSessi
> onId = null
> DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.myRoleSessi
> onId = null
> DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.partnerRole
> SessionId = null
> DEBUG - GeronimoLog.debug(66) | INPUTMSG: 36.initiate: MSG RCVD keys=[]
> mySessio
> nId=null partnerSessionId=null
> DEBUG - GeronimoLog.debug(66) | INPUTMSG: 36.initiate: routing failed,
> CREATING
> NEW INSTANCE
> DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for
> instance 201.
> INDEXED STATE={}
> DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: USING
> CORRELATOR
> 36.initiate
> DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: CHECKING
> for NEW
> INSTANCE match
> DEBUG - GeronimoLog.debug(66) | INPUTMSGMATCH: Changing process instance
> state f
> rom ready to active
> DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: FOUND match
> for N
> EW instance mexRef={MyRoleMex#hqejbhcnphr3mp5lpfmt4a [Client
> hqejbhcnphr3mp5lpfm
> t49] calling {http://www.tsi.enst.fr}TestService.initiate(...)}
> DEBUG - GeronimoLog.debug(66) | INVOKING PARTNER:
> partnerLink={PartnerLinkInstan
> ce partnerLinkDecl=OPartnerLink#37,scopeInstanceId=251}, op=changeScale
> channel=
> InvokeResponseChannel#20)
> DEBUG - GeronimoLog.debug(66) | INVOKE PARTNER (SEP): sessionId=null
> partnerSess
> ionId=null
> DEBUG - GeronimoLog.debug(66) | Routed: svcQname {http://paam}VideoService
> --> n
> ull
> DEBUG - GeronimoLog.debug(66) | Invoking a partner operation: changeScale
> DEBUG - GeronimoLog.debug(66) | The service to invoke is the external
> service {h
> ttp://paam}VideoService:Video
> 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"><EndpointR
> eference
> xmlns="http://www.w3.org/2005/08/addressing"><Metadata><ServiceName xml
> ns="http://www.w3.org/2006/05/addressing/wsdl" EndpointName="Video"
> xmlns:servic
> ens="http://paam
> ">servicens:VideoService</ServiceName></Metadata><Address>http:/
>
> /localhost:8080/mobic/services/Video</Address></EndpointReference></service-ref>
>
> DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.partnerRole
> SessionId = null
> DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.myRoleSessi
> onId = 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/m
> obic/services/Video <http://localhost:8080/mobic/services/Video> using MEX
> {PartnerRoleMex#hqejbhcnphr3mp5lpfmt4d [PID
> {http:
> //www.tsi.enst.fr}Test-1] calling
> org.apache.ode.bpel.epr.WSAEndpoint@f5498f.cha
> ngeScale(...)}
> DEBUG - GeronimoLog.debug(66) | Message: <?xml version='1.0'
> encoding='utf-8'?><
> soapenv:Envelope
> xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soap
> env:Body><changeScale xmlns="http://paam">
> <stUrl
> xmlns="">http://www.tsi.enst.fr/~elloumi/Medi
> asDB/trailers/kill_bill_small.mp4<http://www.tsi.enst.fr/%7Eelloumi/MediasDB/trailers/kill_bill_small.mp4>
> </stUrl>
> <width xmlns="">200</width>
> <height xmlns="">200</height>
> </changeScale></soapenv:Body></soapenv:Envelope>
> DEBUG - GeronimoLog.debug(66) |
> org.apache.ode.axis2.SoapExternalService$CachedO
> ptions$1@df672a has been modified
> DEBUG - GeronimoLog.debug(66) | Translating IL Properties for Axis2
> DEBUG - GeronimoLog.debug(66) | replyAsync mex=hqejbhcnphr3mp5lpfmt4d
> DEBUG - GeronimoLog.debug(66) | Setting execution state on instance 201
> DEBUG - GeronimoLog.debug(66) | Releasing mex hqejbhcnphr3mp5lpfmt4a
> 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 he
> aders for session passing.
> DEBUG - GeronimoLog.debug(66) | <?xml version='1.0'
> encoding='utf-8'?><soapenv:E
> nvelope
> xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Heade
> r><addr:To
> xmlns:addr="http://www.w3.org/2005/08/addressing">http://localhost:80
> 80/mobic/services/Video</addr:To><addr:Action
> xmlns:addr="http://www.w3.org/2005
> /08/addressing <http://www.w3.org/2005/08/addressing>
> "></addr:Action><addr:ReplyTo
> xmlns:addr="http://www.w3.org/2005/0
> 8/addressing <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/ad
>
> dressing">uuid:hqejbhcnphr3mp5lpfmt4e</addr:MessageID></soapenv:Header><soapenv:
> Body><changeScale xmlns="http://paam">
> <stUrl
> xmlns="">http://www.tsi.enst.fr/~elloumi/Medi
> asDB/trailers/kill_bill_small.mp4<http://www.tsi.enst.fr/%7Eelloumi/MediasDB/trailers/kill_bill_small.mp4>
> </stUrl>
> <width xmlns="">200</width>
> <height xmlns="">200</height>
> </changeScale></soapenv:Body></soapenv:Envelope>
> FFmpeg version SVN-r12665, Copyright (c) 2000-2008 Fabrice Bellard, et al.
> configuration: --enable-gpl --enable-postproc --enable-swscale
> --enable-avfilt
> er-lavf --enable-pthreads --enable-liba52 --enable-avisynth
> --enable-libfaac --e
> nable-libfaad --enable-libgsm --enable-memalign-hack --enable-libmp3lame
> --enabl
> e-libnut --enable-libtheora --enable-libvorbis --enable-libx264
> --enable-libxvid
> --cpu=i686 --extra-ldflags=-static
> libavutil version: 49.6.0
> libavcodec version: 51.54.0
> libavformat version: 52.13.0
> libavdevice version: 52.0.0
> built on Apr 2 2008 22:35:11, gcc: 4.2.3
>
> Seems stream 2 codec frame rate differs from container frame rate: 25.00
> (25/1)
> -> 8.00 (120000/15000)
> Input #0, mov,mp4,m4a,3gp,3g2,mj2, from
> 'C:\19801009_ENST_PAAM\1222698273484_287
> 4.mp4':
> Duration: 00:02:28.4, start: 0.000000, bitrate: 314 kb/s
> Stream #0.0(und): Data: mp4s / 0x7334706D
> Stream #0.1(und): Data: mp4s / 0x7334706D
> Stream #0.2(und): Video: mpeg4, yuv420p, 240x128 [PAR 1:1 DAR 15:8],
> 8.00 t
> b(r)
> Stream #0.3(und): Audio: mpeg4aac, 44100 Hz, stereo
> Stream #0.4(und): Data: rtp / 0x20707472
> Stream #0.5(und): Data: rtp / 0x20707472
> Output #0, mp4, to 'C:\19801009_ENST_PAAM\1222698274015_4595.mp4':
> Stream #0.0(und): Video: mpeg4, yuv420p, 200x200 [PAR 15:8 DAR 15:8],
> q=2-31
> , 200 kb/s, 8.00 tb(c)
> Stream #0.1(und): Audio: libfaac, 44100 Hz, stereo, 64 kb/s
> Stream mapping:
> Stream #0.2 -> #0.0
> Stream #0.3 -> #0.1
> [mpeg4 @ 00ABC290]removing common factors from framerate
> Press [q] to stop encoding
> frame= 1173 fps= 58 q=1.6 Lsize= 4504kB time=146.6 bitrate= 251.7kbits/s
> video:3600kB audio:841kB global headers:0kB muxing overhead 1.434929%
> DEBUG - GeronimoLog.debug(66) | Service response:
> <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope
> xmlns:soapenv="http://sc
> hemas.xmlsoap.org/soap/envelope/"
> xmlns:xsd="http://www.w3.org/2001/XMLSchema" x
> mlns:xsi="http://www.w3.org/2001/XMLSchema-instance
> "><soapenv:Body><changeScaleR
> esponse
> xmlns="http://paam"><changeScaleReturn>http://vesta.enst.fr:8080/result/
>
> 1222698274015_4595.mp4</changeScaleReturn></changeScaleResponse></soapenv:Body><
> /soapenv:Envelope>
> DEBUG - GeronimoLog.debug(66) | Received response for MEX
> {PartnerRoleMex#hqejbh
> cnphr3mp5lpfmt4d [PID {http://www.tsi.enst.fr}Test-1] calling
> null.changeScale(.
> ..)}
> INFO - GeronimoLog.info(79) | Response:
> <?xml version="1.0" encoding="UTF-8"?>
> <message><parameters><changeScaleResponse xmlns="http://paam"
> xmlns:soapenv="htt
> p://schemas.xmlsoap.org/soap/envelope/"
> xmlns:xsd="http://www.w3.org/2001/XMLSch
> ema"
> xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"><changeScaleReturn
> xm
> lns="http://paam">http://vesta.enst.fr:8080/result/1222698274015_4595.mp4
> </chang
> eScaleReturn></changeScaleResponse></parameters></message>
> DEBUG - GeronimoLog.debug(66) | reply mex=hqejbhcnphr3mp5lpfmt4d
> DEBUG - GeronimoLog.debug(66) | create work event for
> mex=hqejbhcnphr3mp5lpfmt4d
>
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1
> MICROSECONDS)
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1
> MICROSECONDS)-->GRANTED
> DEBUG - GeronimoLog.debug(66) | >>
> handleWorkEvent(jobData={mexid=hqejbhcnphr3mp
> 5lpfmt4d, iid=201, type=INVOKE_RESPONSE, channel=20})
> DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for
> instance 201.
> INDEXED
> STATE={OSequence#38-main::2=[SEQUENCE(self=(OSequence#38-main,Terminati
> onChannel#3,ParentScopeChannel#5),
> linkframe=org.apache.ode.bpel.runtime.LinkFra
> me@1bf4c80, remaining=[{OScope 'Invoke' id=49}, {OScope 'Scope' id=56},
> {OScope
> 'callbackClient' id=90}])], {OScope 'Invoke'
> id=49}::9=[ACTIVITYGUARD(...)], OIn
> voke#50-Invoke::12=[INVOKE(...)], {OScope '__PROCESS_SCOPE:Test'
> id=20}::0=[ACTI
> VE(...)], {OScope 'Invoke' id=49}::10=[ACTIVE(...)],
> OSequence#38-main::1=[ACTIV
> ITYGUARD(...)], {OScope '__PROCESS_SCOPE:Test' id=20}::0=[SCOPE(...)],
> OInvoke#5
> 0-Invoke::11=[ACTIVITYGUARD(...)], {OScope 'Invoke'
> id=49}::10=[SCOPE(...)]}
> DEBUG - GeronimoLog.debug(66) | InvokeResponse event for iid 201
> DEBUG - GeronimoLog.debug(66) | Invoking message response for mexid
> hqejbhcnphr3
> mp5lpfmt4d and channel 20
> DEBUG - GeronimoLog.debug(66) | Triggering response
> DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#34: USING
> CORRELATOR
> 36.say
> DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#34: ADDED
> ROUTE 36.s
> ay: {CorrelationKey setId=35,
> values=[http://www.tsi.enst.fr/~elloumi/MediasDB/t<http://www.tsi.enst.fr/%7Eelloumi/MediasDB/t>
> railers/kill_bill_small.mp4]} --> 201
> DEBUG - GeronimoLog.debug(66) | Setting execution state on instance 201
> 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=1
> MICROSECONDS)
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
> time=1
> MICROSECONDS)-->GRANTED
> DEBUG - GeronimoLog.debug(66) | >>
> handleWorkEvent(jobData={ckey=35~http://www.t
> si.enst.fr/~~elloumi/MediasDB/trailers/kill_bill_small.mp4<http://si.enst.fr/%7E%7Eelloumi/MediasDB/trailers/kill_bill_small.mp4>
> ,
> correlatorId=36.say,
> inmem=false, iid=201, type=MATCHER})
> DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for
> instance 201.
> INDEXED STATE={OSequence#57-Sequence::15=[ACTIVITYGUARD(...)],
> OSequence#57-Seq
>
> uence::16=[SEQUENCE(self=(OSequence#57-Sequence,TerminationChannel#25,ParentScop
> eChannel#27), linkframe=org.apache.ode.bpel.runtime.LinkFrame@102c065,
> remaining
> =[OPickReceive#67-Pick])],
> OSequence#38-main::2=[SEQUENCE(self=(OSequence#38-mai
> n,TerminationChannel#3,ParentScopeChannel#5),
> linkframe=org.apache.ode.bpel.runt
> ime.LinkFrame@102c065, remaining=[{OScope 'Scope' id=56}, {OScope
> 'callbackClien
> t' id=90}])], {OScope '__PROCESS_SCOPE:Test' id=20}::0=[ACTIVE(...)],
> {OScope '_
> _PROCESS_SCOPE:Test' id=20}::0=[SCOPE(...)], {OScope 'Scope'
> id=56}::14=[SCOPE(.
> ..)], OSequence#38-main::1=[ACTIVITYGUARD(...)],
> OPickReceive#67-Pick::20=[PICK(
> ...)], {OScope 'Scope' id=56}::14=[ACTIVE(...)], {OScope 'Scope'
> id=56}::13=[ACT
> IVITYGUARD(...)], OPickReceive#67-Pick::19=[ACTIVITYGUARD(...)]}
> DEBUG - GeronimoLog.debug(66) | Matcher event for iid 201
> DEBUG - GeronimoLog.debug(66) | MatcherEvent handling:
> correlatorId=36.say, ckey
> ={CorrelationKey setId=35,
> values=[http://www.tsi.enst.fr/~elloumi/MediasDB/trai
> lers/kill_bill_small.mp4<http://www.tsi.enst.fr/%7Eelloumi/MediasDB/trailers/kill_bill_small.mp4>
> ]}
> DEBUG - GeronimoLog.debug(66) | MatcherEvent handling: nothing to do, no
> matchin
> g message in DB
> DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
>
> --
> Kinh
>
>
>
Re: Asynchronous
Posted by NGUYEN Cong Kinh <ng...@telecom-paristech.fr>.
Hi Matthieu,
Thank you for your helps. Here is full log:
DEBUG - GeronimoLog.debug(66) | Received one-way message for
TestService.{http:/
/www.tsi.enst.fr}initiate
DEBUG - GeronimoLog.debug(66) | Starting transaction.
DEBUG - GeronimoLog.debug(66) | Routed: svcQname
{http://www.tsi.enst.fr}TestSer
vice --> BpelProcess[{http://www.tsi.enst.fr}Test-1]
DEBUG - GeronimoLog.debug(66) | ODE routed to operation Operation:
name=initiate
style=ONE_WAY,0
Input: name=null
Message: name={http://www.tsi.enst.fr}TestRequestMessage
Part: name=payload
elementName={http://www.tsi.enst.fr}TestRequest from service
{http://www.tsi.ens
t.fr}TestService
DEBUG - GeronimoLog.debug(66) | Invoking ODE using MEX
{MyRoleMex#hqejbhcnphr3mp
5lpfmt4a [Client hqejbhcnphr3mp5lpfmt49] calling
{http://www.tsi.enst.fr}TestSer
vice.initiate(...)}
DEBUG - GeronimoLog.debug(66) | Message content: <?xml version="1.0"
encoding="
UTF-8"?>
<message><payload><TestRequest xmlns="http://www.tsi.enst.fr"
xmlns:q0="http://w
ww.tsi.enst.fr" xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"
xmlns:
xsd="http://www.w3.org/2001/XMLSchema"
xmlns:xsi="http://www.w3.org/2001/XMLSche
ma-instance">
<input>hello world</input>
</TestRequest></payload></message>
DEBUG - GeronimoLog.debug(66) | Routed: svcQname
{http://www.tsi.enst.fr}TestSer
vice --> BpelProcess[{http://www.tsi.enst.fr}Test-1]
DEBUG - GeronimoLog.debug(66) | invoke() EPR= null ==>
BpelProcess[{http://www.t
si.enst.fr}Test-1]
DEBUG - GeronimoLog.debug(66) | Commiting ODE MEX
{MyRoleMex#hqejbhcnphr3mp5lpfm
t4a [Client hqejbhcnphr3mp5lpfmt49] calling
{http://www.tsi.enst.fr}TestService.
initiate(...)}
DEBUG - GeronimoLog.debug(66) | Commiting transaction.
DEBUG - GeronimoLog.debug(66) | Releasing mex hqejbhcnphr3mp5lpfmt4a
DEBUG - GeronimoLog.debug(66) | >>
handleWorkEvent(jobData={mexid=hqejbhcnphr3mp
5lpfmt4a, pid={http://www.tsi.enst.fr}Test-1, type=INVOKE_INTERNAL})
DEBUG - GeronimoLog.debug(66) | InvokeInternal event for mexid
hqejbhcnphr3mp5lp
fmt4a
DEBUG - GeronimoLog.debug(66) | GET MEX property
org.apache.ode.bpel.myRoleSessi
onId = null
DEBUG - GeronimoLog.debug(66) | GET MEX property
org.apache.ode.bpel.myRoleSessi
onId = null
DEBUG - GeronimoLog.debug(66) | GET MEX property
org.apache.ode.bpel.partnerRole
SessionId = null
DEBUG - GeronimoLog.debug(66) | INPUTMSG: 36.initiate: MSG RCVD keys=[]
mySessio
nId=null partnerSessionId=null
DEBUG - GeronimoLog.debug(66) | INPUTMSG: 36.initiate: routing failed,
CREATING
NEW INSTANCE
DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for
instance 201.
INDEXED STATE={}
DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: USING
CORRELATOR
36.initiate
DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: CHECKING
for NEW
INSTANCE match
DEBUG - GeronimoLog.debug(66) | INPUTMSGMATCH: Changing process instance
state f
rom ready to active
DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: FOUND match
for N
EW instance mexRef={MyRoleMex#hqejbhcnphr3mp5lpfmt4a [Client
hqejbhcnphr3mp5lpfm
t49] calling {http://www.tsi.enst.fr}TestService.initiate(...)}
DEBUG - GeronimoLog.debug(66) | INVOKING PARTNER:
partnerLink={PartnerLinkInstan
ce partnerLinkDecl=OPartnerLink#37,scopeInstanceId=251}, op=changeScale
channel=
InvokeResponseChannel#20)
DEBUG - GeronimoLog.debug(66) | INVOKE PARTNER (SEP): sessionId=null
partnerSess
ionId=null
DEBUG - GeronimoLog.debug(66) | Routed: svcQname {http://paam}VideoService
--> n
ull
DEBUG - GeronimoLog.debug(66) | Invoking a partner operation: changeScale
DEBUG - GeronimoLog.debug(66) | The service to invoke is the external
service {h
ttp://paam}VideoService:Video
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"><EndpointR
eference
xmlns="http://www.w3.org/2005/08/addressing"><Metadata><ServiceName xml
ns="http://www.w3.org/2006/05/addressing/wsdl" EndpointName="Video"
xmlns:servic
ens="http://paam">servicens:VideoService</ServiceName></Metadata><Address>http:/
/localhost:8080/mobic/services/Video</Address></EndpointReference></service-ref>
DEBUG - GeronimoLog.debug(66) | GET MEX property
org.apache.ode.bpel.partnerRole
SessionId = null
DEBUG - GeronimoLog.debug(66) | GET MEX property
org.apache.ode.bpel.myRoleSessi
onId = 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/m
obic/services/Video using MEX {PartnerRoleMex#hqejbhcnphr3mp5lpfmt4d [PID
{http:
//www.tsi.enst.fr}Test-1] calling
org.apache.ode.bpel.epr.WSAEndpoint@f5498f.cha
ngeScale(...)}
DEBUG - GeronimoLog.debug(66) | Message: <?xml version='1.0'
encoding='utf-8'?><
soapenv:Envelope
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soap
env:Body><changeScale xmlns="http://paam">
<stUrl
xmlns="">http://www.tsi.enst.fr/~elloumi/Medi
asDB/trailers/kill_bill_small.mp4</stUrl>
<width xmlns="">200</width>
<height xmlns="">200</height>
</changeScale></soapenv:Body></soapenv:Envelope>
DEBUG - GeronimoLog.debug(66) |
org.apache.ode.axis2.SoapExternalService$CachedO
ptions$1@df672a has been modified
DEBUG - GeronimoLog.debug(66) | Translating IL Properties for Axis2
DEBUG - GeronimoLog.debug(66) | replyAsync mex=hqejbhcnphr3mp5lpfmt4d
DEBUG - GeronimoLog.debug(66) | Setting execution state on instance 201
DEBUG - GeronimoLog.debug(66) | Releasing mex hqejbhcnphr3mp5lpfmt4a
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 he
aders for session passing.
DEBUG - GeronimoLog.debug(66) | <?xml version='1.0'
encoding='utf-8'?><soapenv:E
nvelope
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Heade
r><addr:To
xmlns:addr="http://www.w3.org/2005/08/addressing">http://localhost:80
80/mobic/services/Video</addr:To><addr:Action
xmlns:addr="http://www.w3.org/2005
/08/addressing"></addr:Action><addr:ReplyTo
xmlns:addr="http://www.w3.org/2005/0
8/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/ad
dressing">uuid:hqejbhcnphr3mp5lpfmt4e</addr:MessageID></soapenv:Header><soapenv:
Body><changeScale xmlns="http://paam">
<stUrl
xmlns="">http://www.tsi.enst.fr/~elloumi/Medi
asDB/trailers/kill_bill_small.mp4</stUrl>
<width xmlns="">200</width>
<height xmlns="">200</height>
</changeScale></soapenv:Body></soapenv:Envelope>
FFmpeg version SVN-r12665, Copyright (c) 2000-2008 Fabrice Bellard, et al.
configuration: --enable-gpl --enable-postproc --enable-swscale
--enable-avfilt
er-lavf --enable-pthreads --enable-liba52 --enable-avisynth
--enable-libfaac --e
nable-libfaad --enable-libgsm --enable-memalign-hack --enable-libmp3lame
--enabl
e-libnut --enable-libtheora --enable-libvorbis --enable-libx264
--enable-libxvid
--cpu=i686 --extra-ldflags=-static
libavutil version: 49.6.0
libavcodec version: 51.54.0
libavformat version: 52.13.0
libavdevice version: 52.0.0
built on Apr 2 2008 22:35:11, gcc: 4.2.3
Seems stream 2 codec frame rate differs from container frame rate: 25.00
(25/1)
-> 8.00 (120000/15000)
Input #0, mov,mp4,m4a,3gp,3g2,mj2, from
'C:\19801009_ENST_PAAM\1222698273484_287
4.mp4':
Duration: 00:02:28.4, start: 0.000000, bitrate: 314 kb/s
Stream #0.0(und): Data: mp4s / 0x7334706D
Stream #0.1(und): Data: mp4s / 0x7334706D
Stream #0.2(und): Video: mpeg4, yuv420p, 240x128 [PAR 1:1 DAR 15:8],
8.00 t
b(r)
Stream #0.3(und): Audio: mpeg4aac, 44100 Hz, stereo
Stream #0.4(und): Data: rtp / 0x20707472
Stream #0.5(und): Data: rtp / 0x20707472
Output #0, mp4, to 'C:\19801009_ENST_PAAM\1222698274015_4595.mp4':
Stream #0.0(und): Video: mpeg4, yuv420p, 200x200 [PAR 15:8 DAR 15:8],
q=2-31
, 200 kb/s, 8.00 tb(c)
Stream #0.1(und): Audio: libfaac, 44100 Hz, stereo, 64 kb/s
Stream mapping:
Stream #0.2 -> #0.0
Stream #0.3 -> #0.1
[mpeg4 @ 00ABC290]removing common factors from framerate
Press [q] to stop encoding
frame= 1173 fps= 58 q=1.6 Lsize= 4504kB time=146.6 bitrate= 251.7kbits/s
video:3600kB audio:841kB global headers:0kB muxing overhead 1.434929%
DEBUG - GeronimoLog.debug(66) | Service response:
<?xml version='1.0' encoding='utf-8'?><soapenv:Envelope
xmlns:soapenv="http://sc
hemas.xmlsoap.org/soap/envelope/"
xmlns:xsd="http://www.w3.org/2001/XMLSchema" x
mlns:xsi="http://www.w3.org/2001/XMLSchema-instance"><soapenv:Body><changeScaleR
esponse
xmlns="http://paam"><changeScaleReturn>http://vesta.enst.fr:8080/result/
1222698274015_4595.mp4</changeScaleReturn></changeScaleResponse></soapenv:Body><
/soapenv:Envelope>
DEBUG - GeronimoLog.debug(66) | Received response for MEX
{PartnerRoleMex#hqejbh
cnphr3mp5lpfmt4d [PID {http://www.tsi.enst.fr}Test-1] calling
null.changeScale(.
..)}
INFO - GeronimoLog.info(79) | Response:
<?xml version="1.0" encoding="UTF-8"?>
<message><parameters><changeScaleResponse xmlns="http://paam"
xmlns:soapenv="htt
p://schemas.xmlsoap.org/soap/envelope/"
xmlns:xsd="http://www.w3.org/2001/XMLSch
ema"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"><changeScaleReturn
xm
lns="http://paam">http://vesta.enst.fr:8080/result/1222698274015_4595.mp4</chang
eScaleReturn></changeScaleResponse></parameters></message>
DEBUG - GeronimoLog.debug(66) | reply mex=hqejbhcnphr3mp5lpfmt4d
DEBUG - GeronimoLog.debug(66) | create work event for
mex=hqejbhcnphr3mp5lpfmt4d
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
time=1
MICROSECONDS)
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
time=1
MICROSECONDS)-->GRANTED
DEBUG - GeronimoLog.debug(66) | >>
handleWorkEvent(jobData={mexid=hqejbhcnphr3mp
5lpfmt4d, iid=201, type=INVOKE_RESPONSE, channel=20})
DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for
instance 201.
INDEXED
STATE={OSequence#38-main::2=[SEQUENCE(self=(OSequence#38-main,Terminati
onChannel#3,ParentScopeChannel#5),
linkframe=org.apache.ode.bpel.runtime.LinkFra
me@1bf4c80, remaining=[{OScope 'Invoke' id=49}, {OScope 'Scope' id=56},
{OScope
'callbackClient' id=90}])], {OScope 'Invoke'
id=49}::9=[ACTIVITYGUARD(...)], OIn
voke#50-Invoke::12=[INVOKE(...)], {OScope '__PROCESS_SCOPE:Test'
id=20}::0=[ACTI
VE(...)], {OScope 'Invoke' id=49}::10=[ACTIVE(...)],
OSequence#38-main::1=[ACTIV
ITYGUARD(...)], {OScope '__PROCESS_SCOPE:Test' id=20}::0=[SCOPE(...)],
OInvoke#5
0-Invoke::11=[ACTIVITYGUARD(...)], {OScope 'Invoke' id=49}::10=[SCOPE(...)]}
DEBUG - GeronimoLog.debug(66) | InvokeResponse event for iid 201
DEBUG - GeronimoLog.debug(66) | Invoking message response for mexid
hqejbhcnphr3
mp5lpfmt4d and channel 20
DEBUG - GeronimoLog.debug(66) | Triggering response
DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#34: USING
CORRELATOR
36.say
DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#34: ADDED
ROUTE 36.s
ay: {CorrelationKey setId=35,
values=[http://www.tsi.enst.fr/~elloumi/MediasDB/t
railers/kill_bill_small.mp4]} --> 201
DEBUG - GeronimoLog.debug(66) | Setting execution state on instance 201
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=1
MICROSECONDS)
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: lock(iid=201,
time=1
MICROSECONDS)-->GRANTED
DEBUG - GeronimoLog.debug(66) | >>
handleWorkEvent(jobData={ckey=35~http://www.t
si.enst.fr/~~elloumi/MediasDB/trailers/kill_bill_small.mp4,
correlatorId=36.say,
inmem=false, iid=201, type=MATCHER})
DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for
instance 201.
INDEXED STATE={OSequence#57-Sequence::15=[ACTIVITYGUARD(...)],
OSequence#57-Seq
uence::16=[SEQUENCE(self=(OSequence#57-Sequence,TerminationChannel#25,ParentScop
eChannel#27), linkframe=org.apache.ode.bpel.runtime.LinkFrame@102c065,
remaining
=[OPickReceive#67-Pick])],
OSequence#38-main::2=[SEQUENCE(self=(OSequence#38-mai
n,TerminationChannel#3,ParentScopeChannel#5),
linkframe=org.apache.ode.bpel.runt
ime.LinkFrame@102c065, remaining=[{OScope 'Scope' id=56}, {OScope
'callbackClien
t' id=90}])], {OScope '__PROCESS_SCOPE:Test' id=20}::0=[ACTIVE(...)],
{OScope '_
_PROCESS_SCOPE:Test' id=20}::0=[SCOPE(...)], {OScope 'Scope'
id=56}::14=[SCOPE(.
..)], OSequence#38-main::1=[ACTIVITYGUARD(...)],
OPickReceive#67-Pick::20=[PICK(
...)], {OScope 'Scope' id=56}::14=[ACTIVE(...)], {OScope 'Scope'
id=56}::13=[ACT
IVITYGUARD(...)], OPickReceive#67-Pick::19=[ACTIVITYGUARD(...)]}
DEBUG - GeronimoLog.debug(66) | Matcher event for iid 201
DEBUG - GeronimoLog.debug(66) | MatcherEvent handling:
correlatorId=36.say, ckey
={CorrelationKey setId=35,
values=[http://www.tsi.enst.fr/~elloumi/MediasDB/trai
lers/kill_bill_small.mp4]}
DEBUG - GeronimoLog.debug(66) | MatcherEvent handling: nothing to do, no
matchin
g message in DB
DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-1,5,main]: unlock(iid=201)
--
Kinh