Uploaded image for project: 'Geode'
  1. Geode
  2. GEODE-4958

Remove stack trace logging for some occurrences of AuthenticationRequiredException

Attach filesAttach ScreenshotVotersWatch issueWatchersCreate sub-taskLinkCloneUpdate Comment AuthorReplace String in CommentUpdate Comment VisibilityDelete Comments
    XMLWordPrintableJSON

Details

    • Improvement
    • Status: Closed
    • Major
    • Resolution: Fixed
    • None
    • 1.10.0
    • security
    • None

    Description

      Occasionally we're logging messages like these:

      ```[error 2018/03/27 17:05:19.471 CST server2 <ServerConnection on port 40404 Thread 632> tid=0x2ec] Failed to bind the subject of uniqueId -5320790194368010384 for message REQUEST with Server connection from [identity(0.0.0.0(default_GeodeDS:177342:loner):2:GFNative_9Vy9zzNsTw177342:default_GeodeDS,connection=1; port=35644]
      
      [warning 2018/03/27 17:05:19.472 CST server2 <ServerConnection on port 40404 Thread 632> tid=0x2ec] ClientHealthMonitor: Unregistering client with member id identity(0.0.0.0(default_GeodeDS:177342:loner):2:GFNative_9Vy9zzNsTw177342:default_GeodeDS,connection=1 due to: Unknown reason
      
      [severe 2018/03/27 17:05:19.475 CST server2 <ServerConnection on port 40404 Thread 632> tid=0x2ec] Uncaught exception in thread Thread[ServerConnection on port 40404 Thread 632,5,ServerConnection on port 40404]
      org.apache.geode.security.AuthenticationRequiredException: Failed to find the authenticated user.
          at org.apache.geode.internal.cache.tier.sockets.ServerConnection.doNormalMsg(ServerConnection.java:793)
          at org.apache.geode.internal.cache.tier.sockets.LegacyServerConnection.doOneMessage(LegacyServerConnection.java:85)
          at org.apache.geode.internal.cache.tier.sockets.ServerConnection.run(ServerConnection.java:1179)
          at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
          at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
          at org.apache.geode.internal.cache.tier.sockets.AcceptorImpl$4$1.run(AcceptorImpl.java:641)
          at java.lang.Thread.run(Thread.java:748)
      
      [error 2018/03/27 17:05:25.575 CST server2 <ServerConnection on port 40404 Thread 640> tid=0x2f4] Failed to bind the subject of uniqueId -8780376006667518716 for message REQUEST with Server connection from [identity(0.0.0.0(default_GeodeDS:177266:loner):2:GFNative_QCAzJikbYT177266:default_GeodeDS,connection=1; port=36288]
      
      [warning 2018/03/27 17:05:25.576 CST server2 <ServerConnection on port 40404 Thread 640> tid=0x2f4] ClientHealthMonitor: Unregistering client with member id identity(0.0.0.0(default_GeodeDS:177266:loner):2:GFNative_QCAzJikbYT177266:default_GeodeDS,connection=1 due to: Unknown reason
      
      [severe 2018/03/27 17:05:25.577 CST server2 <ServerConnection on port 40404 Thread 640> tid=0x2f4] Uncaught exception in thread Thread[ServerConnection on port 40404 Thread 640,5,ServerConnection on port 40404]
      org.apache.geode.security.AuthenticationRequiredException: Failed to find the authenticated user.
          at org.apache.geode.internal.cache.tier.sockets.ServerConnection.doNormalMsg(ServerConnection.java:793)
          at org.apache.geode.internal.cache.tier.sockets.LegacyServerConnection.doOneMessage(LegacyServerConnection.java:85)
          at org.apache.geode.internal.cache.tier.sockets.ServerConnection.run(ServerConnection.java:1179)
          at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
          at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
          at org.apache.geode.internal.cache.tier.sockets.AcceptorImpl$4$1.run(AcceptorImpl.java:641)
          at java.lang.Thread.run(Thread.java:748)```
      

      They look scary but we should remove the stack trace from the log - the severity can also be turned down to 'warning'.

      This is related to GEODE-4076

      Attachments

        Activity

          This comment will be Viewable by All Users Viewable by All Users
          Cancel

          People

            Unassigned Unassigned
            jens.deppe Jens Deppe
            Votes:
            0 Vote for this issue
            Watchers:
            4 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved:

              Time Tracking

                Estimated:
                Original Estimate - Not Specified
                Not Specified
                Remaining:
                Remaining Estimate - 0h
                0h
                Logged:
                Time Spent - 50m
                50m

                Issue deployment