作者:何甜甜在嗎 鏈接:https://juejin.im/post/5d4d61326fb9a06aff5e5ff5
通過閱讀本篇文章將了解到
- 1.日志輸出到文件并根據(jù)LEVEL級(jí)別將日志分類保存到不同文件
- 2.通過異步輸出日志減少磁盤IO提高性能
- 3.異步輸出日志的原理
配置文件logback-spring.xml
SpringBoot工程自帶logback和slf4j的依賴,所以重點(diǎn)放在編寫配置文件上,需要引入什么依賴,日志依賴沖突統(tǒng)統(tǒng)都不需要我們管了。logback框架會(huì)默認(rèn)加載classpath下命名為logback-spring或logback的配置文件。將所有日志都存儲(chǔ)在一個(gè)文件中文件大小也隨著應(yīng)用的運(yùn)行越來越大并且不好排查問題,正確的做法應(yīng)該是將error日志和其他日志分開,并且不同級(jí)別的日志根據(jù)時(shí)間段進(jìn)行記錄存儲(chǔ)。
部分標(biāo)簽說明
- <root>標(biāo)簽,必填標(biāo)簽,用來指定最基礎(chǔ)的日志輸出級(jí)別
- <Appender-ref>標(biāo)簽,添加append
- <append>標(biāo)簽,通過使用該標(biāo)簽指定日志的收集策略
- name屬性指定appender命名
- class屬性指定輸出策略,通常有兩種,控制臺(tái)輸出和文件輸出,文件輸出就是將日志進(jìn)行一個(gè)持久化。ConsoleAppender將日志輸出到控制臺(tái)
- <filter>標(biāo)簽,通過使用該標(biāo)簽指定過濾策略
- <level>標(biāo)簽指定過濾的類型
- <encoder>標(biāo)簽,使用該標(biāo)簽下的<pattern>標(biāo)簽指定日志輸出格式
- <rollingPolicy>標(biāo)簽指定收集策略,比如基于時(shí)間進(jìn)行收集
- <fileNamePattern>標(biāo)簽指定生成日志保存地址 通過這樣配置已經(jīng)實(shí)現(xiàn)了分類分天手機(jī)日志的目標(biāo)了
logback 高級(jí)特性異步輸出日志
之前的日志配置方式是基于同步的,每次日志輸出到文件都會(huì)進(jìn)行一次磁盤IO。采用異步寫日志的方式而不讓此次寫日志發(fā)生磁盤IO,阻塞線程從而造成不必要的性能損耗。異步輸出日志的方式很簡(jiǎn)單,添加一個(gè)基于異步寫日志的appender,并指向原先配置的appender即可
異步輸出日志性能測(cè)試
既然能提高性能的話,必須進(jìn)行一次測(cè)試比對(duì),同步和異步輸出日志性能到底能提升多少倍?
服務(wù)器硬件
- CPU 六核
- 內(nèi)存 8G
測(cè)試工具
Apache Jmeter
同步輸出日志
- 線程數(shù):100
- Ramp-Up Loop(可以理解為啟動(dòng)線程所用時(shí)間) :0 可以理解為100個(gè)線程同時(shí)啟用
- 測(cè)試結(jié)果
- 重點(diǎn)關(guān)注指標(biāo)Throughput【TPS】吞吐量:系統(tǒng)在單位時(shí)間內(nèi)處理請(qǐng)求的數(shù)量,在同步輸出日志中TPS為44.2/sec
異步輸出日志
- 線程數(shù) 100
- Ramp-Up Loop:0
- 測(cè)試結(jié)果
- TPS為497.5/sec,性能提升了10多倍!!!
異步日志輸出原理
從logback框架下的Logger.info方法開始追蹤。一路的方法調(diào)用路徑如下圖所示:
異步輸出日志中最關(guān)鍵的就是配置文件中ch.qos.logback.classic包下AsyncAppenderBase類中的append方法,查看該方法的源碼:
protected void append(E eventObject) {
if(!this.isQueueBelowDiscardingThreshold() || !this.isDiscardable(eventObject)) {
this.preprocess(eventObject);
this.put(eventObject);
}
}
通過隊(duì)列情況判斷是否需要丟棄日志,不丟棄的話將它放到阻塞隊(duì)列中,通過查看代碼,這個(gè)阻塞隊(duì)列為ArrayBlockingQueueu,默認(rèn)大小為256,可以通過配置文件進(jìn)行修改。Logger.info(...)到append(...)就結(jié)束了,只做了將日志塞入到阻塞隊(duì)列的事,然后繼續(xù)執(zhí)行Logger.info(...)下面的語句了。在AsyncAppenderBase類中定義了一個(gè)Worker線程,run方法中的關(guān)鍵部分代碼如下:
E e = parent.blockingQueue.take();
aai.appendLoopOnAppenders(e);
從阻塞隊(duì)列中取出一個(gè)日志,并調(diào)用AppenderAttachableImpl類中的appendLoopOnAppenders方法維護(hù)一個(gè)Append列表。Worker線程中調(diào)用方法過程主要如下圖:
最主要的兩個(gè)方法就是encode和write方法,前一個(gè)法方會(huì)根據(jù)配置文件中encode指定的方式轉(zhuǎn)化為字節(jié)碼,后一個(gè)方法將轉(zhuǎn)化成的字節(jié)碼寫入到文件中去。所以寫文件是通過新起一個(gè)線程去完成的,主線程將日志扔到阻塞隊(duì)列中,然后又去做其他事情了。
項(xiàng)目完整代碼:https://github.com/TiantianUpup/springboot-log






