要让nginx日志记录连接耗时,需在log_format中显式添加$upstream_connect_time、$upstream_header_time、$upstream_response_time等上游变量,而非依赖$ request_time;因后者包含全链路耗时,无法定位连接瓶颈,且这些变量仅在启用proxy_pass等代理指令的location中有效,还需确保access_log明确引用自定义格式名并执行nginx -t与-s reload。

要让 Nginx 日志里出现连接耗时相关字段,关键不是配“连接耗时”这个概念本身——Nginx 没有直接叫 connection_time 的变量——而是用 $upstream_connect_time、$upstream_header_time、$upstream_response_time 这三个上游变量组合还原连接阶段耗时。单纯看 $request_time 只能知道总耗时,无法拆解瓶颈在哪。
为什么不能只靠 $request_time 定位连接问题
$request_time 是从接收到第一个字节开始,到发送完最后一个字节结束的总时间,它包含:TCP 握手(客户端侧)、SSL 协商、Nginx 自身处理(重写、鉴权等)、等待 upstream 建连、等待 upstream 返回 header、等待 upstream 返回 body 全部阶段。一旦出现慢请求,你根本不知道卡在了哪一环。
- 如果
$request_time大但$upstream_connect_time为空或为-,说明 Nginx 根本没连上后端(DNS 解析失败、IP 不可达、防火墙拦截) - 如果
$upstream_connect_time明显偏高(比如 >1s),说明建连慢,需检查后端服务监听配置、网络延迟、连接池是否耗尽 - 如果
$upstream_header_time和$upstream_response_time差值大(如 0.02s vs 2.8s),说明后端返回 header 很快,但 body 流式输出慢或阻塞
必须在 log_format 中显式添加 upstream 系列变量
log_format 必须定义在 http 块内,且名称不能和已有的(如 combined、main)重复;access_log 指令必须显式引用该格式名,否则会 fallback 到默认 combined,导致新字段不出现。
- 推荐格式定义(可直接复制):
log_format upstream_timed '$remote_addr - $remote_user [$time_local] "$request" ' '$status $body_bytes_sent "$http_referer" "$http_user_agent" ' 'rt=$request_time uct="$upstream_connect_time" uht="$upstream_header_time" ' 'urt="$upstream_response_time" upstream="$upstream_addr"';
-
$upstream_connect_time:Nginx 与 upstream 建立 TCP 连接所花时间(单位秒,精度毫秒) -
$upstream_header_time:从发起 upstream 请求,到收到第一个响应 header 的时间 -
$upstream_response_time:从发起 upstream 请求,到收到全部响应 body 的时间(即整个 upstream 耗时) - 这些变量仅在启用
proxy_pass、fastcgi_pass等代理指令的 location 中有效;纯静态服务 location 里它们恒为-
access_log 必须绑定自定义格式名,且路径权限要对
只改 log_format 不生效,必须在 http 或 server 块中明确使用该格式名:
- 正确写法:
access_log /var/log/nginx/access.log upstream_timed; - 错误写法:
access_log /var/log/nginx/access.log;(这用的是内置combined) - 日志路径必须是绝对路径,且 Nginx worker 进程用户(通常是
nginx或www-data)对该路径有写权限 - Windows 下路径要用正斜杠或双反斜杠,例如:
C:/nginx/logs/access.log - 修改后务必执行:
nginx -t(语法检查)→nginx -s reload(重载),旧连接仍用旧格式,新请求才走新日志
容易被忽略的兼容性与调试细节
这几个 upstream 时间变量依赖于 upstream 模块正常工作,不是所有场景都可靠:
-
$upstream_connect_time在使用 keepalive 连接池时可能为0.000或极小值(复用已有连接),不能据此判断网络质量 - 如果 upstream 是 HTTPS,
$upstream_connect_time包含 TLS 握手时间;若想单独观察握手开销,需结合客户端侧指标或抓包 - 当后端超时断连(如
proxy_read_timeout触发),$upstream_response_time可能截断,显示为实际耗时而非超时值 - 变量拼写错误(如
$upstream_connet_time)不会报错,日志里对应位置留空,排查时得逐个核对变量名











