Nginx Unit中使用njs变量在access_log.format中的重复引用问题分析

问题背景

在Nginx Unit 1.32.0版本中，当使用NJS(JavaScript)语法定义access_log的日志格式时，如果日志格式字符串中多次引用vars变量，会出现变量值重复的问题。具体表现为：第一个变量的值会被错误地应用到后续所有变量上。

问题现象

开发人员发现，当配置如下NJS格式的access_log时：

{
  "access_log": {
    "path": "/dev/stderr",
    "format": "`${JSON.stringify({bodyLength:vars.body_bytes_sent,status:vars.status})}\n`"
  }
}

日志输出会出现异常：

{"bodyLength":"82733","status":"82733"}

而实际上，status变量应该是200，却被错误地赋值为与body_bytes_sent相同的值。

技术分析

这个问题源于Nginx Unit在处理NJS变量引用时的缓存机制。在底层实现中，当多个变量被引用时，系统错误地复用了第一个变量的缓存值，而没有为每个变量创建独立的缓存上下文。

核心问题出现在nxt_var.c文件中的变量引用处理逻辑。系统默认情况下会将变量标记为可缓存(cacheable)，但在NJS上下文中，这种缓存行为导致了变量值的错误共享。

解决方案

开发团队已经识别出问题所在，并提供了修复方案。修复的核心思想是：在NJS上下文中（当内存池为state->pool时），才允许变量缓存；否则禁用缓存机制。

具体修复代码如下：

diff --git a/src/nxt_var.c b/src/nxt_var.c
index 2600371b..57110f66 100644
--- a/src/nxt_var.c
+++ b/src/nxt_var.c
@@ -147,7 +147,7 @@ nxt_var_ref_get(nxt_tstr_state_t *state, nxt_str_t *name, nxt_mp_t *mp)
 
     if (decl != NULL) {
         ref->handler = decl->handler;
-        ref->cacheable = decl->cacheable;
+        ref->cacheable = (mp == state->pool) ? decl->cacheable : 0;
 
         goto done;
     }

问题影响

这个问题会导致：

1. 日志记录不准确，多个变量值被错误地统一
2. 统计数据失真，影响监控和分析
3. 在调试和问题排查时产生误导

临时解决方案

在官方修复发布前，可以考虑以下临时方案：

1. 使用传统的非NJS日志格式
2. 将多个变量合并到单个JSON.stringify调用中处理
3. 避免在日志格式中多次引用vars变量

技术启示

这个案例提醒我们：

1. 缓存机制虽然能提高性能，但需要考虑上下文环境
2. 在JavaScript与原生代码交互时需要特别注意变量作用域
3. 日志系统的准确性对运维至关重要，需要充分测试

总结

Nginx Unit团队已经快速响应并修复了这个NJS变量引用问题。该修复确保了日志格式中多个vars变量能够正确获取各自的值，为开发者提供了可靠的日志记录功能。这也体现了开源项目对用户反馈的重视和快速响应能力。