上一篇我们介绍了Mybatis中的参数，本篇我们使用JDK Log打印一下Mybatis运行时的日志，看一下Mybatis执行的过程。
这里我选取上一篇的示例进行JDK Log的集成，这里如果您想对上一篇进行详细了解，可以参考：
Mybatis参数(parameterType)
https://blog.csdn.net/m1729339749/article/details/132548838
一、配置Mybatis
在mybatis-config.xml文件中配置logImpl
<?xml version="1.0" encoding="UTF-8" ?>
<!DOCTYPE configuration
PUBLIC "-//mybatis.org//DTD Config 3.0//EN"
"http://mybatis.org/dtd/mybatis-3-config.dtd">
<configuration>
<settings>
<setting name="logImpl" value="JDK_LOGGING"/>
</settings>
<environments default="development">
<environment id="development">
<transactionManager type="JDBC"/>
<dataSource type="POOLED">
<property name="driver" value="org.gjt.mm.mysql.Driver"/>
<property name="url" value="jdbc:mysql://localhost:3306/demo?useUnicode=true&useSSL=false&characterEncoding=utf8"/>
<property name="username" value="root"/>
<property name="password" value="horse"/>
</dataSource>
</environment>
</environments>
<mappers>
<mapper resource="demo/UserInfoMapper.xml" />
</mappers>
</configuration>
在配置文件中，我们配置了logImpl，值配置成了JDK_LOGGING，代表的是使用JDK提供的日志系统
二、JDK日志配置
在resources目录下新建logging.properties配置文件
handlers=java.util.logging.ConsoleHandler
.level=FINER
java.util.logging.ConsoleHandler.level=ALL
java.util.logging.ConsoleHandler.formatter=java.util.logging.SimpleFormatter
java.util.logging.SimpleFormatter.format=%1$tY-%1$tm-%1$td %1$tT.%1$tL %4$s %3$s - %5$s%6$s%n
handlers：代表的是日志处理器，java.util.logging.ConsoleHandler处理器用于直接在控制台打印日志
.level：代表的是全局日志级别
java.util.logging.ConsoleHandler.level：设置的是处理器需要处理的日志级别
java.util.logging.ConsoleHandler.formatter：设置的是处理器打印日志使用的格式化器
java.util.logging.SimpleFormatter.format：设置的是处理器打印日志的格式
1$：代表的是执行时间
2$：代表的是调用源（Jdk Log的调用源都为Jdk14LoggingImpl）
3$：代表的是日志名称
4$：代表的是日志级别
5$：代表的是日志内容
6$：代表的是异常信息
格式的定义需要参考java.util.Formatter类
三、引入日志配置
JDK Log提供了两种引入日志配置的方式：
1、class配置
我们在cn.horse.demo下新建JdkLogConfig类
JdkLogConfig类：
package cn.horse.demo;
import java.io.IOException;
import java.io.InputStream;
import java.util.logging.LogManager;
public class JdkLogConfig {
public JdkLogConfig() {
try {
InputStream inputStream = ClassLoader.getSystemClassLoader().getResourceAsStream("logging.properties");
LogManager.getLogManager().readConfiguration(inputStream);
} catch (IOException e) {
throw new RuntimeException(e);
}
}
}
在程序入口(main方法)配置系统属性：
System.setProperty("java.util.logging.config.class", "cn.horse.demo.JdkLogConfig");或者在运行时配置VM参数：
-Djava.util.logging.config.class=cn.horse.demo.JdkLogConfig
class配置方式更加灵活，配置来源更加多样化，例如可以从Mysql、ldap等库中读取
2、file配置(不建议使用)
在程序入口(main方法)配置系统属性：
System.setProperty("java.util.logging.config.file", "日志配置文件的绝对路径（不能包含中文、空格）");或者在运行时配置VM参数：
-Djava.util.logging.config.file=日志配置文件的绝对路径（不能包含中文、空格）
四、示例测试
测试：
这里我们查询年龄大于21岁的所有用户
StatementUtils.find("cn.horse.demo.UserInfoMapper.findByAge", 21);执行的结果如下：
2023-08-29 16:11:27.767 详细 org.apache.ibatis.logging.LogFactory - Logging initialized using 'class org.apache.ibatis.logging.jdk14.Jdk14LoggingImpl' adapter.
2023-08-29 16:11:27.843 详细 org.apache.ibatis.logging.LogFactory - Logging initialized using 'class org.apache.ibatis.logging.jdk14.Jdk14LoggingImpl' adapter.
2023-08-29 16:11:27.854 详细 org.apache.ibatis.datasource.pooled.PooledDataSource - PooledDataSource forcefully closed/removed all connections.
2023-08-29 16:11:27.855 详细 org.apache.ibatis.datasource.pooled.PooledDataSource - PooledDataSource forcefully closed/removed all connections.
2023-08-29 16:11:27.855 详细 org.apache.ibatis.datasource.pooled.PooledDataSource - PooledDataSource forcefully closed/removed all connections.
2023-08-29 16:11:27.855 详细 org.apache.ibatis.datasource.pooled.PooledDataSource - PooledDataSource forcefully closed/removed all connections.
2023-08-29 16:11:27.900 详细 org.apache.ibatis.transaction.jdbc.JdbcTransaction - Opening JDBC Connection
2023-08-29 16:11:28.058 详细 org.apache.ibatis.datasource.pooled.PooledDataSource - Created connection 1379435698.
2023-08-29 16:11:28.059 详细 org.apache.ibatis.transaction.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [com.mysql.jdbc.JDBC4Connection@523884b2]
2023-08-29 16:11:28.062 详细 cn.horse.demo.UserInfoMapper.findByAge - ==> Preparing: SELECT ID, USERNAME name, AGE FROM T_USER WHERE AGE > ?
2023-08-29 16:11:28.094 详细 cn.horse.demo.UserInfoMapper.findByAge - ==> Parameters: 21(Integer)
2023-08-29 16:11:28.105 较详细 cn.horse.demo.UserInfoMapper.findByAge - <== Columns: ID, name, AGE
2023-08-29 16:11:28.106 较详细 cn.horse.demo.UserInfoMapper.findByAge - <== Row: 2, 李四, 22
2023-08-29 16:11:28.108 较详细 cn.horse.demo.UserInfoMapper.findByAge - <== Row: 3, 王五, 24
2023-08-29 16:11:28.109 详细 cn.horse.demo.UserInfoMapper.findByAge - <== Total: 2
2023-08-29 16:11:28.110 详细 org.apache.ibatis.transaction.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [com.mysql.jdbc.JDBC4Connection@523884b2]
2023-08-29 16:11:28.113 详细 org.apache.ibatis.transaction.jdbc.JdbcTransaction - Closing JDBC Connection [com.mysql.jdbc.JDBC4Connection@523884b2]
2023-08-29 16:11:28.114 详细 org.apache.ibatis.datasource.pooled.PooledDataSource - Returned connection 1379435698 to pool.
{id: 2, name: 李四, age: 22}
{id: 3, name: 王五, age: 24}
在日志中我们可以看到预处理SQL语句，传递参数，返回的查询结果
2023-08-29 16:11:28.062 详细 cn.horse.demo.UserInfoMapper.findByAge - ==> Preparing: SELECT ID, USERNAME name, AGE FROM T_USER WHERE AGE > ?
2023-08-29 16:11:28.094 详细 cn.horse.demo.UserInfoMapper.findByAge - ==> Parameters: 21(Integer)
2023-08-29 16:11:28.105 较详细 cn.horse.demo.UserInfoMapper.findByAge - <== Columns: ID, name, AGE
2023-08-29 16:11:28.106 较详细 cn.horse.demo.UserInfoMapper.findByAge - <== Row: 2, 李四, 22
2023-08-29 16:11:28.108 较详细 cn.horse.demo.UserInfoMapper.findByAge - <== Row: 3, 王五, 24
2023-08-29 16:11:28.109 详细 cn.horse.demo.UserInfoMapper.findByAge - <== Total: 2
预处理：Preparing: SELECT ID, USERNAME name, AGE FROM T_USER WHERE AGE > ?
传递参数：Parameters: 21(Integer)
查询结果：Columns: ID, name, AGE
Row: 2, 李四, 22
Row: 3, 王五, 24
Total: 2
五、日志筛选
上面的日志信息打印了全部的详细日志记录，但是我只对SQL语句执行的过程比较关心，其他不相关的信息只会造成干扰，我们需要修改日志的配置，才能输出我们想要的日志信息：
handlers=java.util.logging.ConsoleHandler
.level=INFO
cn.horse.demo.UserInfoMapper.level=FINER
java.util.logging.ConsoleHandler.level=ALL
java.util.logging.ConsoleHandler.formatter=java.util.logging.SimpleFormatter
java.util.logging.SimpleFormatter.format=%1$tY-%1$tm-%1$td %1$tT.%1$tL %4$s %3$s - %5$s%6$s%n将全局的日志级别设置为INFO, 将日志名称以cn.horse.demo.UserInfoMapper命名空间开头的日志级别设置为FINER
测试：
这里我们查询年龄大于21岁的所有用户
StatementUtils.find("cn.horse.demo.UserInfoMapper.findByAge", 21);执行的结果如下：
详细日志中只保留了SQL执行的过程
