【借力打力】记一次由于堆栈信息不详细的错误排查方法，利用访问日志进行定位问题

1，背景

异常信息每隔50分钟显示一次，如图所示。

能够看出是控制器上出现参数转换失效的问题，但是具体的是哪一个控制器在异常堆栈信息中也没有打印出来，这给问题定位带来了一定的难度。

2，排查步骤

2.1 调用方问题

系统接收几个供应商的数据推送，推送失败的会进行数据补偿，首先想到是不是某个供应商推送数据失败，使用调度任务每隔50分钟进行请求，导致一致出现数据失败和请求。这种情况不好排查，但是还是咨询了其中一个，他的日志没有出现异常，但他提供了一个很好地思路，使用Nginx进行定位。

2.2 Nginx手段

通过Nginx的代理访问日志文件能够看到接口调用的详情，但是笔者的Nginx没有对特殊的后端接口进行代理，该方法本来是一种很好地方法，但是在这种情况下失效了。

2.3 运维工具辅助

想到运维人员记录了访问日志，反馈的结果就是没有在给定的时间范围内没有发现数据交互。排除了外来供应商调用接口的情况。

2.4 嵌入tomcat日志记录

既然通过Nginx的代理可以进行排查，于是想到了利用tomcat进行问题定位，举一反三，通过以下配置进行开启。

开启嵌入tomcat配置项为：

server:
  #开启tomcat日志记录功能
  tomcat:
    basedir: C:\zcadmin\zcAdmin-logs\tomcat
    background-processor-delay: 30
    port-header: X-Forwarded-Port
    protocol-header: X-Forwarded-Proto
    protocol-header-https-value: https
    redirect-context-root: true
    remote-ip-header: X-Forwarded-For
    uri-encoding: UTF-8
    accesslog:
      enabled: true
      buffered: true
      directory: .\log
      file-date-format: .yyyy-MM-dd
      pattern: '%h %l %u %t "%r" %s %b "%{Referer}i" "%{User-Agent}i" %D ms'
      prefix: access_log
      rename-on-rotate: false
      request-attributes-enabled: false
      rotate: true
      suffix: .log

打印的日志格式为：

127.0.0.1 - - [03/Nov/2023:15:05:06 +0800] "GET /api/big-screen/getLatestAssetAlertLog HTTP/1.1" 200 5532 "http://localhost:8013/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/118.0.0.0 Safari/537.36" 16 ms

3，结果

通过时间戳就可以锁定异常调用的接口。