【线上问题排查技巧】动态修改LOGGER日志级别

曾经终败给现在 2022-12-20 14:59 132阅读 0赞

# 前言 #

大多数情况下，我们会在打印日志时定义日志的LOGGER级别，用来控制输出的信息范围。

一方面，过多的输出会影响查看日志的效率，另一方面，过少的日志让问题定位变得困难。

但当线上出现问题时，线上容器通常定义在info级别，发生一些疑难问题时，光靠info级别的日志很难定位问题。

一个典型的场景：在一些需要打印MySQL语句的场景，如果你正在使用MyBatis框架，由于MyBaits中SQL语句是DEBUG级别的信息，通常在线上容器就没法看到。

一个丑陋的解决办法就是在沙箱/预发环境，将log4j.xml中的info改为debug：

然后重新打包部署，再发起请求来调试代码。

甚至在一些无法模拟请求的场景下，还需要将修改灰度至线上环境，大量的debug信息会对线上服务造成实质性的影响。

**本文简要介绍如何使用阿里巴巴开源Java调试工具Arthas，实时修改线上服务的LOGGER级别，从而免去打包再部署的繁杂手续，更快的定位线上问题。**

**效果演示：**

![在这里插入图片描述][20201112233913469.gif_pic_center]

**本文内容重点：**

*  Arthas工具简介
 *  本地测试：实时修改LOGGER级别
 *  线上实战：实时打印MyBatis SQL语句
 *  总结

> 本文阅读大概需要：2分钟
> 
> 码字不易，欢迎关注我的个人原创技术公众号：后端技术漫谈（二维码见文章底部）

# Arthas工具简介 #

Arthas是阿里开源的Java诊断工具，它的功能可以大致参考下图：

![50f40609f93a9d1ea3058100606079a8.png][]

它运行的原理是通过字节码生成工具（ASM字节码增强），将代理逻辑编织到原来的类里，实现对应的监控调试等功能。

> 关于Arthas这个工具，之前**我写了一篇完整的总结文章**，包括所有功能的使用和原理初探，可以去原文章查看：https://juejin.im/post/6844903998730797070

# 本地测试：实时修改LOGGER级别 #

## 安装arthas ##

### 网络安装 ###

在接通外网的环境下，可以使用快速网络安装，会从阿里的源拉去全量包。

curl -O https://arthas.aliyun.com/arthas-boot.jar
    java -jar arthas-boot.jar

### 全量安装 ###

如果本地外网环境不通，比如某些容器内是不允许外网访问的，那么可以使用预先下载好的全量安装包，然后解压后运行包内的jar，使用命令：

java -jar arthas-boot.jar

## 启动arthas ##

我在本地启动arthas，效果如下图：

![b87a34e58df2121d29608cdc635156c0.png][]

## 全局Logger信息 ##

使用命令：

logger

![79e9149c1aaccade9c2c58338416d834.png][]

可以看到所有logger的信息，包括其中每个appenders。

使用如下命令，修改名称为ROOT的logger的日志级别至debug级别：

logger --name ROOT --level debug

![3e164ebf29e9b5505ef0fabbed21b1b7.png][]

可以看到多出了debug级别的输出。

## 指定类名的logger信息 ##

在有多个logger的情况下，可以查找指定名称的logger

logger -n ROOT

![781d00fdb5aa53c3773f42c0cfa93dba.png][]

## 指定classloader的logger信息 ##

如果需要改变指定类的输出级别，先要定位到该类的classLoader，然后修改该clasLoader的logger。

使用sc命令查看你需要改变的类信息：

sc -d cn.monitor4all.miaoshaweb.DynamicLoggerTest | grep classLoaderHash

![da1acd3459868b19a4ccce171173a67d.png][]

随后可以通过classLoader找到其对应的logger：

logger -c 18b4aac2

![54e9cde2377595e8f4ae4abe2bd0e594.png][]

然后就可以调整对应的logger日志级别:

logger -c 18b4aac2 --name ROOT --level debug

![3c1576d8b70d3a98ccdd3feafe5d2979.png][]

![a9fdf964bf807de26b6c51008a0014e8.png][]

## 使用 ongl 命令 ##

此外，Arthas还支持使用ognl来修改日志级别。但是这种方法对log4j不友好，修改会报错。并且就算支持的logback/slf4j，也需要复杂的形如`ognl -c @org.slf4j.LoggerFactory@getLogger("root").setLevel()`的命令才能修改,并不是一个很好的办法。

# 线上实战：实时打印MyBatis SQL语句 #

## 容器内启动arthas ##

我的线上容器，是没有外网访问权限的(这种情况蛮常见的)，我将全量包解压在容器内运行：

