[
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) = [EMAIL PROTECTED]
> 15:15:14,420 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl |
> mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement({OScope
> '__PROCESS_SCOPE:CriminalRegisterProcess' id=3}) = [EMAIL PROTECTED]
> 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/[EMAIL
> PROTECTED]) = [EMAIL PROTECTED]
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl |
> mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement({OAssign
> : assign3, joinCondition=null}) = [EMAIL PROTECTED]
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl |
> mpl$ExecutionQueueOutputStream 694 | ReplacmentMap:
> getReplacement(OReply#86-end) = [EMAIL PROTECTED]
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl |
> mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement({OScope
> 'invokeFederalRegister' id=65}) = [EMAIL PROTECTED]
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl |
> mpl$ExecutionQueueOutputStream 694 | ReplacmentMap:
> getReplacement(OInvoke#66-invokeFederalRegister) = [EMAIL PROTECTED]
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl |
> mpl$ExecutionQueueOutputStream 694 | ReplacmentMap: getReplacement({Variable
> __PROCESS_SCOPE:CriminalRegisterProcess.federalResponse:OMessageVarType#22})
> = [EMAIL PROTECTED]
> 15:15:14,440 | DEBUG | pool-2-thread-2 | ExecutionQueueImpl |
> mpl$ExecutionQueueOutputStream 694 | ReplacmentMap:
> getReplacement(OProcess#0) = [EMAIL PROTECTED]
> 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 | [EMAIL PROTECTED] 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) = [EMAIL PROTECTED]
> 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
