Docker健康检查场景下Apache CustomLog异常行为排查

背景 #

在一个容器中成功实现了Docker健康检查的日志过滤（不记录健康检查请求），但将相同配置部署到另一个容器时出现异常，健康检查请求仍会生成截断的日志条目。需求是通过环境变量排除特定请求的日志记录。

Dockerfile配置 #

HEALTHCHECK CMD curl -ILfSs http://localhost:80 -A "HealthCheck" || exit 1

RUN ln -sf /dev/stdout /var/www/logs/access.log \
    && ln -sf /dev/stdout /var/www/logs/transfer.log \
    && ln -sf /dev/stdout /var/www/logs/ssl-transfer.log \
    && ln -sf /dev/stderr /var/www/logs/error.log \
    && ln -sf /dev/stderr /var/www/logs/ssl-error.log

httpd.conf配置 #

<IfModule log_config_module>
    LogFormat "%h %l %u %t \"%r\" %>s %b \"%{Referer}i\" \"%{User-Agent}i\"" combined
    LogFormat "%h %l %u %t \"%r\" %>s %b" common

    <IfModule logio_module>
      LogFormat "%h %l %u %t \"%r\" %>s %b \"%{Referer}i\" \"%{User-Agent}i\" %I %O" combinedio
    </IfModule>

    <IfModule setenvif_module>
       BrowserMatchNoCase ^healthcheck nolog
    </IfModule>

    CustomLog "logs/access.log" combinedio env=!nolog

</IfModule>

问题现象 #

• 预期：健康检查请求不会被记录
• 实际：生成了截断的日志条目：

  127.0.0.1 - - [05/Oct/2022:05:17:46 +0000] "HEAD / HTTP/1.1" 200 -
  

• 正常日志条目（注释掉BrowserMatchNoCase ^healthcheck nolog后）：

  127.0.0.1 - - [05/Oct/2022:03:22:13 +0000] "HEAD / HTTP/1.1" 200 - "-" "HealthCheck" 74 1095
  

排查与解决方向 #

1. 确认setenvif模块加载状态：在异常容器中执行httpd -M，检查setenvif_module是否已加载。若未加载，需在httpd配置中启用该模块。
2. 调整User-Agent匹配规则：当前正则^healthcheck仅匹配以小写开头的字符串，虽用了NoCase，但可改为更宽松的匹配逻辑，确保覆盖所有包含"HealthCheck"的请求：

   BrowserMatchNoCase healthcheck nolog
   

3. 检查配置指令顺序：确保BrowserMatchNoCase规则定义在CustomLog指令之前，否则规则无法作用于日志记录逻辑。
4. 验证curl请求头：在异常容器内手动执行健康检查命令，确认User-Agent是否正确携带：

   curl -ILfSs http://localhost:80 -A "HealthCheck" -v
   

内容的提问来源于stack exchange，提问作者J. Scott Elblein