$msec 不够用,因其仅提供毫秒级精度且受日志缓冲延迟影响;需用 lua 模块调用 ngx.now() 获取微秒/纳秒时间,并结合统一 ntp 同步与早期打点实现高精度路径损耗分析。

Nginx 的 $msec 变量本身只提供毫秒级精度(小数点后三位),无法直接输出微秒级时间戳。要实现微秒级高精度绝对时间戳用于网关层路径损耗分析,需结合其他机制补足精度,并确保时间基准统一、可比对。
为什么 $msec 不够用?
$msec 是 Nginx 内置变量,格式为 1718923456.123,表示 Unix 时间戳 + 毫秒偏移,但其底层依赖 gettimeofday() 或 clock_gettime(CLOCK_MONOTONIC) 的调用时机,且 Nginx 日志写入存在缓冲与延迟,实际写入日志的时间可能比请求到达晚数百微秒甚至更久。单纯靠它无法满足微秒级路径损耗比对需求。
替代方案:用 $time_iso8601 + 自定义微秒字段
推荐在 log_format 中同时记录 ISO 时间和独立的微秒部分,由 Nginx 主动捕获更高精度时间(需开启支持):
- 启用
ngx_http_realip_module和ngx_http_core_module默认支持的$msec仅作参考; - 使用
lua-nginx-module在log_by_lua_block中调用ngx.now()(纳秒级精度,返回秒+小数,如1718923456.123456789),截取微秒位:
log_by_lua_block { ngx.log(ngx.STDERR, string.format("us=%d", (ngx.now() * 1e6) % 1000000)) } - 或改用
$time_iso8601(精确到秒)配合 Lua 获取微秒,拼接成2024-06-20T14:30:45.123456+08:00格式写入日志字段。
关键:统一时间源与低延迟采集点
路径损耗比对依赖端到端各环节使用同一高精度时钟源,否则“微秒”只是数字游戏:
- 所有网关节点启用
chrony或ntpd并同步至同一 Stratum 1 时间服务器,误差控制在 ±50μs 内; - 在
rewrite_by_lua_block或access_by_lua_block中尽早打点(例如刚完成 realip 解析后),记录入口时间; - 在
log_by_lua_block中再次打点,计算差值作为网关内部耗时,避免日志 I/O 干扰; - 若用 OpenResty,可利用
ngx.timer.at(0, ...)实现零延迟回调,进一步减少采集偏差。
日志格式示例与下游解析建议
定义 log_format 示例:
log_format trace '$remote_addr - $remote_user [$time_local] "$request" $status $body_bytes_sent "$http_referer" "$http_user_agent" $request_time $upstream_response_time "$http_x_request_id" $msec $upstream_http_x_process_time';更优做法是新增 Lua 字段:
log_by_lua_block { local t = ngx.now(); local us = math.floor((t - math.floor(t)) * 1e6); ngx.var.msec_us = string.format("%.6f", t); ngx.var.micros = us; }然后在 log_format 中引用 $micros 或 $msec_us。下游用 ELK 或 Loki 解析时,将 micros 字段转为纳秒级 epoch 时间,与其他系统(如服务端 OpenTelemetry trace timestamp)对齐比对。











