天啦擼!列印日誌竟然只曉得 Log4j?

2021-03-02 Java編程

空了的時候,我都會在群裡偷偷摸摸地潛水,對小夥伴們的一舉一動、一言一行篩查診斷。一副班主任的即時感,讓我感到非常的快樂,略微夾帶一絲絲的枯燥

這不,我在戰國時代讀者群裡發現了這麼一串聊天記錄:

竟然有小夥伴不知道「打日誌」是什麼意思,不知道該怎麼學習,還有小夥伴回答說,只知道 Log4j!

有那麼一刻,我遭受到了一萬點暴擊,內心莫名的傷感,猶如一匹垂頭喪氣的狗。因為網絡上總有一些不懷好意的人不停地攻擊我,說我寫的文章入門,毫無深度——他們就是我命中注定的黑子,不信你到脈脈上搜「沉默王二」,就能看到他們毫無新意的抨擊。

我就想問一下,怎麼了,入門的文章有入門的群體需要,而我恰好幫助了這麼一大批初學者,我應該受到褒獎好不好?

(說好的不在乎,怎麼在乎起來了呢?手動狗頭)

管他呢,我行我素吧,保持初心不改就對了!這篇文章就來說說 Log4j,這個列印日誌的鼻祖。Java 中的日誌列印其實是個藝術活,我保證,這句話絕不是忽悠。

事實證明,列印日誌絕逼會影響到程序的性能,這是不可否認的,畢竟多做了一項工作。尤其是在交易非常頻繁的程序裡,湧現大量的日誌確實會比較低效。

基於性能上的考量,小夥伴們很有必要認認真真地學習一下如何優雅地列印 Java 日誌。畢竟,性能是一個程式設計師優不優秀的重要考量。

01、為什麼需要在 Java 中列印日誌

System.out.println() 恐怕是我們在學習 Java 的時候,最常用的一種列印日誌的方式了,幾乎每個 Java 初學者都這樣幹過,甚至一些老鳥。

之所以這樣列印日誌,是因為很方便,上手難度很低,尤其是在 IDEA 的幫助下,只需在鍵盤上按下 so 兩個字母就可以調出 System.out.println()。

在本地環境下,使用 System.out.println() 列印日誌是沒問題的,可以在控制臺看到信息。但如果是在生產環境下的話,System.out.println() 就變得毫無用處了。

控制臺列印出的信息並沒有保存到日誌文件中,只能即時查看,在一屏日誌的情況下還可以接受。如果日誌量非常大,控制臺根本就裝不下。所以就需要更高級的日誌記錄 API(比如 Log4j 和 java.util.logging)。

它們可以把大量的日誌信息保存到文件中,並且控制每個文件的大小,如果滿了,就存儲到下一個,方便查找。

02、選擇不同日誌級別的重要性

使用 Java 日誌的時候,一定要注意日誌的級別,比如常見的 DEBUG、INFO、WARN 和 ERROR。

DEBUG 的級別最低,當需要列印調試信息的話,就用這個級別,不建議在生產環境下使用。

INFO 的級別高一些,當一些重要的信息需要列印的時候,就用這個。

WARN,用來記錄一些警告類的信息,比如說客戶端和服務端的連接斷開了,資料庫連接丟失了。

ERROR 比 WARN 的級別更高,用來記錄錯誤或者異常的信息。

FATAL,當程序出現致命錯誤的時候使用,這意味著程序可能非正常中止了。

OFF,最高級別,意味著所有消息都不會輸出了。

這個級別是基於 Log4j 的,和 java.util.logging 有所不同,後者提供了更多的日誌級別,比如說 SEVERE、FINER、FINEST。

03、錯誤的日誌記錄方式是如何影響性能的

為什麼說錯誤的日誌記錄方式會影響程序的性能呢?因為日誌記錄的次數越多,意味著執行文件 IO 操作的次數就越多,這也就意味著會影響到程序的性能,能 get 吧?

雖然說普通硬碟升級到固態硬碟後,讀寫速度快了很多,但磁碟相對於內存和 CPU 來說,還是太慢了!就像馬車和奔馳之間的速度差距。

這也就是為什麼要選擇日誌級別的重要性。對於程序來說,記錄日誌是必選項,所以能控制的就是日誌的級別,以及在這個級別上列印的日誌。

對於 DEBUG 級別的日誌來說,一定要使用下面的方式來記錄:

