7 Replies Latest reply: Apr 24, 2012 7:37 AM by 781423 RSS

    Populating EBM Header For Trace logging

    913950
      Hi All..

      I am using Jdveloper 11.1.1.5 and AIA FP 3.0

      When ever Sublanguage execution fault occurs or Catch All Block gets executed, i.e. AIAAsyncErrorHandlingBPELProcess is getting called.. I am not getting all the fields populated in my aia-trace.log file as shown below

      <msg time='2012-04-10T12:07:04.658+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='44' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:-39f97d71:13696b31bf7:-8000-0000000000026c91' rid='0:1:100003223'>
      <attr name='APP' value='soa-infra'/>
      <attr name='VERB_CODE' value=''/>
      <attr name='SENDER_TRANSACTION_CODE' value=''/>
      <attr name='SENDER_ID' value=''/>
      <attr name='EBM_ID' value=''/>
      <attr name='EBO_NAME' value=''/>
      <attr name='SENDER_MESSAGE_ID' value=''/>
      <attr name='EBM_NAME' value=''/>
      <attr name='ECID' value='ec0c5aae6e6c1184:-39f97d71:13696b31bf7:-8000-0000000000026c91'/>
      <txt>published message on JMS Error Queue</txt>
      </msg>


      but when i am getting remote/binding fault i.e. Fault policy is getting used i am getting proper tracing in aia-trace.log as shown below

      <msg time='2012-04-10T21:58:33.807+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='20' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc' rid='0:3'>
      <attr name='APP' value='soa-infra'/>
      <attr name='VERB_CODE' value='Sync'/>
      <attr name='SENDER_TRANSACTION_CODE' value=''/>
      <attr name='SENDER_ID' value='JDEE1'/>
      <attr name='EBM_ID' value='2d353039343832393034353230383730'/>
      <attr name='EBO_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBO'/>
      <attr name='SENDER_MESSAGE_ID' value=''/>
      <attr name='EBM_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBM'/>
      <attr name='ECID' value='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc'/>
      <txt>published message on JMS Error Queue</txt>
      </msg>

      thanks in advance.. i am stuck on this from many days..

      PS: i have checked in assign ora:processXSLT('xsl/EBM_to_Fault.xsl',bpws:getVariableData('EBM_HEADER')) is getting assigned to AIAAsyncErrorHandlingBPELProcessRequestMessage/FaultMessage/Fault so it should take care of populating the header in this case..

      Need Help :(
        • 1. Re: Populating EBM Header For Trace logging
          913950
          Detailed Trace log in Case AIAAsyncErrorHandlingBPELProcess is getting called -> Details gets missing only when message is published on JMS Error Queue

          <msg time='2012-04-10T21:59:50.298+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='19' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115b33' rid='0:3'>
          <attr name='APP' value='soa-infra'/>
          <txt>Starting SyncSupplierPartyFaultHandlingReqABCSImplProcess Instance: 1391992Sync SupplierParty</txt>
          </msg>
          <msg time='2012-04-10T21:59:50.508+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='19' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115b33' rid='0:3'>
          <attr name='APP' value='soa-infra'/>
          <txt>Starting SyncSupplierPartyFaultHandlingReqABCSImplProcess Before SupplierPartyEBMReqMsg Transform Instance: 1391992Sync SupplierParty</txt>
          </msg>
          <msg time='2012-04-10T21:59:50.552+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='19' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115b33' rid='0:3'>
          <attr name='APP' value='soa-infra'/>
          <txt>Starting SyncSupplierPartyFaultHandlingReqABCSImplProcess After SupplierPartyEBMReqMsg Transform Instance: 1391992Sync SupplierParty</txt>
          </msg>
          <msg time='2012-04-10T21:59:50.588+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='19' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115b33' rid='0:3'>
          <attr name='APP' value='soa-infra'/>
          <attr name='VERB_CODE' value='Sync'/>
          <attr name='SENDER_TRANSACTION_CODE' value=''/>
          <attr name='SENDER_ID' value='JDEE1'/>
          <attr name='EBM_ID' value='2d323732363139373930323535313839'/>
          <attr name='EBO_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBO'/>
          <attr name='SENDER_MESSAGE_ID' value=''/>
          <attr name='EBM_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBM'/>
          <attr name='ECID' value='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115b33'/>
          <txt>Starting SyncSupplierPartyFaultHandlingReqABCSImplProcess Before SupplierParty Service Invoke Instance: 1391992Sync SupplierParty</txt>
          </msg>
          <msg time='2012-04-10T21:59:50.598+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='19' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115b33' rid='0:3'>
          <attr name='APP' value='soa-infra'/>
          <attr name='VERB_CODE' value='Sync'/>
          <attr name='SENDER_TRANSACTION_CODE' value=''/>
          <attr name='SENDER_ID' value='JDEE1'/>
          <attr name='EBM_ID' value='2d323732363139373930323535313839'/>
          <attr name='EBO_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBO'/>
          <attr name='SENDER_MESSAGE_ID' value=''/>
          <attr name='EBM_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBM'/>
          <attr name='ECID' value='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115b33'/>
          <txt>Starting SyncSupplierPartyFaultHandlingReqABCSImplProcess Entering Error Hanlder Catch All Instance: 1391992Sync SupplierParty</txt>
          </msg>
          *<msg time='2012-04-10T21:59:50.740+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='19' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115b33' rid='0:3'>*
          *<attr name='APP' value='soa-infra'/>*
          *<attr name='VERB_CODE' value=''/>*
          *<attr name='SENDER_TRANSACTION_CODE' value=''/>*
          *<attr name='SENDER_ID' value=''/>*
          *<attr name='EBM_ID' value=''/>*
          *<attr name='EBO_NAME' value=''/>*
          *<attr name='SENDER_MESSAGE_ID' value=''/>*
          *<attr name='EBM_NAME' value=''/>*
          *<attr name='ECID' value='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115b33'/>*
          *<txt>published message on JMS Error Queue</txt>*
          *</msg>*


          And


          Detailed Trace Log in case of Binding/Remote Fault- Details are present even when message is published on error queue

          <msg time='2012-04-10T21:58:33.491+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='20' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc' rid='0:3'>
          <attr name='APP' value='soa-infra'/>
          <txt>Starting SyncSupplierMasterFaultHandling7ReqABCSImplProcess Instance: 1391991Sync SupplierMaster</txt>
          </msg>
          <msg time='2012-04-10T21:58:33.491+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='20' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc' rid='0:3'>
          <attr name='APP' value='soa-infra'/>
          <txt>Starting SyncSupplierMasterFaultHandling7ReqABCSImplProcess Before SupplierPartyEBMReqMsg Transform Instance: 1391991Sync SupplierMaster</txt>
          </msg>
          <msg time='2012-04-10T21:58:33.497+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='20' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc' rid='0:3'>
          <attr name='APP' value='soa-infra'/>
          <txt>Starting SyncSupplierMasterFaultHandling7ReqABCSImplProcess After SupplierPartyEBMReqMsg Transform Instance: 1391991Sync SupplierMaster</txt>
          </msg>
          <msg time='2012-04-10T21:58:33.527+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='20' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc' rid='0:3'>
          <attr name='APP' value='soa-infra'/>
          <attr name='VERB_CODE' value='Sync'/>
          <attr name='SENDER_TRANSACTION_CODE' value=''/>
          <attr name='SENDER_ID' value='JDEE1'/>
          <attr name='EBM_ID' value='2d353039343832393034353230383730'/>
          <attr name='EBO_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBO'/>
          <attr name='SENDER_MESSAGE_ID' value=''/>
          <attr name='EBM_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBM'/>
          <attr name='ECID' value='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc'/>
          <txt>Starting SyncSupplierMasterFaultHandling7ReqABCSImplProcess Before SupplierParty Service Invoke Instance: 1391991Sync SupplierMaster</txt>
          </msg>
          <msg time='2012-04-10T21:58:33.704+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='20' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc' rid='0:3'>
          <attr name='APP' value='soa-infra'/>
          <attr name='VERB_CODE' value='Sync'/>
          <attr name='SENDER_TRANSACTION_CODE' value=''/>
          <attr name='SENDER_ID' value='JDEE1'/>
          <attr name='EBM_ID' value='2d353039343832393034353230383730'/>
          <attr name='EBO_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBO'/>
          <attr name='SENDER_MESSAGE_ID' value=''/>
          <attr name='EBM_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBM'/>
          <attr name='ECID' value='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc'/>
          <txt>Redirecting to BPEL Error Handling</txt>
          </msg>
          <msg time='2012-04-10T21:58:33.704+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='20' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc' rid='0:3'>
          <attr name='APP' value='soa-infra'/>
          <attr name='VERB_CODE' value='Sync'/>
          <attr name='SENDER_TRANSACTION_CODE' value=''/>
          <attr name='SENDER_ID' value='JDEE1'/>
          <attr name='EBM_ID' value='2d353039343832393034353230383730'/>
          <attr name='EBO_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBO'/>
          <attr name='SENDER_MESSAGE_ID' value=''/>
          <attr name='EBM_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBM'/>
          <attr name='ECID' value='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc'/>
          <txt>Redirecting to BPEL Error Handling</txt>
          </msg>
          *<msg time='2012-04-10T21:58:33.807+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='20' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc' rid='0:3'>*
          *<attr name='APP' value='soa-infra'/>*
          *<attr name='VERB_CODE' value='Sync'/>*
          *<attr name='SENDER_TRANSACTION_CODE' value=''/>*
          *<attr name='SENDER_ID' value='JDEE1'/>*
          *<attr name='EBM_ID' value='2d353039343832393034353230383730'/>*
          *<attr name='EBO_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBO'/>*
          *<attr name='SENDER_MESSAGE_ID' value=''/>*
          *<attr name='EBM_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBM'/>*
          *<attr name='ECID' value='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc'/>*
          *<txt>published message on JMS Error Queue</txt>*
          *</msg>*
          <msg time='2012-04-10T21:58:33.865+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='XXXXXXXXXX' host_addr='XXX.XXX.XX.XX' module='oracle.aia.logging.trace' tid='20' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc' rid='0:3'>
          <attr name='APP' value='soa-infra'/>
          <attr name='VERB_CODE' value='Sync'/>
          <attr name='SENDER_TRANSACTION_CODE' value=''/>
          <attr name='SENDER_ID' value='JDEE1'/>
          <attr name='EBM_ID' value='2d353039343832393034353230383730'/>
          <attr name='EBO_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBO'/>
          <attr name='SENDER_MESSAGE_ID' value=''/>
          <attr name='EBM_NAME' value='{http://xmlns.oracle.com/EnterpriseObjects/Core/EBO/SupplierParty/V1}SyncSupplierPartyEBM'/>
          <attr name='ECID' value='ec0c5aae6e6c1184:278cba51:13671970df8:-8000-0000000000115adc'/>
          <txt>Starting SyncSupplierMasterFaultHandling7ReqABCSImplProcess Entering Error Hanlder Remote Fault Instance: 1391991Sync SupplierMaster</txt>
          </msg>


          Someone pls tell why is this happening??????
          • 2. Re: Populating EBM Header For Trace logging
            781423
            Are you setting all the required values in ebm reference section of constructed AIA Fault ?.
            • 3. Re: Populating EBM Header For Trace logging
              913950
              Hi Veeru ,

              Can you please elaborate it bit more..

              What you mean by setting all the required values in ebm reference section ???

              I am using Transform created by AIA and EBM Header is getting populated which is required for logging -> right?

              For Remote and Binding fault all the values are getting populated..
              But For Sub Language execution fault and catch all the message is not getting populated properly as explained above in aia-error and aia-log file ..

              Please Help.. :(
              • 4. Re: Populating EBM Header For Trace logging
                617580
                Could you please check if in your ebm_to_fault.xsl, the transformation for element <corecom:IntermediateMessageHop> is present or not?
                • 5. Re: Populating EBM Header For Trace logging
                  913950
                  Hi Vijay,

                  The transformation for element <corecom:IntermediateMessageHop> is not present in my EBM_to_Fault.xsl..

                  Please tell where can i add it, if it can sove my problem..


                  Please Reply.. Thanks in advance

                  Also when i checked my flow trace, i could find only this in my fault message which is going as input to AIAAsyncErrorHandlingBPELProcess.. Am i missing something here?

                  <AIAAsyncErrorHandlingBPELProcessRequestMessage>
                       <part name="FaultMessage">
                            <Fault>
                                 <corecom:FaultNotification>
                                 <corecom:ReportingDateTime>2012-04-23T21:34:51+05:30</corecom:ReportingDateTime>
                                 <corecom:CorrectiveAction/>
                                 <corecom:FaultMessage>
                                 <Code>XPathExecutionError</Code>
                                 <Text>XPath expression failed to execute.</Text>
                                 <corecom:Severity/>
                                 <corecom:Stack/>
                                 </corecom:FaultMessage>
                                 <corecom:FaultingService>
                                 <corecom:ID>SyncSupplierMasterFaultHandling7ReqABCSImplProcess</corecom:ID>
                                 <corecom:ImplementationCode>BPEL</corecom:ImplementationCode>
                                 <corecom:InstanceID>1460133</corecom:InstanceID>
                                 <corecom:ExecutionContextID>ec0c5aae6e6c1184:-6305e772:136df53e708:-8000-0000000000000f0c</corecom:ExecutionContextID>
                                 </corecom:FaultingService>
                                 </corecom:FaultNotification>
                            </Fault>
                       </part>
                  </AIAAsyncErrorHandlingBPELProcessRequestMessage>


                  Is it possible that ora:processXSLT('xsl/EBM_to_Fault.xsl',bpws:getVariableData('EBM_HEADER')) is not geting executed but i do have EBM_to_Fault.xsl present in my project so why is it not getting executed, do i need to do something extra for that???
                  • 6. Re: Populating EBM Header For Trace logging
                    913950
                    hi vijay

                    Even after adding IntermediateMessageHop in EBM_to_Fault.xsl , the fields are not getting populated in aia-trace.log

                    <msg time='2012-04-23T23:06:23.068+05:30' comp_id='soa_server1' type='NOTIFICATION' level='1' host_id='**********' host_addr='***.***.**.**' module='oracle.aia.logging.trace' tid='18' user='&lt;anonymous>' ecid='ec0c5aae6e6c1184:-6305e772:136df53e708:-8000-0000000000001269' rid='0:3'>
                    <attr name='APP' value='soa-infra'/>
                    <attr name='VERB_CODE' value=''/>
                    <attr name='SENDER_TRANSACTION_CODE' value=''/>
                    <attr name='SENDER_ID' value=''/>
                    <attr name='EBM_ID' value=''/>
                    <attr name='EBO_NAME' value=''/>
                    <attr name='SENDER_MESSAGE_ID' value=''/>
                    <attr name='EBM_NAME' value=''/>
                    <attr name='ECID' value='ec0c5aae6e6c1184:-6305e772:136df53e708:-8000-0000000000001269'/>
                    <txt>published message on JMS Error Queue</txt>
                    </msg>


                    :(
                    • 7. Re: Populating EBM Header For Trace logging
                      781423
                      Can you post the AIAFault used for this sample ?.