简介:
通用日志里记录了,mysql每一个连接线程的执行情况和异常退出等信息,有助于分析代码执行流程。
配置介绍
#查看日志情况
show variables like '%general%';
#开启日志
SET GLOBAL general_log = 'On';
显示结果分析
2019-09-28T01:58:20.247567Z 33541 Query SET AUTOCOMMIT=0
2019-09-28T01:58:20.247698Z 33541 Query start transaction
2019-09-28T01:58:20.247822Z 33541 Query UPDATE node_products SET flag=0 WHERE uid='test_4'
2019-09-28T01:58:20.248208Z 33541 Query DELETE FROM node_global WHERE uid='test_4'
2019-09-28T01:58:20.248504Z 33541 Query COMMIT
2019-09-28T01:58:20.287023Z 33541 Query ROLLBACK
2019-09-28T01:58:20.291930Z 33542 Query SET AUTOCOMMIT=0
2019-09-28T01:58:20.292277Z 33542 Query start transaction
2019-09-28T01:58:20.292643Z 33542 Query UPDATE node_products SET flag=0 WHERE uid='test_5'
2019-09-28T01:58:20.293646Z 33542 Query DELETE FROM node_global WHERE uid='test_5'
2019-09-28T01:58:20.294296Z 33542 Query COMMIT
2019-09-28T01:58:20.337153Z 33542 Query ROLLBACK
2019-09-28T01:58:20.343315Z 33543 Query SET AUTOCOMMIT=0
2019-09-28T01:58:20.343756Z 33543 Query start transaction
2019-09-28T01:58:20.344051Z 33543 Query UPDATE node_products SET flag=0 WHERE uid='test_6'
2019-09-28T01:58:20.345202Z 33543 Query DELETE FROM node_global WHERE uid='test_6'
2019-09-28T01:58:20.345856Z 33543 Query COMMIT
2019-09-28T01:58:20.387181Z 33543 Query ROLLBACK
第一列:时间列,前面一个是日期,后面一个是小时和分钟,有一些不显示的原因是因为这些sql语句几乎是同时执行的,所以就不另外记录时间了.
第二列:ID列,就是show processlist出来的第一列的线程ID,对于长连接和一些比较耗时的sql语句,你可以精确找出究竟是那一条那一个线程在运行.
第三列:操作类型,Connect就是连接数据库,Query就是查询数据库(增删查改都显示为查询),可以特定过虑一些操作.
第四列:详细信息,
例如下面例子Connect的详细信息就是 root@localhost on kvdata,意思就是root@localhost连上kvdata库,如此类推,
2019-09-28T01:58:20.867646Z 33541 Query SET AUTOCOMMIT=0
2019-09-28T01:58:20.867903Z 33541 Query start transaction
2019-09-28T01:58:20.868216Z 33541 Query UPDATE node_products SET flag=0 WHERE uid='test_14'
2019-09-28T01:58:20.870254Z 33553 Connect root@localhost on kvdata using TCP/IP
2019-09-28T01:58:20.870560Z 33553 Query SET AUTOCOMMIT = 0
2019-09-28T01:58:20.870849Z 33541 Quit
2019-09-28T01:58:20.871027Z 33553 Query DELETE FROM node_global WHERE uid='test_14'
2019-09-28T01:58:20.871811Z 33553 Query COMMIT
与上面的显示分析比较,这里的数据库操作明显有问题,作为一个事务处理的语句被两个线程处理,且第一个线程退出后,第二个线程没有从第一条语句开始执行,造成了不可预知的错误。