一般前端开发同学，对日志其实不太敏感，毕竟前端大多数情况下，不太关心日志。即使有，也可能调用一些第三方的统计，比如百度统计或者别的等。在 Node.js推进过程中，也发现我们平常打日志太随意，该打的日志没有打，打的一些关键日志缺少必要上下文信息，导致在线上定位问题的时候很困难。

本文主要梳理了在nodejs开发中日志方面存在的问题，以及通过统一日志规范，希望达到什么样的效果。

存在的问题

现在大部分小团队使用node去做服务端开发，都或多或少存在以下问题：

• node日志不规范，打日志太随意
• 没有良好的日志格式、约定的字段，在 ELK 里不能很好的解析&检索
• 由于node对接的后端服务化，调用链不清晰，定位问题困难
• 数据部门对node日志的使用，没有明确的记录。node修改了日志，导致统计数据异常

希望达成的目标

为了方便查看和统计，我们制定了以下目标：

• 规范日志打印字段&格式，便于 ELK 检索
• 增强node上下游(nginx/后端)日志格式，加入惟一 requestId，方便微服务下定位问题
• 统计应用运行情况，性能数据
• 维护数据部门对node日志的使用情况

实现方案

日志类型

参考一些日志的最佳实践，目前将node日志分为如下几种类型(scope)：

• desc: 系统启动、运行过程中，打的日志，表明系统的一些启动日志、启动参数等，也包含在 不能 捕获到http上下文的时候，打的日志
• stat: 系统性能统计日志，应用会定时收集一些性能信息，便于查询应用当前状态
• visit: 每个http请求相关的日志，会包含惟一的 requestId，定位该请求相关的所有日志
• biz: 业务数据相关日志，主要提供给数据统计使用

日志级别

只使用 FATAL、ERROR、WARN、INFO 和 DEBUG 等级。

• FATAL - 导致程序退出的严重系统级错误，不可恢复，当错误发生时，系统管理员需要立即介入，一般应用代码 不 使用。
• ERROR - 运行时异常以及预期之外的错误，也需要立即处理，但紧急程度低于FATAL,当错误发生时，影响了程序的正确执行。需要注意的是这两种级别属于服务自己的错误，需要管理员介入，用户输入出错不属于此分类，请求后端、读文件、数据库等超时、返回错误结构，属于ERROR
• WARN - 预期之外的运行时状况，表示系统可能出现问题。对于那些目前还不是错误，然而不及时处理也会变成错误的情况，也可以记为WARN，如磁盘过低。
• INFO - 有意义的事件信息，记录程序正常的运行状态，比如收到请求，成功执行。通过查看INFO,可以快速定位WARN，ERROR, FATAL。INFO不宜过多，通常情况下不超过 DEBUG 的10%。
• DEBUG - 与程序运行时的流程相关的详细信息以及当前变量状态。

日志格式/字段

日志格式统一采用JSON ，便于 ELK 解析处理。

日志中的各个字段的值，都应该尽量使用英文 ，不使用中文。

日志具体字段，分为 基础数据 + 扩展数据。基础数据，是底层日志框架自带的，所有日志都会包含。扩展数据，不同类型的日志，包含不同的字段。

日志基础数据

目前使用的 node-bunyan 日志库，官方文档，基础字段包含如下：

• v: integer 。bunyan的日志版本号
• level: integer。日志级别对应的数字
• name: string。服务名
• hostname: string。主机名
• pid: integer。进程号
• time: string。UTC格式的日期
• msg: string。日志主体信息

日志扩展数据

下面定义的各个数据类型的扩展数据，不是 全部的字段，仅包含该日志类型下，必需的字段。这些必需的扩展字段，需要在 ELK 中建立索引，方便定位各种问题。

1. desc类型日志，扩展字段：TODO
2. stat类型日志，扩展字段：{ perf: {rss: xxxx, cpu: xxx} }
3. visit类型日志，扩展字段：
4. biz

{ / 基础数据  v: 1, level: 20, / 扩展字段  // 标志日志类型 scope: "visit