if(logger.isDebugEnabled()){ 
    logger.debug("DEBUG 是開啟的"); 

當 DEBUG 級別是開啟的時候再列印日誌,這種方式在你看很多源碼的時候就可以發現,很常見。

切記,在生產環境下,一定不要開啟 DEBUG 級別的日誌,否則程序在大量記錄日誌的時候會變很慢,還有可能在你不注意的情況下,悄悄地把磁碟空間撐爆。

04、為什麼選擇 Log4j 而不是 java.util.logging

java.util.logging 屬於原生的日誌 API,Log4j 屬於第三方類庫,但我建議使用 Log4j,因為 Log4j 更好用。java.util.logging 的日誌級別比 Log4j 更多,但用不著,就變成了多餘。

Log4j 的另外一個好處就是,不需要重新啟動 Java 程序就可以調整日誌的記錄級別,非常靈活。可以通過 log4j.properties 文件來配置 Log4j 的日誌級別、輸出環境、日誌文件的記錄方式。

Log4j 還是線程安全的,可以在多線程的環境下放心使用。

先來看一下 java.util.logging 的使用方式:

package com.itwanger;

import java.io.IOException;
import java.util.logging.FileHandler;
import java.util.logging.Logger;
import java.util.logging.SimpleFormatter;

/**
 * @author 微信搜「沉默王二」,回復關鍵字 PDF
 */
public class JavaUtilLoggingDemo {
    public static void main(String[] args) throws IOException {
        Logger logger = Logger.getLogger("test");
        FileHandler fileHandler = new FileHandler("javautillog.txt");
        fileHandler.setFormatter(new SimpleFormatter());
        logger.addHandler(fileHandler);
        logger.info("細小的信息");
    }
}

程序運行後會在 target 目錄下生成一個名叫 javautillog.txt 的文件,內容如下所示:

再來看一下 Log4j 的使用方式。

第一步,在 pom.xml 文件中引入 Log4j 包:

<dependency>
    <groupId>log4j</groupId>
    <artifactId>log4j</artifactId>
    <version>1.2.17</version>
</dependency>

第二步,在 resources 目錄下創建 log4j.properties 文件,內容如下所示:

### 設置###
log4j.rootLogger = debug,stdout,D,E

### 輸出信息到控制臺 ###
log4j.appender.stdout = org.apache.log4j.ConsoleAppender
log4j.appender.stdout.Target = System.out
log4j.appender.stdout.layout = org.apache.log4j.PatternLayout
log4j.appender.stdout.layout.ConversionPattern = [%-5p] %d{yyyy-MM-dd HH:mm:ss,SSS} method:%l%n%m%n

### 輸出DEBUG 級別以上的日誌到=debug.log ###
log4j.appender.D = org.apache.log4j.DailyRollingFileAppender
log4j.appender.D.File = debug.log
log4j.appender.D.Append = true
log4j.appender.D.Threshold = DEBUG 
log4j.appender.D.layout = org.apache.log4j.PatternLayout
log4j.appender.D.layout.ConversionPattern = %d{yyyy-MM-dd HH:mm:ss}  [ %t:%r ] - [ %p ]  %m%n

### 輸出ERROR 級別以上的日誌到=error.log ###
log4j.appender.E = org.apache.log4j.DailyRollingFileAppender
log4j.appender.E.File =error.log 
log4j.appender.E.Append = true
log4j.appender.E.Threshold = ERROR 
log4j.appender.E.layout = org.apache.log4j.PatternLayout
log4j.appender.E.layout.ConversionPattern = %d{yyyy-MM-dd HH:mm:ss}  [ %t:%r ] - [ %p ]  %m%n

1)配置根 Logger,語法如下所示:

log4j.rootLogger = [ level ] , appenderName, appenderName, …

level 就是日誌的優先級,從高到低依次是 ERROR、WARN、INFO、DEBUG。如果這裡定義的是 INFO,那麼低級別的 DEBUG 日誌信息將不會列印出來。

appenderName 就是指把日誌信息輸出到什麼地方,可以指定多個地方,當前的配置文件中有 3 個地方,分別是 stdout、D、E。

2)配置日誌輸出的目的地,語法如下所示:

log4j.appender.appenderName = fully.qualified.name.of.appender.class  
log4j.appender.appenderName.option1 = value1  
…  
log4j.appender.appenderName.option = valueN

Log4j 提供的目的地有下面 5 種:

org.apache.log4j.ConsoleAppender:控制臺

org.apache.log4j.FileAppender:文件

