|
| 1 | +--- |
| 2 | +layout: post |
| 3 | +category: java |
| 4 | +title: 阿里巴巴开发手册强制使用SLF4J作为门面担当的秘密,我搞清楚了 |
| 5 | +tagline: by 沉默王二 |
| 6 | +tags: |
| 7 | + - java |
| 8 | +--- |
| 9 | + |
| 10 | + |
| 11 | +之前已经详细、全面地介绍了 [Log4j](https://mp.weixin.qq.com/s/AXgNnJe8djD901EmhFkWUg),相信小伙伴们已经完全掌握了。那我在读嵩山版的阿里巴巴开发手册(没有的小伙伴,记着找我要)的时候,就发现了一条「**强制**」性质的日志规约: |
| 12 | + |
| 13 | + |
| 14 | +<!--more--> |
| 15 | + |
| 16 | + |
| 17 | +>应用中不可以直接使用日志系统(Log4j、Logback)中的 API,而应该使用日志框架中的 API,比如说 SLF4J,使用门面模式的日志框架,有利于维护和统一各个类的日志处理方式。 |
| 18 | +
|
| 19 | +(为什么我把这段文字手敲了下来呢,因为我发现阿里巴巴开发手册上的有语病,瞧下面红色标出的部分) |
| 20 | + |
| 21 | + |
| 22 | + |
| 23 | +(维护和统一,把统一放在最后面读起来真的是别扭,和的有点牵强,请问手册的小编是数学老师教的语文吧?) |
| 24 | + |
| 25 | + |
| 26 | + |
| 27 | +那看到这条强制性的规约,我就忍不住想要问:“为什么阿里巴巴开发手册会强制使用 SLF4J 作为 Log4J 的门面担当呢?”究竟这背后藏了什么“不可告人”的秘密? |
| 28 | + |
| 29 | +(请小伙伴们自行配上 CCTV 12 台的那种 BGM) |
| 30 | + |
| 31 | +PS:顺带给小伙伴们普及一点小知识,阿里巴巴开发手册上出现的 Jakarta 其实是 Apache 软件基金会下的一个开源项目。其实 Commons 是以前隶属于 Jakarta,现在是作为 Apache 下的一个单独项目,阿里巴巴开发手册上的描述已经不太恰当了,换成是 Apache Commons Logging 会更合适一点。 |
| 32 | + |
| 33 | +(忍不住又给阿里巴巴开发手册挑了一个毛病,请原谅我“一丝不苟”的做事态度) |
| 34 | + |
| 35 | +### 01、SLF4J 是什么 |
| 36 | + |
| 37 | +SLF4J 是 Simple Logging Facade for Java 的缩写(for≈4),也就是简易的日志门面,以外观模式(Facade pattern,一种设计模式,为子系统中的一组接口提供一个统一的高层接口,使得子系统更容易使用)实现,支持 java.util.logging、Log4J 和 Logback。 |
| 38 | + |
| 39 | +SLF4J 的作者就是 Log4J 和 Logback 的作者,他的 GitHub 主页长下面这样: |
| 40 | + |
| 41 | + |
| 42 | + |
| 43 | +一股秋风瑟瑟的清冷感扑面而来,有没有?可能巨佬不屑于维护他的 GitHub 主页吧?我的 GitHub 主页够凄惨了,没想到巨佬比我还惨,终于可以吹牛逼地说,“我,沉默王二,GitHub 主页比 SLF4J、Log4J 和 Logback 的作者 Ceki Gulcu 绿多了。。。。。。” |
| 44 | + |
| 45 | + |
| 46 | + |
| 47 | +1996 年初,欧洲安全电子市场项目决定编写自己的跟踪 API,最后该 API 演变成了 Log4j,已经推出就备受宠爱。 |
| 48 | + |
| 49 | +2002 年 2 月,Sun 推出了自己的日志包 java.util.logging(可称 JUL),据说实现思想借鉴了 Log4j,毕竟此时的 Log4j 已经很成熟了。 |
| 50 | + |
| 51 | +2002 年 8 月,Apache 就推出了自己的日志包,也就是阿里巴巴开发手册上提到的 JCL(Jakarta Commons Logging)。JCL 的野心很大,它在 JUL 和 Log4j 的基础上提供了一个抽象层的接口,方便使用者在 JUL 和 Log4j 之间切换。 |
| 52 | + |
| 53 | + |
| 54 | + |
| 55 | +但 JCL 好像并不怎么招人喜欢,有人是这样抱怨的: |
| 56 | + |
| 57 | + |
| 58 | + |
| 59 | +Ceki Gulcu 也觉得 JCL 不好,要不然他也不会在 2005 年自己撸一个名叫 SLF4J 的新项目,对吧?但出来混总是要付出代价的,SLF4J 只有接口,没有实现,总不能强逼着 Java 和 Apache 去实现 SLF4J 接口吧?这太难了,不现实。 |
| 60 | + |
| 61 | +但巨佬之所以称之为巨佬,是因为他拥有超出普通人的惊人之处,他在 SLF4J 和 JUL、Log4j、JCL 之间搭了三座桥: |
| 62 | + |
| 63 | + |
| 64 | + |
| 65 | +巨佬动手,丰衣足食,有没有?狠起来连自己的 Log4j 都搭个桥。 |
| 66 | + |
| 67 | +面对巨佬的霸气,我只想弱弱地说一句,“ SLF4J 这个门面担当,你以为好当的啊?” |
| 68 | + |
| 69 | +### 02、SLF4J 解决了什么痛点 |
| 70 | + |
| 71 | +春秋战国的时候,每个国家都有自己的货币,用别国的货币也不合适,对吧?那在发生贸易的时候就比较麻烦了,货币不统一,就没法直接交易,因为货币可能不等价。 |
| 72 | + |
| 73 | +那秦始皇统一六国后,就推出了新的货币政策,全国都用一种货币,那之前的问题就解决掉了。 |
| 74 | + |
| 75 | +你看,同样的道理,日志系统有 JUL、JCL,Ceki Gulcu 自己又写了 2 种,Log4j 和 Logback,各有各的优缺点,再加上使用者千千万,萝卜白菜各有所爱,这就导致不同的应用可能会用不同的日志系统。 |
| 76 | + |
| 77 | +假设我们正在开发一套系统,打算用 SLF4J 作为门面,Log4j 作为日志系统,我们在项目中使用了 A 框架,而 A 框架的门面是 JCL,日志系统是 JUL,那就相等于要维护两套日志系统,对吧? |
| 78 | + |
| 79 | + |
| 80 | + |
| 81 | +这就难受了! |
| 82 | + |
| 83 | +Ceki Gulcu 想到了这个问题,并且帮我们解决了!来看 SLF4J 官网给出的解决方案。 |
| 84 | + |
| 85 | + |
| 86 | + |
| 87 | +- 使用 jcl-over-slf4j.jar 替换 commons-logging.jar |
| 88 | +- 引入 jul-to-slf4j.jar |
| 89 | + |
| 90 | +为了模拟这个过程,我们来建一个使用 JCL 的项目。 |
| 91 | + |
| 92 | +第一步,在 pom.xml 文件中引入 commons-logging.jar: |
| 93 | + |
| 94 | +```xml |
| 95 | +<dependency> |
| 96 | + <groupId>commons-logging</groupId> |
| 97 | + <artifactId>commons-logging</artifactId> |
| 98 | + <version>1.2</version> |
| 99 | +</dependency> |
| 100 | +``` |
| 101 | + |
| 102 | +第二步,新建测试类: |
| 103 | + |
| 104 | +```java |
| 105 | +package com.itwanger; |
| 106 | + |
| 107 | +import org.apache.commons.logging.Log; |
| 108 | +import org.apache.commons.logging.LogFactory; |
| 109 | + |
| 110 | +/** |
| 111 | + * @author 微信搜「沉默王二」,回复关键字 PDF |
| 112 | + */ |
| 113 | +public class Demo { |
| 114 | + private static Log logger = LogFactory.getLog(Demo.class); |
| 115 | + public static void main(String[] args) { |
| 116 | + logger.info("jcl"); |
| 117 | + } |
| 118 | +} |
| 119 | +``` |
| 120 | + |
| 121 | +该类会通过 LogFactory 获取一个 Log 对象,并且使用 `info()` 方法打印一行日志。 |
| 122 | + |
| 123 | +调试这段代码的过程中你会发现,Log 的实现有四种: |
| 124 | + |
| 125 | + |
| 126 | + |
| 127 | +如果没有绑定 Log4j 的话,就会默认选择 Jdk14Logger——它返回的 Logger 对象,正是 java.util.logging.Logger,也就是 JUL。 |
| 128 | + |
| 129 | +因此,就可以在控制台看到以下信息: |
| 130 | + |
| 131 | +``` |
| 132 | +10月 21, 2020 3:13:30 下午 com.itwanger.Demo main |
| 133 | +信息: jcl |
| 134 | +``` |
| 135 | + |
| 136 | +怎么把使用 JCL 的项目改造成使用 SLF4J 的呢? |
| 137 | + |
| 138 | +第三步,使用 jcl-over-slf4j.jar 替换 commons-logging.jar,并加入 jul-to-slf4j.jar、slf4j-log4j12.jar(会自动引入 slf4j-api.jar 和 log4j.jar): |
| 139 | + |
| 140 | +```xml |
| 141 | +<dependency> |
| 142 | + <groupId>org.slf4j</groupId> |
| 143 | + <artifactId>jcl-over-slf4j</artifactId> |
| 144 | + <version>1.7.25</version> |
| 145 | +</dependency> |
| 146 | + |
| 147 | +<dependency> |
| 148 | + <groupId>org.slf4j</groupId> |
| 149 | + <artifactId>jul-to-slf4j</artifactId> |
| 150 | + <version>1.7.29</version> |
| 151 | +</dependency> |
| 152 | + |
| 153 | +<dependency> |
| 154 | + <groupId>org.slf4j</groupId> |
| 155 | + <artifactId>slf4j-log4j12</artifactId> |
| 156 | + <version>1.7.25</version> |
| 157 | +</dependency> |
| 158 | +``` |
| 159 | + |
| 160 | +第四步,在 resources 目录下创建 log4j.properties 文件,内容如下所示: |
| 161 | + |
| 162 | +``` |
| 163 | +### 设置### |
| 164 | +log4j.rootLogger = debug,stdout,D |
| 165 | +
|
| 166 | +### 输出信息到控制台 ### |
| 167 | +log4j.appender.stdout = org.apache.log4j.ConsoleAppender |
| 168 | +log4j.appender.stdout.Target = System.out |
| 169 | +log4j.appender.stdout.layout = org.apache.log4j.PatternLayout |
| 170 | +log4j.appender.stdout.layout.ConversionPattern = [%-5p] %d{yyyy-MM-dd HH:mm:ss,SSS} method:%l%n%m%n |
| 171 | +
|
| 172 | +### 输出DEBUG 级别以上的日志到=debug.log ### |
| 173 | +log4j.appender.D = org.apache.log4j.DailyRollingFileAppender |
| 174 | +log4j.appender.D.File = debug.log |
| 175 | +log4j.appender.D.Append = true |
| 176 | +log4j.appender.D.Threshold = DEBUG |
| 177 | +log4j.appender.D.layout = org.apache.log4j.PatternLayout |
| 178 | +log4j.appender.D.layout.ConversionPattern = %d{yyyy-MM-dd HH:mm:ss} [ %t:%r ] - [ %p ] %m%n |
| 179 | +``` |
| 180 | + |
| 181 | +再次运行 Demo 类,你会发现 target 目录下会生成一个名叫 debug.log 的文件,内容如下所示: |
| 182 | + |
| 183 | +``` |
| 184 | +2020-10-21 15:32:06 [ main:0 ] - [ INFO ] jcl |
| 185 | +``` |
| 186 | + |
| 187 | +并且可以在控制台看到以下信息: |
| 188 | + |
| 189 | +``` |
| 190 | +[INFO ] 2020-10-21 15:32:06,192 method:com.itwanger.Demo.main(Demo.java:12) |
| 191 | +jcl |
| 192 | +``` |
| 193 | + |
| 194 | +仔细对比一下,你就会发现,这次输出的格式和之前不一样,这就是因为 Log4j 和 JUL 的日志格式不同导致的。 |
| 195 | + |
| 196 | +另外,你有没有发现?我们并没有改动测试类 Demo,它里面使用的仍然是 JCL 获取 Log 的方式: |
| 197 | + |
| 198 | +```java |
| 199 | +private static Log logger = LogFactory.getLog(Demo.class); |
| 200 | +``` |
| 201 | + |
| 202 | +但输出的格式已经切换到 Log4j 了! |
| 203 | + |
| 204 | +SLF4J 除了提供这种解决方案,绑定 Log4j 替换 JUL 和 JCL;还提供了绑定 Logback 替换 JUL、JCL、Log4j 的方案: |
| 205 | + |
| 206 | + |
| 207 | + |
| 208 | +还有绑定 JUL 替换 JCL 和 Log4j 的方案: |
| 209 | + |
| 210 | + |
| 211 | + |
| 212 | +太强了,有木有?有的话请在留言区敲出 666。 |
| 213 | + |
| 214 | + |
| 215 | + |
| 216 | +### 03、SLF4J 比 Log4J 强在哪 |
| 217 | + |
| 218 | +SLF4J 除了解决掉以上的痛点,帮助我们的应用程序独立于任何特定的日志系统,还有一个非常牛逼的功能,那就是 SLF4J 在打印日志的时候使用了占位符 `{}`,它有点类似于 String 类的 `format()` 方法(使用 `%s` 等填充参数),但更加便捷,这在很大程度上提高了程序的性能。 |
| 219 | + |
| 220 | +众所周知,字符串是不可变的,字符串拼接会创建很多不必要的字符串对象,极大的消耗了内存空间。但 Log4J 在打印带参数的日志时,只能使用字符串拼接的方式: |
| 221 | + |
| 222 | +```java |
| 223 | +String name = "沉默王二"; |
| 224 | +int age = 18; |
| 225 | +logger.debug(name + ",年纪:" + age + ",是个非常不要脸的程序员"); |
| 226 | +``` |
| 227 | + |
| 228 | +非常笨重,但加入了 SLF4J 后,这个问题迎刃而解。我们来看一下在 Log4j 项目中加入 SLF4J 的详细的步骤。 |
| 229 | + |
| 230 | +第一步,把 log4j 的依赖替换为 slf4j-log4j12(Maven 会自动引入 slf4j-api.jar 和 log4j.jar): |
| 231 | + |
| 232 | +```java |
| 233 | +<dependency> |
| 234 | + <groupId>org.slf4j</groupId> |
| 235 | + <artifactId>slf4j-log4j12</artifactId> |
| 236 | + <version>1.7.25</version> |
| 237 | +</dependency> |
| 238 | +``` |
| 239 | + |
| 240 | +第二步,在 resources 目录下创建 log4j.properties 文件,内容和 [Log4j 那一篇](https://mp.weixin.qq.com/s/AXgNnJe8djD901EmhFkWUg)完全相同: |
| 241 | + |
| 242 | +``` |
| 243 | +### 设置### |
| 244 | +log4j.rootLogger = debug,stdout,D,E |
| 245 | +
|
| 246 | +### 输出信息到控制台 ### |
| 247 | +log4j.appender.stdout = org.apache.log4j.ConsoleAppender |
| 248 | +log4j.appender.stdout.Target = System.out |
| 249 | +log4j.appender.stdout.layout = org.apache.log4j.PatternLayout |
| 250 | +log4j.appender.stdout.layout.ConversionPattern = [%-5p] %d{yyyy-MM-dd HH:mm:ss,SSS} method:%l%n%m%n |
| 251 | +
|
| 252 | +### 输出DEBUG 级别以上的日志到=debug.log ### |
| 253 | +log4j.appender.D = org.apache.log4j.DailyRollingFileAppender |
| 254 | +log4j.appender.D.File = debug.log |
| 255 | +log4j.appender.D.Append = true |
| 256 | +log4j.appender.D.Threshold = DEBUG |
| 257 | +log4j.appender.D.layout = org.apache.log4j.PatternLayout |
| 258 | +log4j.appender.D.layout.ConversionPattern = %d{yyyy-MM-dd HH:mm:ss} [ %t:%r ] - [ %p ] %m%n |
| 259 | +
|
| 260 | +### 输出ERROR 级别以上的日志到=error.log ### |
| 261 | +log4j.appender.E = org.apache.log4j.DailyRollingFileAppender |
| 262 | +log4j.appender.E.File =error.log |
| 263 | +log4j.appender.E.Append = true |
| 264 | +log4j.appender.E.Threshold = ERROR |
| 265 | +log4j.appender.E.layout = org.apache.log4j.PatternLayout |
| 266 | +log4j.appender.E.layout.ConversionPattern = %d{yyyy-MM-dd HH:mm:ss} [ %t:%r ] - [ %p ] %m%n |
| 267 | +``` |
| 268 | + |
| 269 | +第三步,新建测试类: |
| 270 | + |
| 271 | +```java |
| 272 | +package com.itwanger; |
| 273 | + |
| 274 | +import org.slf4j.Logger; |
| 275 | +import org.slf4j.LoggerFactory; |
| 276 | + |
| 277 | +/** |
| 278 | + * @author 微信搜「沉默王二」,回复关键字 PDF |
| 279 | + */ |
| 280 | +public class Log4jSLF4JDemo { |
| 281 | + private static final Logger logger = LoggerFactory.getLogger(Log4jSLF4JDemo.class); |
| 282 | + |
| 283 | + public static void main(String[] args) { |
| 284 | + logger.debug("{},是个非常不要脸的程序员","沉默王二"); |
| 285 | + } |
| 286 | +} |
| 287 | +``` |
| 288 | + |
| 289 | +看到了吧,使用占位符要比“+”操作符方便的多。并且此时不再需要 `isDebugEnabled()` 先进行判断,`debug()` 方法会在字符串拼接之前执行。 |
| 290 | + |
| 291 | + |
| 292 | + |
| 293 | + |
| 294 | +如果只是 Log4J 的话,会先进行字符串拼接,再执行 `debug()` 方法,来看示例代码: |
| 295 | + |
| 296 | +```java |
| 297 | +String name = "沉默王二"; |
| 298 | +int age = 18; |
| 299 | +logger.debug(name + ",年纪:" + age + ",是个非常不要脸的程序员"); |
| 300 | +``` |
| 301 | + |
| 302 | +在调试这段代码的时候,你会发现的,如下图所示: |
| 303 | + |
| 304 | + |
| 305 | + |
| 306 | +这也就意味着,如果日志系统的级别不是 DEBUG,就会多执行了字符串拼接的操作,白白浪费了性能。 |
| 307 | + |
| 308 | +注意,阿里巴巴开发手册上还有一条「**强制**」级别的规约: |
| 309 | + |
| 310 | + |
| 311 | + |
| 312 | +这是因为如果参数是基本数据类型的话,会先进行自动装箱(`Integer.valueOf()`)。测试代码如下所示: |
| 313 | + |
| 314 | +```java |
| 315 | +logger.debug("沉默王二,{}岁", 18); |
| 316 | +``` |
| 317 | + |
| 318 | +通过反编译工具就可以看得到: |
| 319 | + |
| 320 | +```java |
| 321 | +logger.debug("\u6C89\u9ED8\u738B\u4E8C\uFF0C{}\u5C81", Integer.valueOf(18)); |
| 322 | +``` |
| 323 | + |
| 324 | +如果参数需要调用其他方法的话,`debug()` 方法会随后调用。 |
| 325 | + |
| 326 | + |
| 327 | + |
| 328 | +也就是说,如果不 `isDebugEnabled()` 的话,在不是 DEBUG 级别的情况下,会多执行自动装箱和调用其他方法的操作——程序的性能就下降了! |
| 329 | + |
| 330 | +测试类运行的结果和之前 Log4J 的一样,小伙伴们可以点击链接跳转到 [Log4j 那篇](https://mp.weixin.qq.com/s/AXgNnJe8djD901EmhFkWUg)对比下。 |
| 331 | + |
| 332 | +### 04、总结 |
| 333 | + |
| 334 | +简单总结一下这篇文章哈。 |
| 335 | + |
| 336 | +1)在使用日志系统的时候,一定要使用 SLF4J 作为门面担当。 |
| 337 | + |
| 338 | +2)SLF4J 可以统一日志系统,作为上层的抽象接口,不需要关注底层的日志实现,可以是 Log4j,也可以是 Logback,或者 JUL、JCL。 |
| 339 | + |
| 340 | +3)SLF4J 在打印日志的时候可以使用占位符,既提高了程序性能(临时字符串少了,垃圾回收的工作量就小),又让代码变得美观统一。 |
| 341 | + |
| 342 | +4)小伙伴们如果知道更多秘密的话,建议在留言区贴出来哦。 |
| 343 | + |
| 344 | + |
| 345 | + |
| 346 | +嗯哼,其实我已经写完了整个日志系统,包括 Log4j、 SLF4J、Logback、Log4j 它弟 Log4j 2,但我觉得分开来发的话,更利于 SEO(瞧我这为了流量的心机,手动狗头)。如果你确实需要看完整版的话,我也贴心地为你准备了,点击下面的链接就可以下载 PDF: |
| 347 | + |
| 348 | +>[https://pan.baidu.com/s/1dPwsQhT5OMVapE7hGi7vww](https://pan.baidu.com/s/1dPwsQhT5OMVapE7hGi7vww) 提取码:fxxy |
| 349 | +
|
| 350 | +码字不易,日常求个赞吧,动一动金手指,bug 少一个(逃。 |
0 commit comments