別在 Java 代碼里亂打日志了,這才是打印日志的正確姿勢!
小Hub領(lǐng)讀:
不同級別的日志應(yīng)該區(qū)分使用,另外用 [] 進(jìn)行參數(shù)變量隔離。
西格瑪?shù)牟┛?/span>
http://t.cn/E9BkD7a
使用 slf4j
使用門面模式的日志框架,有利于維護(hù)和各個類的日志處理方式統(tǒng)一
實現(xiàn)方式統(tǒng)一使用: Logback 框架
打日志的正確方式
什么時候應(yīng)該打日志
當(dāng)你遇到問題的時候,只能通過 debug 功能來確定問題,你應(yīng)該考慮打日志,良好的系統(tǒng),是可以通過日志進(jìn)行問題定為的。
當(dāng)你碰到 if…else 或者 switch 這樣的分支時,要在分支的首行打印日志,用來確定進(jìn)入了哪個分支
經(jīng)常以功能為核心進(jìn)行開發(fā),你應(yīng)該在提交代碼前,可以確定通過日志可以看到整個流程
基本格式
必須使用參數(shù)化信息的方式:
logger.debug("Processing trade with id:[{}] and symbol : [{}] ", id, symbol);
對于 debug 日志,必須判斷是否為 debug 級別后,才進(jìn)行使用:
if(logger.isDebugEnabled()) {
logger.debug("Processing trade with id: "+id + " symbol: "+ symbol);
}
不要進(jìn)行字符串拼接, 那樣會產(chǎn)生很多 String 對象,占用空間,影響性能。
反例 (不要這么做):
logger.debug("Processing trade with id: " + id + " symbol: " + symbol);
使用 [] 進(jìn)行參數(shù)變量隔離
如有參數(shù)變量,應(yīng)該寫成如下寫法:
logger.debug("Processing trade with id:[{}] and symbol : [{}] ", id, symbol);
這樣的格式寫法,可讀性更好,對于排查問題更有幫助。
不同級別的使用
ERROR:
基本概念
影響到程序正常運行、當(dāng)前請求正常運行的異常情況:
打開配置文件失敗
所有第三方對接的異常 (包括第三方返回錯誤碼)
所有影響功能使用的異常,包括: SQLException 和除了業(yè)務(wù)異常之外的所有異常 (RuntimeException 和 Exception)
不應(yīng)該出現(xiàn)的情況:
比如要使用 Azure 傳圖片,但是 Azure 未響應(yīng)
如果有 Throwable 信息,需要記錄完成的堆棧信息:
log.error("獲取用戶[{}]的用戶信息時出錯",userName,e);
說明
如果進(jìn)行了拋出異常操作,請不要記錄 error 日志,由最終處理方進(jìn)行處理:
反例 (不要這么做):
try{
....
}catch(Exception ex){
String errorMessage=String.format("Error while reading information of user [%s]",userName);
logger.error(errorMessage,ex);
thrownewUserServiceException(errorMessage,ex);
}
WARN
基本概念
不應(yīng)該出現(xiàn)但是不影響程序、當(dāng)前請求正常運行的異常情況:
有容錯機(jī)制的時候出現(xiàn)的錯誤情況
找不到配置文件,但是系統(tǒng)能自動創(chuàng)建配置文件
即將接近臨界值的時候,例如:
緩存池占用達(dá)到警告線
業(yè)務(wù)異常的記錄, 比如:
當(dāng)接口拋出業(yè)務(wù)異常時,應(yīng)該記錄此異常
INFO:
基本概念
系統(tǒng)運行信息
Service 方法中對于系統(tǒng) / 業(yè)務(wù)狀態(tài)的變更
主要邏輯中的分步驟
外部接口部分
客戶端請求參數(shù) (REST/WS)
調(diào)用第三方時的調(diào)用參數(shù)和調(diào)用結(jié)果
說明
1. 并不是所有的 service 都進(jìn)行出入口打點記錄, 單一、簡單 service 是沒有意義的 (job 除外, job 需要記錄開始和結(jié)束,)。
反例 (不要這么做):
publicList listByBaseType(Integer baseTypeId) {
log.info("開始查詢基地");
BaseExample ex=newBaseExample();
BaseExample.Criteria ctr = ex.createCriteria();
ctr.andIsDeleteEqualTo(IsDelete.USE.getValue());
Optionals.doIfPresent(baseTypeId, ctr::andBaseTypeIdEqualTo);
log.info("查詢基地結(jié)束");
return baseRepository.selectByExample(ex);
}
2.對于復(fù)雜的業(yè)務(wù)邏輯,需要進(jìn)行日志打點,以及埋點記錄,比如電商系統(tǒng)中的下訂單邏輯,以及 OrderAction 操作 (業(yè)務(wù)狀態(tài)變更)。
3. 對于整個系統(tǒng)的提供出的接口 (REST/WS),使用 info 記錄入?yún)?/p>
4. 如果所有的 service 為 SOA 架構(gòu),那么可以看成是一個外部接口提供方,那么必須記錄入?yún)ⅰ?/p>
5. 調(diào)用其他第三方服務(wù)時,所有的出參和入?yún)⑹潜仨氁涗浀?(因為你很難追溯第三方模塊發(fā)生的問題)
DEBUG
基本概念
可以填寫所有的想知道的相關(guān)信息 (但不代表可以隨便寫,debug 信息要有意義, 最好有相關(guān)參數(shù))
生產(chǎn)環(huán)境需要關(guān)閉 DEBUG 信息
如果在生產(chǎn)情況下需要開啟 DEBUG, 需要使用開關(guān)進(jìn)行管理,不能一直開啟。
說明
如果代碼中出現(xiàn)以下代碼,可以進(jìn)行優(yōu)化:
//1. 獲取用戶基本薪資
//2. 獲取用戶休假情況
//3. 計算用戶應(yīng)得薪資
優(yōu)化后的代碼:
logger.debug("開始獲取員工[{}] [{}]年基本薪資",employee,year);
logger.debug("獲取員工[{}] [{}]年的基本薪資為[{}]",employee,year,basicSalary);
logger.debug("開始獲取員工[{}] [{}]年[{}]月休假情況",employee,year,month);
logger.debug("員工[{}][{}]年[{}]月年假/病假/事假為[{}]/[{}]/[{}]",employee,year,month,annualLeaveDays,sickLeaveDays,noPayLeaveDays);
logger.debug("開始計算員工[{}][{}]年[{}]月應(yīng)得薪資",employee,year,month);
logger.debug("員工[{}] [{}]年[{}]月應(yīng)得薪資為[{}]",employee,year,month,actualSalary);
TRACE
基本概念
特別詳細(xì)的系統(tǒng)運行完成信息,業(yè)務(wù)代碼中,不要使用.(除非有特殊用意,否則請使用 DEBUG 級別替代)
規(guī)范示例說明
@Override
@Transactional
publicvoid createUserAndBindMobile(@NotBlankString mobile, @NotNullUser user) throwsCreateConflictException{
boolean debug = log.isDebugEnabled();
if(debug){
log.debug("開始創(chuàng)建用戶并綁定手機(jī)號. args[mobile=[{}],user=[{}]]", mobile, LogObjects.toString(user));
}
try{
user.setCreateTime(newDate());
user.setUpdateTime(newDate());
userRepository.insertSelective(user);
if(debug){
log.debug("創(chuàng)建用戶信息成功. insertedUser=[{}]",LogObjects.toString(user));
}
UserMobileRelationship relationship = newUserMobileRelationship();
relationship.setMobile(mobile);
relationship.setOpenId(user.getOpenId());
relationship.setCreateTime(newDate());
relationship.setUpdateTime(newDate());
userMobileRelationshipRepository.insertOnDuplicateKey(relationship);
if(debug){
log.debug("綁定手機(jī)成功. relationship=[{}]",LogObjects.toString(relationship));
}
log.info("創(chuàng)建用戶并綁定手機(jī)號. userId=[{}],openId=[{}],mobile=[{}]",user.getId(),user.getOpenId(),mobile);
}catch(DuplicateKeyException e){
log.info("創(chuàng)建用戶并綁定手機(jī)號失敗,已存在相同的用戶. openId=[{}],mobile=[{}]",user.getOpenId(),mobile);
thrownewCreateConflictException("創(chuàng)建用戶發(fā)生沖突, openid=[%s]",user.getOpenId());
}
}