org.apache.log4j.DailyRollingFileAppender:每天產生一個文件

org.apache.log4j.RollingFileAppender:文件大小超過閾值時產生一個新文件

org.apache.log4j.WriterAppender:將日誌信息以流格式發送到任意指定的地方

3)配置日誌信息的格式,語法如下所示:

log4j.appender.appenderName.layout = fully.qualified.name.of.layout.class  
log4j.appender.appenderName.layout.option1 = value1  
…  
log4j.appender.appenderName.layout.option = valueN

Log4j 提供的格式有下面 4 種:

org.apache.log4j.HTMLLayout:HTML 表格

org.apache.log4j.PatternLayout:自定義

org.apache.log4j.SimpleLayout:包含日誌信息的級別和信息字符串

org.apache.log4j.TTCCLayout:包含日誌產生的時間、線程、類別等等信息

自定義格式的參數如下所示:

第三步,寫個使用 Demo:

package com.itwanger;

import org.apache.log4j.LogManager;
import org.apache.log4j.Logger;

/**
 * @author 微信搜「沉默王二」,回復關鍵字 PDF
 */
public class Log4jDemo {
    private static final Logger logger = LogManager.getLogger(Log4jDemo.class);

    public static void main(String[] args) {
        // 記錄debug級別的信息
        logger.debug("debug.");

        // 記錄info級別的信息
        logger.info("info.");

        // 記錄error級別的信息
        logger.error("error.");
    }
}

1)獲取 Logger 對象

要使用 Log4j 的話,需要先獲取到 Logger 對象,它用來負責日誌信息的列印。通常的格式如下所示:

private static final Logger logger = LogManager.getLogger(Log4jDemo.class);

2)列印日誌

有了 Logger 對象後,就可以按照不同的優先級列印日誌了。常見的有以下 4 種:

Logger.debug() ;  
Logger.info() ;  
Logger.warn() ;  
Logger.error() ;

程序運行後會在 target 目錄下生成兩個文件,一個名叫 debug.log,內容如下所示:

2020-10-20 20:53:27  [ main:0 ] - [ DEBUG ]  debug.
2020-10-20 20:53:27  [ main:3 ] - [ INFO ]  info.
2020-10-20 20:53:27  [ main:3 ] - [ ERROR ]  error.

另外一個名叫 error.log,內容如下所示:

2020-10-20 20:53:27  [ main:3 ] - [ ERROR ]  error.

05、列印日誌的 8 個小技巧

1)在列印 DEBUG 級別的日誌時,切記要使用 isDebugEnabled()!那小夥伴們肯定非常好奇,為什麼要這樣做呢?

先來看一下 isDebugEnabled() 方法的源碼:

  public
  boolean isDebugEnabled() {
    if(repository.isDisabled( Level.DEBUG_INT))
      return false;
    return Level.DEBUG.isGreaterOrEqual(this.getEffectiveLevel());
  }

內部使用了 isDisabled() 方法進行了日誌級別的判斷,如果 DEBUG 是禁用的話,就 return false 了。

再來看一下 debug() 方法的源碼:

  public
  void debug(Object message) {
    if(repository.isDisabled(Level.DEBUG_INT))
      return;
    if(Level.DEBUG.isGreaterOrEqual(this.getEffectiveLevel())) {
      forcedLog(FQCN, Level.DEBUG, message, null);
    }
  }

咦,不是也用 isDisabled() 方法判斷嗎?難道使用 isDebugEnabled()不是畫蛇添足嗎?直接用 logger.debug() 不香嗎?我來給小夥伴們解釋下。

如果我們在列印日誌信息的時候需要附帶一個方法去獲取參數值,就像下面這樣:

logger.debug("用戶名是:" + getName());

假如 getName() 方法需要耗費的時間長達 6 秒,那完了!儘管配置文件裡的日誌級別定義的是 INFO,getName() 方法仍然會倔強地執行 6 秒,完事後再 debug(),這就很崩了!

明明 INFO 的時候 debug() 是不執行的,意味著 getName() 也不需要執行的,偏偏就執行了 6 秒,是不是很傻?

if(logger.isDebugEnabled()) {
    logger.debug("用戶名是:" + getName());
}

換成上面這種方式,那確定此時 getName() 是不執行的,對吧?

為了程序性能上的考量,isDebugEnabled() 就變得很有必要了!假如說 debug() 的時候沒有傳參,確實是不需要判斷 DEBUG 是否啟用的。