![a640b7b35f389d5fbacab036e31b9f44.png][]

## 打印DEBUG级别的SQL日志 ##

下图是没有DEBUG信息的一条请求日志，可以看到只有入参出参的拦截器信息（INFO级别）：

![d069953518984032f8abf19602a9adbf.png][]

使用`logger --name ROOT --level debug`，将SQL语句输出出来：

![4f5d6f366414c3b106099d27c94acd00.png][]

毕竟，很多时候线上的bug是不小心拼错SQL导致。

# 总结 #

文章简单总结了使用Arthas来动态调整日志级别的使用方法。在线上环境，能够有效的提升排查问题的效率。当然Arthas能做的还远不止于此，更多有趣并且**实用**的功能等待大家的发掘。

# 参考 #

*  https://jueee.github.io/2020/08/2020-08-20-Arthas%E4%B9%8B%E6%9F%A5%E7%9C%8B%E5%92%8C%E4%BF%AE%E6%94%B9%E6%97%A5%E5%BF%97%E7%BA%A7%E5%88%AB/
 *  https://arthas.aliyun.com/doc/logger.html\#appenderlogger
 *  https://juejin.im/post/6844903959195303943

## 关注我 ##

我是一名奋斗在一线的互联网后端开发工程师。

主要关注后端开发，数据安全，边缘计算等方向，欢迎交流。

### 各大平台都可以找到我 ###

*  **微信公众号：后端技术漫谈**
 *  **Github：[@qqxx6661][qqxx6661]**
 *  CSDN：[@蛮三刀把刀][Link 1]
 *  知乎：[@后端技术漫谈][Link 2]
 *  掘金：[@蛮三刀把刀][Link 3]
 *  腾讯云+社区：[@后端技术漫谈][Link 4]
 *  博客园：[@后端技术漫谈][Link 5]
 *  BiliBili：[@蛮三刀把刀][Link 6]

### 原创文章主要内容 ###

*  后端开发实战
 *  Java面试
 *  设计模式/数据结构/算法题解
 *  读书笔记/逸闻趣事/游戏人生

### 个人公众号：后端技术漫谈 ###

![个人公众号：后端技术漫谈][e963a6996f115b4fa82ffc9dee19ea5c.png]

**如果文章对你有帮助，不妨点赞，收藏起来~**

[20201112233913469.gif_pic_center]: /images/20221120/d5c78ec060494140a4d38b32badd1539.png
[50f40609f93a9d1ea3058100606079a8.png]: /images/20221120/e538a936dbfb4be4834af3a869482cdc.png
[b87a34e58df2121d29608cdc635156c0.png]: /images/20221120/2147c6ff06364bbe897db30a17a453a7.png
[79e9149c1aaccade9c2c58338416d834.png]: /images/20221120/1bfa135c3e3f4673bf25b2ffdcd1e680.png
[3e164ebf29e9b5505ef0fabbed21b1b7.png]: /images/20221120/280cb21d064043529bfbf8e9cd25e68c.png
[781d00fdb5aa53c3773f42c0cfa93dba.png]: /images/20221120/7aa3c68cbd8d43fd92899b2781227954.png
[da1acd3459868b19a4ccce171173a67d.png]: /images/20221120/f737ac0488814988a80574ed168d60d3.png
[54e9cde2377595e8f4ae4abe2bd0e594.png]: /images/20221120/ade3edcdcf5d42e29131554231ff9785.png
[3c1576d8b70d3a98ccdd3feafe5d2979.png]: /images/20221120/ea049e7259fe48f893433ac697a0793b.png
[a9fdf964bf807de26b6c51008a0014e8.png]: /images/20221120/ba85c557143d45af9f4ae82a8156beb2.png
[a640b7b35f389d5fbacab036e31b9f44.png]: /images/20221120/1850d0c078164b3180e3f24f80b40922.png
[d069953518984032f8abf19602a9adbf.png]: /images/20221120/4eacefce809b46558c718e494d0b9897.png
[4f5d6f366414c3b106099d27c94acd00.png]: /images/20221120/6a3fcf0344234a31bcb541c78f3c0f91.png
[qqxx6661]: https://github.com/qqxx6661
[Link 1]: http://blog.csdn.net/qqxx6661
[Link 2]: https://www.zhihu.com/people/yang-zhen-dong-1/
[Link 3]: https://juejin.im/user/5b48015ce51d45191462ba55
[Link 4]: https://cloud.tencent.com/developer/user/1706868
[Link 5]: https://www.cnblogs.com/rude3knife/
[Link 6]: https://space.bilibili.com/18324091
[e963a6996f115b4fa82ffc9dee19ea5c.png]: /images/20221120/f2dd3b32e1a74a64bfb533a54376233d.png