slf4j中MDC是什么鬼
slf4j除了trace、debug、info、warn、error這幾個日志接口外,還可以配合MDC將數據寫入日志。換句話說MDC也是用來記錄日志的,但它的使用方式與使用日志接口不同。
在使用日志接口時我們一般這么做
Logger LOG = LoggerFactory.getLogger("LOGNAME_OR_CLASS"); if(LOG.isDebugEnabled()) { LOG.debug("log debug"); }
MDC從使用方式上有些不同,我對它的理解是MDC可以將一個處理線程中你想體現在日志文件中的數據統一管理起來,根據你的日志文件配置決定是否輸出。
比如以下但不限於以下場景可以考慮使用MDC來達到目的
- 我們想在日志中體現請求用戶IP地址
- 用戶使用http客戶端的user-agent
- 記錄一次處理線程的日志跟蹤編號(這個編號目的是為了查詢日志方便,結合grep命令能根據跟蹤編號將本次的處理日志全部輸出)
MDC的使用
org.slf4j.MDC我個人會用AOP或Filter或Interceptor這類工具配合使用,獲得你希望輸出到日志的變量並調用MDC.put(String key, String val),比如下面代碼片段第5行:
@Around(value = "execution(* com.xx.xx.facade.impl.*.*(..))", argNames="pjp") public Object validator(ProceedingJoinPoint pjp) throws Throwable { try { String traceId = TraceUtils.begin(); MDC.put("mdc_trace_id", traceId); Object obj = pjp.proceed(args); return obj; } catch(Throwable e) { //TODO 處理錯誤 } finally { TraceUtils.endTrace(); } }
代碼通過AOP記錄了每次請求的traceId並使用變量"mdc_trace_id"記錄,在日志配置文件里需要設置變量才能將"mdc_trace_id"輸出到日志文件中。我以logback配置文件為例,看日志第10行%X{mdc_trace_id}:
<appender name="ALL" class="ch.qos.logback.core.rolling.RollingFileAppender">
<file>${CATALINA_BASE}/logs/all.log</file>
<rollingPolicy class="ch.qos.logback.core.rolling.TimeBasedRollingPolicy">
<!-- daily rollover -->
<fileNamePattern>${CATALINA_BASE}/logs/all.%d{yyyy-MM-dd}.log</fileNamePattern>
<!-- keep 30 days' worth of history -->
<maxHistory>30</maxHistory>
</rollingPolicy>
<encoder charset="UTF-8">
<pattern>%d{yyyy-MM-dd HH:mm:ss.SSS} [%thread] %-5level %logger{36} - traceId:[%X{mdc_trace_id}] - %msg%n</pattern>
</encoder>
</appender>
MDC帶來的好處
- 如果你的系統已經上線,突然有一天老板說我們增加一些用戶數據到日志里分析一下。如果沒有MDC我猜此時此刻你應該處於雪崩狀態。MDC恰到好處的讓你能夠實現在日志上突如其來的一些需求
- 如果你是個代碼潔癖,封裝了公司LOG的操作,並且將處理線程跟蹤日志號也封裝了進去,但只有使用了你封裝日志工具的部分才能打印跟蹤日志號,其他部分(比如hibernate、mybatis、httpclient等等)日志都不會體現跟蹤號。當然我們可以通過linux命令來繞過這些困擾。
- 使代碼簡潔、日志風格統一