2)慎重選擇日誌信息的列印級別,因為這太重要了!如果只能通過日誌查看程序發生了什麼問題,那必要的信息是必須要列印的,但列印得太多,又會影響到程序的性能。

所以,該 INFO 的 info(),該 DEBUG 的 debug(),不要隨便用。

3)使用 Log4j 而不是 System.out、System.err 或者 e.printStackTrace() 來列印日誌,原因之前講過了,就不再贅述了。

4)使用 log4j.properties 文件來配置日誌,儘管它不是必須項,使用該文件會讓程序變得更靈活,有一種我的地盤我做主的味道。

5)不要忘記在列印日誌的時候帶上類的全名和線程名,在多線程環境下,這點尤為重要,否則定位問題的時候就太難了。

6)列印日誌信息的時候儘量要完整,不要太過於預設,尤其是在遇到異常或者錯誤的時候(信息要保留兩類:案發現場信息和異常堆棧信息,如果不做處理,通過 throws 關鍵字往上拋),免得在找問題的時候都是一些無用的日誌信息。

7)要對日誌信息加以區分,把某一類的日誌信息在輸出的時候加上前綴,比如說所有資料庫級別的日誌裡添加 DB_LOG,這樣的日誌非常大的時候可以通過 grep 這樣的 Linux 命令快速定位。

8)不要在日誌文件中列印密碼、銀行帳號等敏感信息。

06、 總結

列印日誌真的是一種藝術活,搞不好會嚴重影響伺服器的性能。最可怕的是,記錄了日誌,但最後發現屁用沒有,那簡直是蒼了個天啊!尤其是在生產環境下,問題沒有記錄下來,但重現有一定的隨機性,到那時候,真的是叫天天不應,叫地地不靈啊!

嗯哼,我猜留言區一定會有小夥伴讓我用 SLF4J 或者 Logback,要是沒有的話,那特麼真尷了個尬啦。

