You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@ode.apache.org by "Maciej Szefler (JIRA)" <ji...@apache.org> on 2007/01/09 22:37:28 UTC
[jira] Assigned: (ODE-80) unreliable delivery of respons messages
[ https://issues.apache.org/jira/browse/ODE-80?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Maciej Szefler reassigned ODE-80:
---------------------------------
Assignee: Maciej Szefler
> unreliable delivery of respons messages
> ---------------------------------------
>
> Key: ODE-80
> URL: https://issues.apache.org/jira/browse/ODE-80
> Project: Apache Ode
> Issue Type: Bug
> Components: JBI Integration
> Environment: Windows XP, j2sdk1.5.0_06, ServiceMix 3.0 Release, ode-jbi-2.0-SNAPSHOT-installer.zip (revision 474898)
> Reporter: Matthias von Arx
> Assigned To: Maciej Szefler
> Attachments: ode_criminalregister_client.html, sa-criminalregister.zip, sa-federalcriminalregister.zip
>
>
> With the two SA'a attached to ODE-79 about 50% of the response messages will not be delivered to the caller. In case of fail the following lines were written to the log file:
> 15:15:14,420 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement(OFlow#64-invoke) = org.apache.ode.bpel.engine.BpelProcess$OBaseReplacementImpl@1d0ff95
> 15:15:14,420 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement({OScope '__PROCESS_SCOPE:CriminalRegisterProcess' id=3}) = org.apache.ode.bpel.engine.BpelProcess$OBaseReplacementImpl@d210b2
> 15:15:14,430 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement(OSequence#36-__unnamed:{http://schemas.xmlsoap.org/ws/2004/03/business-process/}sequence@63) = org.apache.ode.bpel.engine.BpelProcess$OBaseReplacementImpl@e9c7e4
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement({OAssign : assign3, joinCondition=null}) = org.apache.ode.bpel.engine.BpelProcess$OBaseReplacementImpl@1712372
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement(OReply#86-end) = org.apache.ode.bpel.engine.BpelProcess$OBaseReplacementImpl@ce2fdb
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement({OScope 'invokeFederalRegister' id=65}) = org.apache.ode.bpel.engine.BpelProcess$OBaseReplacementImpl@2ff64
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement(OInvoke#66-invokeFederalRegister) = org.apache.ode.bpel.engine.BpelProcess$OBaseReplacementImpl@7e6da
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement({Variable __PROCESS_SCOPE:CriminalRegisterProcess.federalResponse:OMessageVarType#22}) = org.apache.ode.bpel.engine.BpelProcess$OBaseReplacementImpl@1f6ad64
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement(OProcess#0) = org.apache.ode.bpel.engine.BpelProcess$OBaseReplacementImpl@1003ba9
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 339 | GC Channel: {CFRAME ParentScopeChannel:null#8 refCount=0, msgs=0, objs=0}
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 339 | GC Channel: {CFRAME TerminationChannel:null#11 refCount=0, msgs=0, objs=0}
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 339 | GC Channel: {CFRAME ParentScopeChannel:null#7 refCount=0, msgs=0, objs=0}
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 339 | GC Channel: {CFRAME ParentScopeChannel:null#12 refCount=0, msgs=0, objs=0}
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 339 | GC Channel: {CFRAME ParentScopeChannel:null#13 refCount=0, msgs=0, objs=0}
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 339 | GC Channel: {CFRAME PickResponseChannel:null#9 refCount=0, msgs=0, objs=0}
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 339 | GC Channel: {CFRAME TerminationChannel:null#6 refCount=0, msgs=0, objs=0}
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 339 | GC Channel: {CFRAME ParentScopeChannel:null#10 refCount=0, msgs=0, objs=0}
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME ParentScopeChannel:null#15 refCount=0, msgs=0, objs=1}
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME ParentScopeChannel:null#4 refCount=0, msgs=0, objs=1}
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME ParentScopeChannel:null#19 refCount=0, msgs=0, objs=1}
> 15:15:14,450 | DEBUG | Thread-19 | SedaQueue | .jbi.nmr.flow.seda.SedaQueue$1 225 | org.apache.servicemix.jbi.nmr.flow.seda.SedaQueue$1@931229 dequeued exchange: InOut[
> id: ID:chav548c-1815-1163599444703-4:25
> status: Done
> role: provider
> service: {http://jbi.exercise.com/xml/ns/services/federalcriminalregister}FederalCriminalRegisterService
> endpoint: JbiEndpoint
> operation: {http://jbi.exercise.com/xml/ns/services/federalcriminalregister}getCriminalRecords
> in: <?xml version="1.0" encoding="UTF-8"?><getCriminalRecords xmlns="http://jbi.exercise.com/xml/ns/services/federalcriminalregister" xmlns:ns2="http://jbi.exercise.com/xml/ns/services/federalcriminalregister">
> <ns2:principalId>2.2.2.2</ns2:principalId>
> </getCriminalRecords>
> out: <?xml version="1.0" encoding="UTF-8"?><getCriminalRecordsResponse xmlns="http://jbi.exercise.com/xml/ns/services/federalcriminalregister"><criminalRecords><ns1:CriminalRecord xmlns:ns1="http://federalcriminalregister.services.jbi.exercise.com"><dateOfArrest xmlns="http://federalcriminalregister.services.jbi.exercise.com">1990-04-20T00:00:00+02:00</dateOfArrest><dateOfDischarge xmlns="http://federalcriminalregister.services.jbi.exercise.com">1991-03-20T00:00:00+01:00</dateOfDischarge><dateOfIncident xmlns="http://federalcriminalregister.services.jbi.exercise.com">1990-03-18T00:00:00+01:00</dateOfIncident><kindOfIncident xmlns="http://federalcriminalregister.services.jbi.exercise.com">Theft</kindOfIncident></ns1:CriminalRecord></criminalRecords></getCriminalRecordsResponse>
> ]
> 15:15:14,450 | DEBUG | Thread-19 | DeliveryChannelImpl | .messaging.DeliveryChannelImpl 579 | Processing inbound exchange: InOut[
> id: ID:chav548c-1815-1163599444703-4:25
> status: Done
> role: provider
> service: {http://jbi.exercise.com/xml/ns/services/federalcriminalregister}FederalCriminalRegisterService
> endpoint: JbiEndpoint
> operation: {http://jbi.exercise.com/xml/ns/services/federalcriminalregister}getCriminalRecords
> in: <?xml version="1.0" encoding="UTF-8"?><getCriminalRecords xmlns="http://jbi.exercise.com/xml/ns/services/federalcriminalregister" xmlns:ns2="http://jbi.exercise.com/xml/ns/services/federalcriminalregister">
> <ns2:principalId>2.2.2.2</ns2:principalId>
> </getCriminalRecords>
> out: <?xml version="1.0" encoding="UTF-8"?><getCriminalRecordsResponse xmlns="http://jbi.exercise.com/xml/ns/services/federalcriminalregister"><criminalRecords><ns1:CriminalRecord xmlns:ns1="http://federalcriminalregister.services.jbi.exercise.com"><dateOfArrest xmlns="http://federalcriminalregister.services.jbi.exercise.com">1990-04-20T00:00:00+02:00</dateOfArrest><dateOfDischarge xmlns="http://federalcriminalregister.services.jbi.exercise.com">1991-03-20T00:00:00+01:00</dateOfDischarge><dateOfIncident xmlns="http://federalcriminalregister.services.jbi.exercise.com">1990-03-18T00:00:00+01:00</dateOfIncident><kindOfIncident xmlns="http://federalcriminalregister.services.jbi.exercise.com">Theft</kindOfIncident></ns1:CriminalRecord></criminalRecords></getCriminalRecordsResponse>
> ]
> 15:15:14,450 | DEBUG | Thread-19 | DeliveryChannelImpl | .messaging.DeliveryChannelImpl 615 | Received: InOut[
> id: ID:chav548c-1815-1163599444703-4:25
> status: Done
> role: provider
> service: {http://jbi.exercise.com/xml/ns/services/federalcriminalregister}FederalCriminalRegisterService
> endpoint: JbiEndpoint
> operation: {http://jbi.exercise.com/xml/ns/services/federalcriminalregister}getCriminalRecords
> in: <?xml version="1.0" encoding="UTF-8"?><getCriminalRecords xmlns="http://jbi.exercise.com/xml/ns/services/federalcriminalregister" xmlns:ns2="http://jbi.exercise.com/xml/ns/services/federalcriminalregister">
> <ns2:principalId>2.2.2.2</ns2:principalId>
> </getCriminalRecords>
> out: <?xml version="1.0" encoding="UTF-8"?><getCriminalRecordsResponse xmlns="http://jbi.exercise.com/xml/ns/services/federalcriminalregister"><criminalRecords><ns1:CriminalRecord xmlns:ns1="http://federalcriminalregister.services.jbi.exercise.com"><dateOfArrest xmlns="http://federalcriminalregister.services.jbi.exercise.com">1990-04-20T00:00:00+02:00</dateOfArrest><dateOfDischarge xmlns="http://federalcriminalregister.services.jbi.exercise.com">1991-03-20T00:00:00+01:00</dateOfDischarge><dateOfIncident xmlns="http://federalcriminalregister.services.jbi.exercise.com">1990-03-18T00:00:00+01:00</dateOfIncident><kindOfIncident xmlns="http://federalcriminalregister.services.jbi.exercise.com">Theft</kindOfIncident></ns1:CriminalRecord></criminalRecords></getCriminalRecordsResponse>
> ]
> 15:15:14,450 | DEBUG | Thread-19 | Jsr181Component | emix.common.AsyncBaseLifeCycle 388 | Received exchange: status: Done, role: provider
> 15:15:14,450 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME InvokeResponseChannel:null#23 refCount=1, msgs=0, objs=1}
> 15:15:14,450 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME ParentScopeChannel:null#16 refCount=0, msgs=0, objs=1}
> 15:15:14,450 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME ParentScopeChannel:null#18 refCount=0, msgs=0, objs=1}
> 15:15:14,450 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME TerminationChannel:null#3 refCount=0, msgs=0, objs=1}
> 15:15:14,450 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME ParentScopeChannel:null#22 refCount=0, msgs=0, objs=1}
> 15:15:14,450 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME TerminationChannel:null#17 refCount=0, msgs=0, objs=1}
> 15:15:14,450 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME ParentScopeChannel:null#2 refCount=0, msgs=0, objs=1}
> 15:15:14,450 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME ParentScopeChannel:null#21 refCount=0, msgs=0, objs=1}
> 15:15:14,460 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME TerminationChannel:null#1 refCount=0, msgs=0, objs=1}
> 15:15:14,460 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME TerminationChannel:null#20 refCount=0, msgs=0, objs=0}
> 15:15:14,460 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME TerminationChannel:null#14 refCount=0, msgs=0, objs=1}
> 15:15:14,460 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | e.jacob.vpu.ExecutionQueueImpl 349 | Writing Channel: {CFRAME ParentScopeChannel:null#5 refCount=0, msgs=0, objs=1}
> 15:15:14,460 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl | mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement(OPartnerLink#34) = org.apache.ode.bpel.engine.BpelProcess$OBaseReplacementImpl@1a4c884
> 15:15:14,460 | DEBUG | pool-2-thread-2 | OdeService | org.apache.ode.jbi.OdeService 236 | ODE MEX {MyRoleMex#98354 [Client ID:chav548c-1815-1163599444703-8:25] calling {http://jbi.exercise.com/xml/ns/services/criminalregister}CriminalRegisterService.getCriminalRecords(...)} completed ASYNCHRONOUSLY.
> 15:15:14,460 | DEBUG | pool-2-thread-2 | OdeService | org.apache.ode.jbi.OdeService 250 | Commiting ODE MEX {MyRoleMex#98354 [Client ID:chav548c-1815-1163599444703-8:25] calling {http://jbi.exercise.com/xml/ns/services/criminalregister}CriminalRegisterService.getCriminalRecords(...)}
> 15:15:18,005 | DEBUG | Timer-2 | AutoDeploymentService | ramework.AutoDeploymentService 568 | Monitoring directory D:\servicemix-3.0\install for new or modified archives
> 15:15:18,005 | DEBUG | Timer-2 | AutoDeploymentService | ramework.AutoDeploymentService 568 | Monitoring directory D:\servicemix-3.0\deploy for new or modified archives
> 15:15:28,011 | DEBUG | Timer-2 | AutoDeploymentService | ramework.AutoDeploymentService 568 | Monitoring directory D:\servicemix-3.0\install for new or modified archives
> 15:15:28,011 | DEBUG | Timer-2 | AutoDeploymentService | ramework.AutoDeploymentService 568 | Monitoring directory D:\servicemix-3.0\deploy for new or modified archives
> 15:15:38,067 | DEBUG | Timer-2 | AutoDeploymentService | ramework.AutoDeploymentService 568 | Monitoring directory D:\servicemix-3.0\install for new or modified archives
> 15:15:38,067 | DEBUG | Timer-2 | AutoDeploymentService | ramework.AutoDeploymentService 568 | Monitoring directory D:\servicemix-3.0\deploy for new or modified archives
> 15:15:42,304 | DEBUG | QuartzScheduler_ODEScheduler-ODE_MisfireHandler | JobStoreJTA | JobStoreSupport$MisfireHandler 2407 | MisfireHandler: scanning for misfires...
> 15:15:42,314 | DEBUG | QuartzScheduler_ODEScheduler-ODE_MisfireHandler | JobStoreJTA | l.jdbcjobstore.JobStoreSupport 745 | Found 0 triggers that missed their scheduled fire-time.
--
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators: https://issues.apache.org/jira/secure/Administrators.jspa
-
For more information on JIRA, see: http://www.atlassian.com/software/jira