7 Replies Latest reply: Aug 30, 2013 12:41 PM by Bobfinan - Oracle-Oracle RSS

    Domain Audit

    user10107871
      Hi All,
      I'm using the Domain audit log to trace GWT calls.
      I set the TM_GW_AUDITLOG_ENHANCE=yes.
      But still the statistics times does not show millisecond only seconds which make it hard to figure out the real timing.

      000000000000020:6816:LocalDom:RemDom:WtcRPLActBean00:::IN FROM TUXEDO :Thu Apr 25 *15:35:52* 2013
      000000000000020:6816:LocalDom:RemDom:WtcRPLActBean00:::OUT TO NETWORK :Thu Apr 25 *15:35:52* 2013
      000000000000020:6816:LocalDom:RemDom:WtcRPLActBean00:::IN FROM NETWORK:Thu Apr 25 *15:35:52* 2013
      000000000000020:6816:LocalDom:RemDom:WtcRPLActBean00:::OUT TO TUXEDO :Thu Apr 25 *15:35:52* 2013

      tmadmin -v
      INFO: Oracle Tuxedo, Version 10.3.0.0, 32-bit, Patch Level 107

      I'm I missing something here?
      TX
        • 1. Re: Domain Audit
          Bobfinan - Oracle-Oracle
          Hi,
          A common confusion with these environment variables. I think you want to use TM_GW_AUDITLOG_ACCURATE =YES.
          Here are the three that are commonly confused with each other.

          TM_GW_AUDITLOG_ENHANCE=YES
          requests the enhanced formatting of the audit log "SequentID:ProcessID:LocalDomain:RemoteDomain:SVCName:TranID:NetTranId:RequestType:filed7:Timestamps"

          TM_GW_AUDITLOG_ACCURATE =YES
          changes the auditing from 1 second to 1 millisecond timestamps level of data logging

          TM_GW_ENHANCED_AUDIT=1
          when set=1 AND the dmadmin "audit on" command is executed then prepare,commit and rollback actions will also be logged to the AUDITLOG.

          Regards,
          Bob Finan

          Note:
          Any one of these when used will increase the size of the file generated and so will effect overall performance.
          • 2. Re: Domain Audit
            user10661923

            Hi Bob,

             

            I have tried setting all three of these variables in my shell and rhen turning aufit logging back on, and it made no difference to the format, Is there something I am missing

             

            Tony Horswill

            • 3. Re: Domain Audit
              Bobfinan - Oracle-Oracle

              Hi Tony,

              Tuxedo processes do not pick up environment variable changes immediately. They need to be rebooted.
              Are these steps similar to what you followed?

              1)tmshutdown the domain group of interest (shutting down just the GWTDOMAIN might work but I would do it for the whole group, GWTDOMAIN+GWADM)

              2)set the environment variable TM_GW_AUDITLOG_ACCURATE=YES (try checking it after with an "env|grep AUDIT" to see if it set)

              3)tmboot the domain group

               

              There are sometimes issues if you are trying to set environment variables from a shell script(e.g. syntax issues) or ENVFILE.

              Are you setting the environment variable manually from the shell command prompt, by using a shell script before tmboot, or using ENVFILEs that are defined in the UBB config file?

               

              If you still don't get millisecond logging let me know the platform and shell you are using (also the Tuxedo release version and patch level if different than previously mentioned).

              Regards,
              Bob

              • 4. Re: Domain Audit
                user10661923

                Hi Bob,

                 

                Thanks. I have now got more detailed logging but the subsecond format is very hard to interpret (as below):

                000010000000009:22159:FXOPS_UAT3SG:FXOPSJMS_UAT3SG:QSPCMessagesM:::IN FROM TUXEDO :1377721096.7481  :Wed Aug 28 16:18:16 2013 000010000000009:22159:FXOPS_UAT3SG:FXOPSJMS_UAT3SG:QSPCMessagesM:::OUT TO NETWORK :1377721096.7981  :Wed Aug 28 16:18:16 2013 000010000000010:22159:FXOPS_UAT3SG:FXOPSJMS_UAT3SG:QSPCMessagesM:::IN FROM NETWORK:1377721096.27086 :Wed Aug 28 16:18:16 2013 000010000000010:22159:FXOPS_UAT3SG:FXOPSJMS_UAT3SG:QSPCMessagesM:::OUT TO TUXEDO  :1377721096.27482 :Wed Aug 28 16:18:16 2013

                 

                We are using Tux 11.1.1.2.0

                 

                Regards,

                  Tony

                • 5. Re: Domain Audit
                  Bobfinan - Oracle-Oracle

                  Hi Tony,

                  The additional timestamp format is "seconds.microseconds".

                  The "seconds" is the number of seconds since the great epoch of 1970 (or some platform specific hubris fixed time point). The timestamp format was chosen so that it would be an easier calculation of the delta for users

                  from one logged datum to the next. (i.e. rather than a conversion from a string, like "Wed Aug 28 16:18:16 2013", and then a calculation).

                  Regards,
                  Bob

                  • 6. Re: Domain Audit
                    user10661923

                    Hi Bob,


                    so leading zeros are dropped and the timetamps from earlier mail would be?

                         1377721096.007481

                         1377721096.007981

                         1377721096.027086

                         1377721096.027482

                     

                    Thanks

                    Tony

                    • 7. Re: Domain Audit
                      Bobfinan - Oracle-Oracle

                      Hi Tony,

                      Yes. That is my thinking also.

                      I think that "seconds" and "micrsoseconds" may each have independent fixed starting time points which are platform dependent.

                      (it varies on an OS providing/use of time functions). So rollover from microseconds to seconds may not occur always as

                      expected but the deltas from/to the previous/next datum should be correct.

                      Bob