Hi,
We moved our configuration of 3A8 collaboration from our test instance to our productions instance. I looked thoroughly many times and I do not see any differences in the settings between this two instances. The 3A8 worked fine on the test server, but on production server, while processing the Acknowledgement the following error occurs:
Error -: AIP-50906: Failed to retrieve value for the given XPATH.
As you can see below, it is done when Converting B2B message to ECX message is performed. I Think this should not happen at all, as I assume this is what the setting 'Is Acknowledgement handled by Integration B2B? Yes' should result in consuming the ACK message by the B2B server. 3A4 is working fine on the same Delivery Channels on both ends.
Please advise.
Thank you in advance.
I have compared the logs with our test server logs and found that the productions server, is trying to do 'more':
2009.03.23 at 14:14:59:554: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.Acknowledgment:continueAcknowledgmentPostColab Document exchange Post Validation done
======================================================================
======================================================================
===== The following part does not happen on our test instance, ACK processing ends here successfully ======
======================================================================
======================================================================
2009.03.23 at 14:14:59:554: Thread-12: BusinessLogicLayer - (DEBUG) Authorization disabled. UserBootstrapped:false, useAuthorization:true, configType:null
2009.03.23 at 14:14:59:554: Thread-12: BusinessLogicLayer - (DEBUG) Push Stack: queryBusinessMessage
2009.03.23 at 14:14:59:555: Thread-12: BusinessLogicLayer - (DEBUG) Pop Stack: queryBusinessMessage
2009.03.23 at 14:14:59:555: Thread-12: B2B - (DEBUG) AccessRepo:findBusinessMessageByB2BMessageId Found Successfull message with B2bMessageId : 35958:24:1:137 and ProtocolMessageId 35958:24:1:137
2009.03.23 at 14:14:59:555: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:DbAccess:formExtB2bMsg Enter
2009.03.23 at 14:14:59:557: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:DbAccess:formExtB2bMsg business transaction instance is not null
2009.03.23 at 14:14:59:557: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:DbAccess:formExtB2bMsg collaboration instance is not null
2009.03.23 at 14:14:59:557: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:DbAccess:formExtB2bMsg B2B Msg Id + 35958:24:1:137
2009.03.23 at 14:14:59:558: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:DbAccess:formExtB2bMsg B2B Collaboration Id + C0A8021E12033781EB8000006A463400
2009.03.23 at 14:14:59:558: Thread-12: B2B - (DEBUG) calling setMode() changing from -1 to 2
2009.03.23 at 14:14:59:558: Thread-12: B2B - (DEBUG) calling setMode() changing from -1 to 2
2009.03.23 at 14:14:59:560: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:
** DbAccess:formExtB2bMsg protocolCollabID = null
2009.03.23 at 14:14:59:560: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:
** DbAccess:formExtB2bMsg msgInfo.id = 35958:24:1:137
2009.03.23 at 14:14:59:561: Thread-12: B2B - (DEBUG) calling setFromPartyId() changing from null to TPName: HOST_COMPANY Type: DUNS Value: 123456789
2009.03.23 at 14:14:59:561: Thread-12: B2B - (DEBUG) calling setToPartyId() changing from null to TPName: TRADINGP Type: DUNS Value: 987654321
2009.03.23 at 14:14:59:561: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:DbAccess:formExtB2bMsg Exit
2009.03.23 at 14:14:59:561: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.Acknowledgment:getAckPayload Enter
2009.03.23 at 14:14:59:561: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.Acknowledgment:getAckPayload Payload:
<ReceiptAcknowledgment>
<inReplyTo>
<thisDocumentIdentifier>
<ProprietaryDocumentIdentifier>35958:24:1:137</ProprietaryDocumentIdentifier>
</thisDocumentIdentifier>
</inReplyTo>
</ReceiptAcknowledgment>
2009.03.23 at 14:14:59:561: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.Acknowledgment:getAckPayload Exit
2009.03.23 at 14:14:59:561: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.MessageHandler:deliverMessageToDestination Enter
2009.03.23 at 14:14:59:561: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.MessageHandler:deliverMessageToDestination CUSTOM_HEADERnull
2009.03.23 at 14:14:59:561: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.MessageHandler:deliverMessageToDestination deliver message to destination. protocol is XMLGateway Queues
2009.03.23 at 14:14:59:561: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.MessageHandler:deliverMessageToDestination deliver message to XMLGW
2009.03.23 at 14:14:59:561: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 Converting B2B message to ECX message..
2009.03.23 at 14:14:59:561: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 Inbound - B2BtoECX - Enter
2009.03.23 at 14:14:59:562: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 B2B Message -
2009.03.23 at 14:14:59:562: Thread-12: B2B - (DEBUG) : COLLABORATION_NAME : 3A8
2009.03.23 at 14:14:59:562: Thread-12: B2B - (DEBUG) : ACTION_NAME : Receipt Acknowledgment
2009.03.23 at 14:14:59:562: Thread-12: B2B - (DEBUG) : DOCUMENT_TYPE : CHANGEPO_REQ
2009.03.23 at 14:14:59:562: Thread-12: B2B - (DEBUG) : DOCUMENT_TYPE_REVISION : 2
2009.03.23 at 14:14:59:562: Thread-12: B2B - (DEBUG) : SOURCE_NAME : TRADINGP
2009.03.23 at 14:14:59:562: Thread-12: B2B - (DEBUG) : DESTINATION_NAME : HOST_COMPANY
2009.03.23 at 14:14:59:562: Thread-12: B2B - (DEBUG) : PAYLOAD : <ReceiptAcknowledgment>
<inReplyTo>
<thisDocumentIdentifier>
<ProprietaryDocumentIdentifier>35958:24:1:137</ProprietaryDocumentIdentifier>
</thisDocumentIdentifier>
</inReplyTo>
</ReceiptAcknowledgment>
2009.03.23 at 14:14:59:562: Thread-12: B2B - (DEBUG) : PAYLOAD : <?xml version="1.0" encoding="UTF-8" ?>
<!DOCTYPE ReceiptAcknowledgment SYSTEM "AcknowledgmentOfReceipt_MS_V02_00.dtd">
<ReceiptAcknowledgment/>
2009.03.23 at 14:14:59:562: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 Enter rnToECX
2009.03.23 at 14:14:59:562: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 The message type is 3
2009.03.23 at 14:14:59:562: Thread-12: BusinessLogicLayer - (DEBUG) Authorization disabled. UserBootstrapped:false, useAuthorization:true, configType:null
2009.03.23 at 14:14:59:562: Thread-12: BusinessLogicLayer - (DEBUG) Push Stack: queryTradingPartner
2009.03.23 at 14:14:59:563: Thread-12: BusinessLogicLayer - (DEBUG) Pop Stack: queryTradingPartner
2009.03.23 at 14:14:59:563: Thread-12: BusinessLogicLayer - (DEBUG) Authorization disabled. UserBootstrapped:false, useAuthorization:true, configType:null
2009.03.23 at 14:14:59:563: Thread-12: BusinessLogicLayer - (DEBUG) Push Stack: queryTradingPartnerIdentification
2009.03.23 at 14:14:59:564: Thread-12: BusinessLogicLayer - (DEBUG) Pop Stack: queryTradingPartnerIdentification
2009.03.23 at 14:14:59:564: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 nothing is null
2009.03.23 at 14:14:59:564: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 getXPathValList - Enter
2009.03.23 at 14:14:59:564: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 getXPathValList - payload [C@10bb83e
2009.03.23 at 14:14:59:564: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 getXPathValList - xpath //receivedDocumentIdentifier/ProprietaryDocumentIdentifier
2009.03.23 at 14:14:59:565: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 getXPathValList Parsing Done!!
2009.03.23 at 14:14:59:565: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 Number of values found for xpath is 0
2009.03.23 at 14:14:59:565: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 getXPathValList - Error in extracting XPATH Value - NO values found
2009.03.23 at 14:14:59:565: Thread-12: B2B - (ERROR) Error -: AIP-50906: Failed to retrieve value for the given XPATH
at oracle.tip.adapter.b2b.xmlgwIntg.Inbound.getXPathValList(Inbound.java:719)
at oracle.tip.adapter.b2b.xmlgwIntg.Inbound.rnToECX(Inbound.java:479)
at oracle.tip.adapter.b2b.xmlgwIntg.Inbound.B2BtoECX(Inbound.java:392)
at oracle.tip.adapter.b2b.xmlgwIntg.Inbound.processInboundMessage(Inbound.java:259)
at oracle.tip.adapter.b2b.xmlgwIntg.XMLGWIntegration.raiseInboundMessage(XMLGWIntegration.java:148)
at oracle.tip.adapter.b2b.msgproc.MessageHandler.deliverMessageToDestination(MessageHandler.java:312)
at oracle.tip.adapter.b2b.msgproc.Acknowledgment.continueAckPostColab(Acknowledgment.java:1135)
at oracle.tip.adapter.b2b.msgproc.Acknowledgment.continueAck(Acknowledgment.java:1064)
at oracle.tip.adapter.b2b.msgproc.Acknowledgment.incomingAcknowledgment(Acknowledgment.java:1017)
at oracle.tip.adapter.b2b.engine.Engine.processIncomingMessage(Engine.java:2130)
at oracle.tip.adapter.b2b.engine.Engine.incomingContinueProcess(Engine.java:2573)
at oracle.tip.adapter.b2b.engine.Engine.handleMessageEvent(Engine.java:2443)
at oracle.tip.adapter.b2b.engine.Engine.processEvents(Engine.java:2398)
at oracle.tip.adapter.b2b.data.MsgListener.onMessage(MsgListener.java:527)
at oracle.tip.adapter.b2b.data.MsgListener.run(MsgListener.java:374)
at java.lang.Thread.run(Thread.java:534)
2009.03.23 at 14:14:59:566: Thread-12: B2B - (ERROR) Error -: AIP-50906: Failed to retrieve value for the given XPATH
at oracle.tip.adapter.b2b.xmlgwIntg.Inbound.getXPathValList(Inbound.java:719)
at oracle.tip.adapter.b2b.xmlgwIntg.Inbound.rnToECX(Inbound.java:479)
at oracle.tip.adapter.b2b.xmlgwIntg.Inbound.B2BtoECX(Inbound.java:392)
at oracle.tip.adapter.b2b.xmlgwIntg.Inbound.processInboundMessage(Inbound.java:259)
at oracle.tip.adapter.b2b.xmlgwIntg.XMLGWIntegration.raiseInboundMessage(XMLGWIntegration.java:148)
at oracle.tip.adapter.b2b.msgproc.MessageHandler.deliverMessageToDestination(MessageHandler.java:312)
at oracle.tip.adapter.b2b.msgproc.Acknowledgment.continueAckPostColab(Acknowledgment.java:1135)
at oracle.tip.adapter.b2b.msgproc.Acknowledgment.continueAck(Acknowledgment.java:1064)
at oracle.tip.adapter.b2b.msgproc.Acknowledgment.incomingAcknowledgment(Acknowledgment.java:1017)
at oracle.tip.adapter.b2b.engine.Engine.processIncomingMessage(Engine.java:2130)
at oracle.tip.adapter.b2b.engine.Engine.incomingContinueProcess(Engine.java:2573)
at oracle.tip.adapter.b2b.engine.Engine.handleMessageEvent(Engine.java:2443)
at oracle.tip.adapter.b2b.engine.Engine.processEvents(Engine.java:2398)
at oracle.tip.adapter.b2b.data.MsgListener.onMessage(MsgListener.java:527)
at oracle.tip.adapter.b2b.data.MsgListener.run(MsgListener.java:374)
at java.lang.Thread.run(Thread.java:534)
2009.03.23 at 14:14:59:566: Thread-12: B2B - (DEBUG) : Mon Mar 23 14:14:59 CET 2009 Inbound shutdown failed - close db connection
2009.03.23 at 14:14:59:566: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.MessageHandler:handleAppMessageRetry Could not deliver the message; exception message is Error -: AIP-50906: Failed to retrieve value for the given XPATH
2009.03.23 at 14:14:59:567: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.MessageHandler:handleAppMessageRetry Application side retry shall happen at Mon Mar 23 16:14:59 CET 2009
2009.03.23 at 14:14:59:567: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:DbAccess:insertEvtTblRow Enter
2009.03.23 at 14:14:59:567: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:DbAccess:insertEvtTblRow Event Type = 2
2009.03.23 at 14:14:59:567: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:DbAccess:insertEvtTblRow EventId = 27
2009.03.23 at 14:14:59:567: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:DbAccess:insertEvtTblRow Id = C0A8021E12033783E14000006A463D00-1
2009.03.23 at 14:14:59:569: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.DbAccess:DbAccess:insertEvtTblRow Exit
2009.03.23 at 14:14:59:569: Thread-12: BusinessLogicLayer - (DEBUG) Authorization disabled. UserBootstrapped:false, useAuthorization:true, configType:null
2009.03.23 at 14:14:59:569: Thread-12: BusinessLogicLayer - (DEBUG) Push Stack: updateBusinessMessage
2009.03.23 at 14:14:59:570: Thread-12: BusinessLogicLayer - (DEBUG) Pop Stack: updateBusinessMessage
2009.03.23 at 14:14:59:570: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.MessageHandler:handleAppMessageRetry remaining retry 2
2009.03.23 at 14:14:59:571: Thread-12: BusinessLogicLayer - (DEBUG) Authorization disabled. UserBootstrapped:false, useAuthorization:true, configType:null
2009.03.23 at 14:14:59:571: Thread-12: BusinessLogicLayer - (DEBUG) Push Stack: updateBusinessMessage
2009.03.23 at 14:14:59:572: Thread-12: BusinessLogicLayer - (DEBUG) Pop Stack: updateBusinessMessage
2009.03.23 at 14:14:59:572: Thread-12: BusinessLogicLayer - (DEBUG) Authorization disabled. UserBootstrapped:false, useAuthorization:true, configType:null
2009.03.23 at 14:14:59:572: Thread-12: BusinessLogicLayer - (DEBUG) Push Stack: updateBusinessTransactionInstance
2009.03.23 at 14:14:59:574: Thread-12: BusinessLogicLayer - (DEBUG) Pop Stack: updateBusinessTransactionInstance
2009.03.23 at 14:14:59:574: Thread-12: B2B - (DEBUG) oracle.tip.adapter.b2b.msgproc.MessageHandler:deliverMessageToDestination Exit
Edited by: Kamil Zadora on Mar 24, 2009 2:07 AM