相關焦點

  • Log4j 日誌體系結構
    值得注意的是log4j的日誌體系中,有一個特殊的日誌對象叫做root(根),他是始終存在的,假設我們首先獲取logger實例,log4j將構造下面這樣一個圖形(我不能把它叫做樹):配置繼承log4j日誌級別定義在往下面看之前我們先來看看log4j對日誌級別的定義:public final static int OFF_INT = Integer.MAX_VALUE;public final static int FATAL_INT = 50000
  • 在WAS上使用第三方Log4j開源日誌工具包
    【IT168 技術】Log4j是常用的一種第三方日誌工具包。在WebSphere應用伺服器(以下簡稱WAS)上使用Log4j時,默認配置下Log4j.properties的配置有時會不生效,日誌會輸出到WAS的SystemOut.log中。
  • Spring Boot 配置 log4j2
    今天將學習如何在 Spring Boot 中整合使用 Log4j2 日誌框架。同學們此時心裡可能就疑惑了,Spring Boot 中不是默認使用 Logback 作為日誌框架的嘛,為什麼我們還要學習配置log4j2呢。為什麼選擇 log4j2logback和log4j是一個人寫的。
  • 一文搞定slf4j、Java日誌那些事兒,我和面試官談笑風生
    在檢查日誌時,我們發現,這段代碼在捕獲異常之後,在有些機器上執行結果會列印出exception的異常棧,有些機器上則只會單純地把reqEx當做一個普通對象,列印 toString信息,不會列印出異常棧。
  • Java 日誌框架衝突問題排查與總結
    作者:Sharehubblog.xiaohansong.com/java-log-confict-solve.html前言Java 有很多的日誌框架可以選擇,當同一個項目中出現多種日誌框架時就很容易出現日誌框架衝突的問題,導致日誌列印不出來。
  • 日誌的藝術 | 好文推薦
    當項目上線之後,也會有各種各樣的日誌,比如記錄用戶的行為、伺服器的狀態、異常情況等等。列印日誌似乎是一件很簡單、不值得一提的事情。但是,當看到線上項目居然有這樣的日誌的時候,不禁想問問我們真的會列印日誌嗎?
  • Log4j 2.4 發布,最低要求 Java 7 - OSCHINA - 中文開源技術交流社區
    From this version onwards, log4j 2requires Java 7.o LOG4J2-1065:  Define org.apache.logging.log4j.Marker.equals(Object) and org.apache.logging.log4j.Marker.hashCode().
  • 天啦擼!在小坊玩泥巴的年紀,有人竟然已經開始造「星球」了?!
    天啦擼!在小坊玩泥巴的年紀,有人竟然已經開始造「星球」了?!坊友們一定十分期待這樣的時刻我們SMG可愛的二次元實習主播申䒕雅帶大家一起穿梭進博穿梭各個展館搜羅各種好物啦
  • 從烏東德水電站深入程序日誌的世界
    作為碼農,我們在做系統設計時也會考慮到未來的風險,而我們的「傳感器」來自日誌監控系統。這也是一個健壯的系統離不開日誌系統的原因。如需求上線,發現程序bug;統計程序bug,提升代碼質量;統計接口調用頻次,發現系統熱點……日誌可以幫助我們用心看清系統常用的日誌系統日誌系統應該包含如下功能:收集-能夠採集多種來源的日誌數據
  • 如何讓AutoCAD列印時不產生列印日誌plot.log文件
    在AutoCAD使用過程中,不管是我們AutoCAD進行列印圖紙還是通過列印的方式導出JPG圖片,細心的朋友會發現只要執行列印功能就會在文件的同一文件夾產生一個叫做plot.log的文件,這個文件是AutoCAD列印日誌文件,每次列印命令完成以後就會產生,不刪除留著沒啥用,刪除它每次都要刪除比較麻煩
  • 架構師之路--談架構師的基本素養和日誌處理
    下面是一如既往的乾貨時間,今天來聊聊日誌處理。  JAVA的日誌大家基本都在用slf4j。SLF4j(Simple Logging Facade for Java)是一個通用的日誌框架。裡面只定義了接口,是門面模式的典型代表。
  • plumelog 發布 3.1.2 版本,好用的 Java 分布式日誌系統
    plumelog發布3.1.2版本本次版本更新內容:1.支持自定義自定義日誌欄位
  • 最喜歡被擼的貓咪排行榜出來啦!中華田園貓竟然排第一第二?
    什麼貓咪最喜歡被擼?根據國內某資深貓奴的排序,號稱擼過幾十號品種的貓咪!中華田園貓榜上有名,竟然排第一第二?這些排名你認可嗎?貓咪喜歡被擼的程度,換句話來說也就是粘人程度,樂意被貓奴愛撫,這不僅取決於每一隻貓咪的性格,不同種類的貓咪也會對主人的愛撫產生不同的反應。
  • 99%的程式設計師都在用Lombok,原理竟然這麼簡單?我也手擼了一個!|建議收藏!!!
    對於 Lombok 我相信大部分人都不陌生,但對於它的實現原理以及缺點卻鮮為人知,而本文將會從 Lombok 的原理出發,手擼一個簡易版的 Lombok,讓你理解這個熱門技術背後的執行原理,以及它的優缺點。簡介 在講原理之前,我們先來複習一下 Lombok (老司機可直接跳過本段)。
  • 寶山亮點一網打盡:喝著3D列印咖啡擼著豬,躺在星空艙裡吃遍網紅蝦
    「五五購物節」來啦在寶山,精彩的活動太多了有爆款直播間、有網紅打卡地、還有數不清的商家折扣優惠是不是有點沒方向了?尤其是潢川縣出品的網紅小龍蝦,5月4日購物節開幕式當天一盒只賣9.9元,限量2500份。這樣便宜的價格,小龍蝦質量如何呢?記者試吃了十三香和香辣兩個口味,發現這款小龍蝦肉質飽滿Q彈,蝦殼不硬不軟,非常入味,味道甚至勝過飯店的現場烹製。5月4日寶山區購物節開幕式當天,寰球漁市拼多多直播間將從上午八點持續到晚上十點,紅包折扣免單,還特別請來米其林大廚現場烹飪。
  • 現在都流行擼鴨擼豬擼兔啦
    這雪白呆萌的寵物鴨可不是一般的鴨,而是每隻身價上萬元的柯爾鴨。去年王思聰曬過這新寵之後,柯爾鴨迅速走紅。  比起自己養一隻,更多人會選擇擼一擼釋放「鴨力」。杭州武林路上就有這樣一家「擼鴨館」,開業沒多久就成為了杭州城裡的網紅店。
  • 噓,我已經瞞著開發解鎖APP日誌文件抓取及分析啦!
    主要包括APP日誌查看工具APP日誌文件分類APP日誌文件抓取詳解APP日誌相關面試題分享ddms監控系統或應用日誌、監控線程狀態、VM使用狀況(內存洩漏通過它來判斷)、模擬簡訊電話事件、生成logcat日誌、文件管理及截屏等功能。