Details

    • Type: Bug
    • Status: Open
    • Priority: Minor
    • Resolution: Unresolved
    • Affects Version/s: 6.0.0, 6.5.0
    • Fix Version/s: None
    • Component/s: debug logging
    • Labels:
      None
    • Target Version/s:

      Description

      Bug description

      In Message level, there is tons of useless stuff being written to the Session log.

      How to reproduce the issue

      1. Enable message level
      2. Clear debug logs
      3. Authenticate as demo to DataStore module
      Expected behaviour
      Useful, detailed logging 
      
      Current behaviour
      forgerock@localhost:~/openam4/openam/debug$ grep -i "local fetch" Session -c
      159
      forgerock@localhost:~/openam4/openam/debug$ grep -i "CtsOperations" Session -c
      342
      

      That's over 1000 lines of logging that is of no/limited use, from a single authentication.

      The session token itself is printed over 150 times.

      amSession:02/15/2019 02:27:34:781 PM GMT: Thread[http-nio-48080-exec-9,5,main]: TransactionId[83d91d68-3134-4c8e-afde-32925e8ef734-23897]
      Local fetch SessionInfo for bN3ydaNgL9mlA3b6vrUU0jg50EU.*AAJTSQACMDEAAlNLABxYbHdIaDhpaElZYVlLdHpGM2kwYXR5dThKMEk9AAR0eXBlAANDVFMAAlMxAAA.*
      Reset: false
      amSession:02/15/2019 02:27:34:781 PM GMT: Thread[http-nio-48080-exec-9,5,main]: TransactionId[83d91d68-3134-4c8e-afde-32925e8ef734-23897]
      bN3ydaNgL9mlA3b6vrUU0jg50EU.*AAJTSQACMDEAAlNLABxYbHdIaDhpaElZYVlLdHpGM2kwYXR5dThKMEk9AAR0eXBlAANDVFMAAlMxAAA.*: CtsOperations selected.
      amSession:02/15/2019 02:27:34:781 PM GMT: Thread[http-nio-48080-exec-9,5,main]: TransactionId[83d91d68-3134-4c8e-afde-32925e8ef734-23897]
      SessionService.isSuperUser: false 

      This makes debugging issues very time consuming.

      On a busy production server forced to enable message level, even for small time windows, this could cause problems.

      ~120Kb logs for every authentication/session refresh

      Refresh the profile page a couple dozen times and you've got 5Mb in 30s, just in the Session file.

        Attachments

          Activity

            People

            • Assignee:
              Unassigned
              Reporter:
              joe.starling Joe Starling
            • Votes:
              1 Vote for this issue
              Watchers:
              4 Start watching this issue

              Dates

              • Created:
                Updated: