회사의 요구 사항 중 하나는 회사의 기존 링크 추적 로그 구성 요소가 MySQL의 SQL 실행 시간 인쇄를 지원해야 한다는 것입니다. 링크 추적을 구현하는 일반적인 방법은 타사 프레임워크 또는 도구에서 제공하는 인터셉터 인터페이스 또는 필터를 구현하는 것입니다. 인터셉터 인터페이스는 MySQL에서도 예외는 아닙니다. 실제로는 MySQL에 의해 구동되는 인터셉터 인터페이스를 구현합니다.
MySQL 채널마다 버전이 다르고 버전별로 인터셉터 인터페이스가 다르기 때문에 사용 중인 MySQL 드라이버의 버전에 따라 응답 인터셉터를 구현해야 합니다. 다음으로 MySQL에 대해 소개하겠습니다. 버전 5, 6, 8의 구현 방법을 별도로 확인하세요.
여기에서는 StatementInterceptorV2 인터페이스를 구현하기 위한 예로 MySQL 채널 버전 5.1.18을 사용합니다. 주요 구현 논리는 preProcess 및 postProcess에 있습니다. 메소드. 이 두 메소드는 sql이 실행되기 전과 후에 실행되는 메소드입니다. 여기서는 MDC를 사용하여 sql이 실행되기 전의 타임스탬프를 기록합니다. postProcess 메소드 MDC .put("sql_exec_time", start);, ThreadLocal을 사용하여 구현한 다음 MDC.get("sql_exec_time")을 사용할 수도 있습니다. <code>postProcess 메소드 코드>에서 SQL 실행 전 기록된 시간을 꺼내고, 마지막으로 현재 타임스탬프에서 SQL 실행 전 시간을 빼서 SQL 실행 시간을 계산합니다. StatementInterceptorV2接口，主要实现逻辑在preProcess和postProcess方法，这两个方法是sql执行前后要执行的方法，我所使用的框架是logback，这里使用MDC来记录sql执行前的一个时间戳，代码在postProcess方法MDC.put("sql_exec_time", start);，自己也可以使用ThreadLocal等来实现，然后在postProcess方法中使用MDC.get("sql_exec_time")将记录的sql执行前的时间取出来，最后再用当前时间戳减去sql执行前的时间，就算出了sql执行的时间。
import static net.logstash.logback.marker.Markers.append;
import com.mysql.jdbc.Connection;
import com.mysql.jdbc.ResultSetInternalMethods;
import com.mysql.jdbc.Statement;
import com.mysql.jdbc.StatementInterceptorV2;
import com.redick.util.LogUtil;
import java.sql.SQLException;
import java.util.Properties;
import lombok.extern.slf4j.Slf4j;
import org.slf4j.MDC;
/**
* @author Redick01
*/
@Slf4j
public class Mysql5StatementInterceptor implements StatementInterceptorV2 {
@Override
public void init(Connection connection, Properties properties) throws SQLException {
}
@Override
public ResultSetInternalMethods preProcess(String s, Statement statement, Connection connection)
throws SQLException {
String start = String.valueOf(System.currentTimeMillis());
MDC.put("sql_exec_time", start);
log.info(LogUtil.customizeMarker(LogUtil.kLOG_KEY_TRACE_TAG, "sql_exec_before"), "开始执行sql");
return null;
}
@Override
public boolean executeTopLevelOnly() {
return false;
}
@Override
public void destroy() {
}
@Override
public ResultSetInternalMethods postProcess(String s, Statement statement,
ResultSetInternalMethods resultSetInternalMethods, Connection connection, int i,
boolean b, boolean b1, SQLException e) throws SQLException {
long start = Long.parseLong(MDC.get("sql_exec_time"));
long end = System.currentTimeMillis();
log.info(LogUtil.customizeMarker(LogUtil.kLOG_KEY_TRACE_TAG, "sql_exec_after")
.and(append(LogUtil.kLOG_KEY_SQL_EXEC_DURATION, end - start)), "结束执行sql");
return null;
}
}MySQL6和MySQL5基本一样，只是接口不是同一个，直接放代码
import static net.logstash.logback.marker.Markers.append;
import com.mysql.cj.api.MysqlConnection;
import com.mysql.cj.api.jdbc.Statement;
import com.mysql.cj.api.jdbc.interceptors.StatementInterceptor;
import com.mysql.cj.api.log.Log;
import com.mysql.cj.api.mysqla.result.Resultset;
import com.redick.util.LogUtil;
import java.sql.SQLException;
import java.util.Properties;
import lombok.extern.slf4j.Slf4j;
import org.slf4j.MDC;
/**
* @author Redick01
*/
@Slf4j
public class Mysql6StatementInterceptor implements StatementInterceptor {
@Override
public StatementInterceptor init(MysqlConnection mysqlConnection, Properties properties,
Log log) {
return null;
}
@Override
public <T extends Resultset> T preProcess(String s, Statement statement) throws SQLException {
String start = String.valueOf(System.currentTimeMillis());
MDC.put("sql_exec_time", start);
log.info(LogUtil.customizeMarker(LogUtil.kLOG_KEY_TRACE_TAG, "sql_exec_before"), "开始执行sql");
return null;
}
@Override
public boolean executeTopLevelOnly() {
return false;
}
@Override
public void destroy() {
}
@Override
public <T extends Resultset> T postProcess(String s, Statement statement, T t, int i, boolean b,
boolean b1, Exception e) throws SQLException {
long start = Long.parseLong(MDC.get("sql_exec_time"));
long end = System.currentTimeMillis();
log.info(LogUtil.customizeMarker(LogUtil.kLOG_KEY_TRACE_TAG, "sql_exec_after")
.and(append(LogUtil.kLOG_KEY_SQL_EXEC_DURATION, end - start)), "结束执行sql");
return null;
}
}MySQL8和MySQL5/6的拦截器接口又不一样了，MySQL8的拦截器接口是com.mysql.cj.interceptors.QueryInterceptor，统计sql执行时间的方式还是一样的，代码如下：
import static net.logstash.logback.marker.Markers.append;
import com.mysql.cj.MysqlConnection;
import com.mysql.cj.Query;
import com.mysql.cj.interceptors.QueryInterceptor;
import com.mysql.cj.log.Log;
import com.mysql.cj.protocol.Resultset;
import com.mysql.cj.protocol.ServerSession;
import com.redick.util.LogUtil;
import java.util.Properties;
import java.util.function.Supplier;
import lombok.extern.slf4j.Slf4j;
import org.slf4j.MDC;
/**
* @author Redick01
*/
@Slf4j
public class Mysql8QueryInterceptor implements QueryInterceptor {
@Override
public QueryInterceptor init(MysqlConnection mysqlConnection, Properties properties, Log log) {
return null;
}
@Override
public <T extends Resultset> T preProcess(Supplier<String> supplier, Query query) {
String start = String.valueOf(System.currentTimeMillis());
MDC.put("sql_exec_time", start);
log.info(LogUtil.customizeMarker(LogUtil.kLOG_KEY_TRACE_TAG, "sql_exec_before"), "开始执行sql");
return null;
}
@Override
public boolean executeTopLevelOnly() {
return false;
}
@Override
public void destroy() {
}
@Override
public <T extends Resultset> T postProcess(Supplier<String> supplier, Query query, T t,
ServerSession serverSession) {
long start = Long.parseLong(MDC.get("sql_exec_time"));
long end = System.currentTimeMillis();
log.info(LogUtil.customizeMarker(LogUtil.kLOG_KEY_TRACE_TAG, "sql_exec_after")
.and(append(LogUtil.kLOG_KEY_SQL_EXEC_DURATION, end - start)), "结束执行sql");
return null;
}
}MySQL5和6的使用方式一样，在数据库链接的url中增加如下statementInterceptors参数，例如：
url: jdbc:mysql://127.0.0.1:3316/log-helper?useUnicode=true&characterEncoding=UTF8&statementInterceptors=com.redick.support.mysql.Mysql5StatementInterceptor&serverTimezone=CST
MySQL8则是在url中增加queryInterceptors
url: jdbc:mysql://127.0.0.1:3316/log-helper?useUnicode=true&characterEncoding=UTF8&queryInterceptors=com.redick.support.mysql.Mysql8QueryInterceptor&serverTimezone=CST
{"@timestamp":"2023-02-28T17:16:29.234+08:00","@version":"0.0.1","message":"开始执行sql","logger_name":"com.redick.support.mysql.Mysql5StatementInterceptor","thread_name":"http-nio-3321-exec-4","level":"INFO","level_value":20000,"traceId":"9ed930dc-4cc6-4719-bf33-9fcb618fd65b","spanId":"1","request_type":"getName","parentId":"0","trace_tag":"sql_exec_before"} com.mysql.cj.interceptors.QueryInterceptor이며 SQL 실행 시간을 계산하는 방법은 여전히 동일하며 코드는 다음과 같습니다. 🎜{"@timestamp":"2023-02-28T17:16:29.237+08:00","@version":"0.0.1","message":"结束执行sql","logger_name":"com.redick.support.mysql.Mysql5StatementInterceptor","thread_name":"http-nio-3321-exec-4","level":"INFO","level_value":20000,"traceId":"9ed930dc-4cc6-4719-bf33-9fcb618fd65b","spanId":"1","request_type":"getName","parentId":"0","trace_tag":"sql_exec_after","sql_duration":3}statementInterceptors 매개변수의 URL에 다음을 추가합니다. 예: 🎜rrreee🎜MySQL8은 URL에 queryInterceptors 매개변수를 추가합니다. 예: 🎜rrreee 🎜테스트 결과🎜🎜sql 실행 전 로그🎜rrreee🎜sql 실행 로그 후 sql_duration 플래그가 sql🎜rrreee를 실행하는 데 3ms가 걸립니다.위 내용은 Java는 MySQL 드라이버 인터셉터를 어떻게 사용하여 SQL 시간이 많이 소요되는 계산을 구현합니까?의 상세 내용입니다. 자세한 내용은 PHP 중국어 웹사이트의 기타 관련 기사를 참조하세요!
![[웹 프런트엔드] Node.js 빠른 시작](https://img.php.cn/upload/course/000/000/067/662b5d34ba7c0227.png)
