众所周知,Zap 是个很 nb 的日志框架,作为入门篇,本文主要用几个例子来直观地感受下 Zap 写出来的日志长什么样,符不符合我们的需求(主要是审美需求),性能什么的我们攒钱不 care。
以下栗子由浅入深,循序渐进,大部分栗子可以直接 copy 运行。
Casescase 1: Hello World
Zap 的 Hello World 代码大概长下面这样:
package mainimport ("fmt""go.uber.org/zap"
)func main() {var logger *zap.Loggerlogger, _ = zap.NewProduction()logger.Debug("i am debug") // 这行不会打印,因为默认日志级别是 INFOlogger.Info("i am info") // INFO 级别日志,这个会正常打印logger.Warn("i am warn") // WARN 级别日志,这个会正常打印logger.Error("i am error") // ERROR 级别日志,这个会打印,并附带堆栈信息logger.Fatal("i am fatal") // FATAL 级别日志,这个会打印,附带堆栈信息,并调用 os.Exit 退出fmt.Println("can i be printed?") // 这行不会打印,呃...上面已经退出了
}
编译运行该程序,输出大概如下:
{"level":"info","ts":1608362501.672074,"caller":"zap2/main.go:11","msg":"i am info"}
{"level":"warn","ts":1608362501.672139,"caller":"zap2/main.go:12","msg":"i am warn"}
{"level":"error","ts":1608362501.672147,"caller":"zap2/main.go:13","msg":"i am error","stacktrace":"main.main\n\t/Users/jack/go/src/helloworld/zap2/main.go:13\nruntime.main\n\t/usr/local/Cellar/go/1.15.2/libexec/src/runtime/proc.go:204"}
{"level":"fatal","ts":1608362501.6721768,"caller":"zap2/main.go:14","msg":"i am fatal","stacktrace":"main.main\n\t/Users/jack/go/src/helloworld/zap2/main.go:14\nruntime.main\n\t/usr/local/Cellar/go/1.15.2/libexec/src/runtime/proc.go:204"}
以上代码应该是相当简洁易懂了,在这里需要再唠嗑一下的是关于输出的日志的几个字段的说明:
- level: 顾名思义,就是日志的级别了,默认的日志级别是 INFO,所以我们的第一行日志没有被打印出来
- ts: timestamp,时间戳的意思
- caller: 调用者,就是打印日志的那行代码的位置
- stacktrace: 调用堆栈,及打印日志的那行代码所在的堆栈信息,默认 ERROR 级别及以上的日志会附带堆栈信息,可以修改
case 2: SugaredLogger
zap.SugaredLoggerzap.Loggerfmt.Printfzap.SugaredLogger
package mainimport ("fmt""go.uber.org/zap"
)func main() {var sugaredLogger *zap.SugaredLoggerlogger, _ := zap.NewProduction()sugaredLogger = logger.Sugar()sugaredLogger.Debugf("i am debug, using %s", "sugar") // 这行不会打印,因为默认日志级别是 INFOsugaredLogger.Infof("i am info, using %s", "sugar") // INFO 级别日志,这个会正常打印sugaredLogger.Warnf("i am warn, using %s", "sugar") // WARN 级别日志,这个会正常打印sugaredLogger.Errorf("i am error, using %s", "sugar") // ERROR 级别日志,这个会打印,并附带堆栈信息sugaredLogger.Fatalf("i am fatal, using %s", "sugar") // FATAL 级别日志,这个会打印,附带堆栈信息,并调用 os.Exit 退出fmt.Println("can i be printed?") // 这行不会打印,呃...上面已经退出了
}
编译运行该程序,输出类似如下:
{"level":"info","ts":1608365481.615607,"caller":"zap3/main.go:13","msg":"i am info, using sugar"}
{"level":"warn","ts":1608365481.615681,"caller":"zap3/main.go:14","msg":"i am warn, using sugar"}
{"level":"error","ts":1608365481.6156878,"caller":"zap3/main.go:15","msg":"i am error, using sugar","stacktrace":"main.main\n\t/Users/jack/go/src/helloworld/zap3/main.go:15\nruntime.main\n\t/usr/local/Cellar/go/1.15.2/libexec/src/runtime/proc.go:204"}
{"level":"fatal","ts":1608365481.6157131,"caller":"zap3/main.go:16","msg":"i am fatal, using sugar","stacktrace":"main.main\n\t/Users/jack/go/src/helloworld/zap3/main.go:16\nruntime.main\n\t/usr/local/Cellar/go/1.15.2/libexec/src/runtime/proc.go:204"}
case 3: 定制化 SugaredLogger
zap.NewProduction()zap.Loggerzap.New(core zapcore.Core, options ...Option)zapcore.Core
zapzapjsonEncoderconsoleEncoderzapos.Fileos.stdoutzap.Logger
我们用定制化的方式来改写上述栗子:
package mainimport ("fmt""go.uber.org/zap""go.uber.org/zap/zapcore""os"
)func main() {// 配置 sugaredLoggervar sugaredLogger *zap.SugaredLoggerwriter := zapcore.AddSync(os.Stdout) // 设置日志输出的设备,这里还是使用标准输出,也可以传一个 File 类型让它写入到文件encoder := zapcore.NewJSONEncoder(zap.NewProductionEncoderConfig()) // 设置编码器,即日志输出的格式,默认提供了 json 和 console 两种编码器,这里我们还是使用 json 的编码器core := zapcore.NewCore(encoder, writer, zapcore.InfoLevel) // 设置日志的默认级别logger := zap.New(core)sugaredLogger = logger.Sugar()// 打印日志sugaredLogger.Debugf("i am debug, using %s", "sugar") // 这行不会打印,因为日志级别是 INFOsugaredLogger.Infof("i am info, using %s", "sugar") // INFO 级别日志,这个会正常打印sugaredLogger.Warnf("i am warn, using %s", "sugar") // WARN 级别日志,这个会正常打印sugaredLogger.Errorf("i am error, using %s", "sugar") // ERROR 级别日志,这个会打印,并附带堆栈信息sugaredLogger.Fatalf("i am fatal, using %s", "sugar") // FATAL 级别日志,这个会打印,附带堆栈信息,并调用 os.Exit 退出fmt.Println("can i be printed?") // 这行不会打印,呃...上面已经退出了
}
编译运行该程序,输出类似如下:
{"level":"info","ts":1608367820.9526541,"msg":"i am info, using sugar"}
{"level":"warn","ts":1608367820.952697,"msg":"i am warn, using sugar"}
{"level":"error","ts":1608367820.9527,"msg":"i am error, using sugar"}
{"level":"fatal","ts":1608367820.952702,"msg":"i am fatal, using sugar"}
callerstackstace
使用 Console 格式
jsonconsolejsonconsole
package mainimport ("fmt""go.uber.org/zap""go.uber.org/zap/zapcore""os"
)func main() {// 配置 sugaredLoggervar sugaredLogger *zap.SugaredLoggerwriter := zapcore.AddSync(os.Stdout)encoder := zapcore.NewConsoleEncoder(zap.NewProductionEncoderConfig()) // 设置 console 编码器core := zapcore.NewCore(encoder, writer, zapcore.InfoLevel)logger := zap.New(core)sugaredLogger = logger.Sugar()// 打印日志sugaredLogger.Debugf("i am debug, using %s", "sugar") // 这行不会打印,因为日志级别是 INFOsugaredLogger.Infof("i am info, using %s", "sugar") // INFO 级别日志,这个会正常打印sugaredLogger.Warnf("i am warn, using %s", "sugar") // WARN 级别日志,这个会正常打印sugaredLogger.Errorf("i am error, using %s", "sugar") // ERROR 级别日志,这个会打印,并附带堆栈信息sugaredLogger.Fatalf("i am fatal, using %s", "sugar") // FATAL 级别日志,这个会打印,附带堆栈信息,并调用 os.Exit 退出fmt.Println("can i be printed?") // 这行不会打印,呃...上面已经退出了
}
编译运行该程序,输出类似如下:
1.60837067575392e+09 info i am info, using sugar
1.6083706757539682e+09 warn i am warn, using sugar
1.608370675753972e+09 error i am error, using sugar
1.6083706757539752e+09 fatal i am fatal, using sugar
修改日期显示格式
human readable
package mainimport ("fmt""go.uber.org/zap""go.uber.org/zap/zapcore""os"
)func main() {// 配置 sugaredLoggervar sugaredLogger *zap.SugaredLoggerwriter := zapcore.AddSync(os.Stdout)// 格式相关的配置encoderConfig := zap.NewProductionEncoderConfig()encoderConfig.EncodeTime = zapcore.ISO8601TimeEncoder // 修改时间戳的格式encoderConfig.EncodeLevel = zapcore.CapitalLevelEncoder // 日志级别使用大写显示encoder := zapcore.NewConsoleEncoder(encoderConfig)core := zapcore.NewCore(encoder, writer, zapcore.InfoLevel)logger := zap.New(core)sugaredLogger = logger.Sugar()// 打印日志sugaredLogger.Debugf("i am debug, using %s", "sugar") // 这行不会打印,因为日志级别是 INFOsugaredLogger.Infof("i am info, using %s", "sugar") // INFO 级别日志,这个会正常打印sugaredLogger.Warnf("i am warn, using %s", "sugar") // WARN 级别日志,这个会正常打印sugaredLogger.Errorf("i am error, using %s", "sugar") // ERROR 级别日志,这个会打印,并附带堆栈信息sugaredLogger.Fatalf("i am fatal, using %s", "sugar") // FATAL 级别日志,这个会打印,附带堆栈信息,并调用 os.Exit 退出fmt.Println("can i be printed?") // 这行不会打印,呃...上面已经退出了
}
编译运行该程序,输出类似如下:
2020-12-19T17:44:19.031+0800 INFO i am info, using sugar
2020-12-19T17:44:19.031+0800 WARN i am warn, using sugar
2020-12-19T17:44:19.031+0800 ERROR i am error, using sugar
2020-12-19T17:44:19.031+0800 FATAL i am fatal, using sugar
呃…看起来正常点了,上述栗子顺便把日志级别显示改成大写了,看起来更习惯一点~
增加 caller 信息
caller
package mainimport ("fmt""go.uber.org/zap""go.uber.org/zap/zapcore""os"
)func main() {// 配置 sugaredLoggervar sugaredLogger *zap.SugaredLoggerwriter := zapcore.AddSync(os.Stdout)// 格式相关的配置encoderConfig := zap.NewProductionEncoderConfig()encoderConfig.EncodeTime = zapcore.ISO8601TimeEncoder // 修改时间戳的格式encoderConfig.EncodeLevel = zapcore.CapitalLevelEncoder // 日志级别使用大写显示encoder := zapcore.NewConsoleEncoder(encoderConfig)core := zapcore.NewCore(encoder, writer, zapcore.InfoLevel)logger := zap.New(core, zap.AddCaller()) // 增加 caller 信息sugaredLogger = logger.Sugar()// 打印日志sugaredLogger.Debugf("i am debug, using %s", "sugar") // 这行不会打印,因为日志级别是 INFOsugaredLogger.Infof("i am info, using %s", "sugar") // INFO 级别日志,这个会正常打印sugaredLogger.Warnf("i am warn, using %s", "sugar") // WARN 级别日志,这个会正常打印sugaredLogger.Errorf("i am error, using %s", "sugar") // ERROR 级别日志,这个会打印,并附带堆栈信息sugaredLogger.Fatalf("i am fatal, using %s", "sugar") // FATAL 级别日志,这个会打印,附带堆栈信息,并调用 os.Exit 退出fmt.Println("can i be printed?") // 这行不会打印,呃...上面已经退出了
}
编译运行该程序,输出类似如下:
2020-12-19T17:50:24.257+0800 INFO zap3/main.go:29 i am info, using sugar
2020-12-19T17:50:24.257+0800 WARN zap3/main.go:30 i am warn, using sugar
2020-12-19T17:50:24.257+0800 ERROR zap3/main.go:31 i am error, using sugar
2020-12-19T17:50:24.257+0800 FATAL zap3/main.go:32 i am fatal, using sugar
修改日志级别
INFODEBUG
package mainimport ("fmt""go.uber.org/zap""go.uber.org/zap/zapcore""os"
)func main() {// 配置 sugaredLoggervar sugaredLogger *zap.SugaredLoggerwriter := zapcore.AddSync(os.Stdout)// 格式相关的配置encoderConfig := zap.NewProductionEncoderConfig()encoderConfig.EncodeTime = zapcore.ISO8601TimeEncoder // 修改时间戳的格式encoderConfig.EncodeLevel = zapcore.CapitalLevelEncoder // 日志级别使用大写显示encoder := zapcore.NewConsoleEncoder(encoderConfig)core := zapcore.NewCore(encoder, writer, zapcore.DebugLevel) // 将日志级别设置为 DEBUGlogger := zap.New(core, zap.AddCaller()) // 增加 caller 信息sugaredLogger = logger.Sugar()// 打印日志sugaredLogger.Debugf("i am debug, using %s", "sugar") // 这行现在可以打印出来了!sugaredLogger.Infof("i am info, using %s", "sugar") // INFO 级别日志,这个会正常打印sugaredLogger.Warnf("i am warn, using %s", "sugar") // WARN 级别日志,这个会正常打印sugaredLogger.Errorf("i am error, using %s", "sugar") // ERROR 级别日志,这个会打印,并附带堆栈信息sugaredLogger.Fatalf("i am fatal, using %s", "sugar") // FATAL 级别日志,这个会打印,附带堆栈信息,并调用 os.Exit 退出fmt.Println("can i be printed?") // 这行不会打印,呃...上面已经退出了
}
编译运行该程序,输出类似如下:
2020-12-19T17:52:29.438+0800 DEBUG zap3/main.go:28 i am debug, using sugar
2020-12-19T17:52:29.439+0800 INFO zap3/main.go:29 i am info, using sugar
2020-12-19T17:52:29.439+0800 WARN zap3/main.go:30 i am warn, using sugar
2020-12-19T17:52:29.439+0800 ERROR zap3/main.go:31 i am error, using sugar
2020-12-19T17:52:29.439+0800 FATAL zap3/main.go:32 i am fatal, using sugar
DEBUG
添加自定义字段
zap.New()logger
package mainimport ("fmt""github.com/google/uuid""go.uber.org/zap""go.uber.org/zap/zapcore""os"
)func main() {// 配置 sugaredLoggervar sugaredLogger *zap.SugaredLoggerwriter := zapcore.AddSync(os.Stdout)// 格式相关的配置encoderConfig := zap.NewProductionEncoderConfig()encoderConfig.EncodeTime = zapcore.ISO8601TimeEncoder // 修改时间戳的格式encoderConfig.EncodeLevel = zapcore.CapitalLevelEncoder // 日志级别使用大写显示encoder := zapcore.NewConsoleEncoder(encoderConfig)core := zapcore.NewCore(encoder, writer, zapcore.DebugLevel) // 将日志级别设置为 DEBUGlogger := zap.New(core, zap.AddCaller(), zap.Fields(zapcore.Field{ // 添加 uuid 字段Key: "uuid",Type: zapcore.StringType,String: uuid.New().String(),}))sugaredLogger = logger.Sugar()// 打印日志sugaredLogger.Debugf("i am debug, using %s", "sugar") // 这行现在可以打印出来了!sugaredLogger.Infof("i am info, using %s", "sugar") // INFO 级别日志,这个会正常打印sugaredLogger.Warnf("i am warn, using %s", "sugar") // WARN 级别日志,这个会正常打印sugaredLogger.Errorf("i am error, using %s", "sugar") // ERROR 级别日志,这个会打印,并附带堆栈信息sugaredLogger.Fatalf("i am fatal, using %s", "sugar") // FATAL 级别日志,这个会打印,附带堆栈信息,并调用 os.Exit 退出fmt.Println("can i be printed?") // 这行不会打印,呃...上面已经退出了
}
编译运行该程序,输出类似如下:
2020-12-19T18:02:15.093+0800 DEBUG zap3/main.go:32 i am debug, using sugar {"uuid": "79432609-3ae9-4728-bbd2-f368d404018d"}
2020-12-19T18:02:15.093+0800 INFO zap3/main.go:33 i am info, using sugar {"uuid": "79432609-3ae9-4728-bbd2-f368d404018d"}
2020-12-19T18:02:15.093+0800 WARN zap3/main.go:34 i am warn, using sugar {"uuid": "79432609-3ae9-4728-bbd2-f368d404018d"}
2020-12-19T18:02:15.093+0800 ERROR zap3/main.go:35 i am error, using sugar {"uuid": "79432609-3ae9-4728-bbd2-f368d404018d"}
2020-12-19T18:02:15.093+0800 FATAL zap3/main.go:36 i am fatal, using sugar {"uuid": "79432609-3ae9-4728-bbd2-f368d404018d"}
uuid