spring+mybatis+log4j日志问题排查

一、问题概述：

1、在我们实际开发中，如果用到mybatis，必然会用到spring。那么针对mybatis,我们会选择什么日志呢？在实际开发项目中遇到了一个问题那就是，我选了log4j，但却没有mybatis的sql日志输出。

二、问题分析：

针对mybatis，我们来分析下他的日志选择规则。mybatis的日志创建在LogFactory.class的类下

static {
    tryImplementation(new Runnable() {
        public void run() {
            LogFactory.useSlf4jLogging();
        }
    });
    tryImplementation(new Runnable() {
        public void run() {
            LogFactory.useCommonsLogging();
        }
    });
    tryImplementation(new Runnable() {
        public void run() {
            LogFactory.useLog4J2Logging();
        }
    });
    tryImplementation(new Runnable() {
        public void run() {
            LogFactory.useLog4JLogging();
        }
    });
    tryImplementation(new Runnable() {
        public void run() {
            LogFactory.useJdkLogging();
        }
    });
    tryImplementation(new Runnable() {
        public void run() {
            LogFactory.useNoLogging();
        }
    });
}

上面贴了一个核心代码，第一个就是根据本地的jar,判断是否能加载Slf4j日志，如果能直接return,如果不能会循环的去创建，第二个是JCL,第三个是Log4j2,第三个是Log4j，第四个JUL,最后如果前面几个都没加载到，就使用System.out.println来完成打印。在我们没用使用spring的时候，项目中只引用了mybatis+Log4j的jar时，mybatis打印日志毫无疑问是选择Log4j来打印。但当我引入了spring5的时候，奇怪的事发生了，mybatis没有日志输出了，但spring有日志输出了。这就很奇怪了。

2、源码分析，在spring5+mybatis+Log4j项目中，当我们一启动，优先加载spring5,我们先看看spring5的日志创建规则。

一般日志的源码都在LogFactory.class类，spring也不例外。下面贴上spring包下的org.apache.commons.logging.LogFactory.class的核心代码。

public static Log getLog(String name) {
	switch (logApi) {
		case LOG4J:
			return Log4jDelegate.createLog(name);
		case SLF4J_LAL:
			return Slf4jDelegate.createLocationAwareLog(name);
		case SLF4J:
			return Slf4jDelegate.createLog(name);
		default:		
			return JavaUtilDelegate.createLog(name);
	}
}

当项目中拥有Log4j的时候，spring就会选择创建Log4j,进而spring选择Log4j来打印日志。注意了spring的Log这个类的全路径是org.apache.commons.logging.Log，下面看下在debug的时候userCommonsLoging为啥可以正常创建

useCommonsLogging方法的功能代码，

public static synchronized void useCommonsLogging() {
    setImplementation(JakartaCommonsLoggingImpl.class);
}

private static void setImplementation(Class<? extends Log> implClass) {
    try {
        Constructor<? extends Log> candidate = implClass.getConstructor(String.class);
        Log log = (Log)candidate.newInstance(LogFactory.class.getName());
        if (log.isDebugEnabled()) {
            log.debug("Logging initialized using '" + implClass + "' adapter.");
        }

        logConstructor = candidate;
    } catch (Throwable var3) {
        throw new LogException("Error setting Log implementation.  Cause: " + var3, var3);
    }
}

体面会通过反射执行JakartaCommonsLoggingImpl的构造方法。那么他的构造方法做了什么操作。

public JakartaCommonsLoggingImpl(String clazz) {
    log = LogFactory.getLog(clazz);
}

就通过LogFactory.getLog,也没啥特别的为啥会和Spring的org.apache.commons.logging.LogFactory关联上，我一直没注意看LogFactory.getLog这行代码中的LogFactory这个类型，发现他居然应用的是

但是就算选择spring5的JCL也应该没有问题，为啥没有打印日志了，这还得去看spring5的JCL底层是选择什么打印的。

原来spring5默认使用的JUL,但是我们本地不是有Log4j的包吗，为啥最终选了JUL来打印日志呢？这个我后面介绍，最终MyBatis+Spring5+Log4j，mybatis却选择Spring的JCl，而JCL里面却选用了JUL打印。而JUL的默认级别是Info级别，spring的sql日志需要的级别是Debug级别。