場景:
String token = md5.substring(0, 10) + base64Two + md5.substring(10); if (logger.isDebugEnabled()) { logger.debug("[op:genShareToken] userId={}, token={}", userId, token); } return token;
且看isDebugEnabled()的源碼:
public boolean isDebugEnabled() { if(repository.isDisabled( Level.DEBUG_INT)) return false; return Level.DEBUG.isGreaterOrEqual(this.getEffectiveLevel()); }
以下是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); } }
假設我們的日志級別設置為info,debug()方法調用后會判斷if(repository.isDisabled(Level.DEBUG_INT))
,然后return。但是在調用debug()方法時,必須先提供參數。要獲得參數,getTotalMoney()方法返回的結果就是參數的一部分,就需要執行getTotalMoney()並拼接,。假設這個獲取參數的過程需要10秒鍾,則系統會在花費10秒后決定return,這顯然很得不償失。
如果並發數大的話,這樣寫還是會影響系統的性能的。這個時候,就應該寫成:
if(logger.isDebugEnabled()){
logger.debug("The money is " + getTotalMoney());
}
如果debug的參數很簡單的話,也可以直接寫 logger.debug(message)的。官方的說法,執行一次logger.isDebugEnabled()這樣的判斷花費的時間大概是寫日志時間的萬分之一.雖然這個比例很小, 但是,程序中的任何地方放到並發的環境下,我們就得重新考慮了。