一、慢查询

在我们的项目中, 有很多需要优化的sql语句, 比如多表连接查询, 通常很耗时, 那么怎么知道哪些sql很耗时从而有针对性地进行优化呢

mysql提供了记录慢查询日志的功能, 通过记录sql语句中超过指定阈值的查询语句, 找到耗时的sql, 从而对这些语句进行分析和优化

例如: 我们设置阈值为1s, 当某条sql语句的执行时间超过了1s, 那么这条语句就会被写入到慢查询配置的日志文件中

二、查看mysql慢查询功能的开启状态

  1. 查看是否已开启: show variables like '%slow_query%'



  2. mysql 慢查询每日汇报与分析_mysql


    image.png


可以看到, 已经开启了

  • slow_query_log: 是否开启慢日志查询功能, ON开启, OFF关闭
  • slow_query_log_file: 慢查询日志的记录文件
  1. 查看阈值: show variables like '%long_query_time%'



  2. mysql 慢查询每日汇报与分析_慢查询_02


    image.png


  • long_query_time: 慢查询日志的时间阈值, 当超过这个阈值时, 慢日志才会被记录, 配置的值可以为0(任何的sql语句都记录下来), 或者>0(具体的阈值), 该配置项是以秒为单位的, 并且可以设置为小数

我这里已经修改为0了, 即所有语句都将记录到日志文件, 默认为10s

三、如何开启慢查询

有2种方式

  1. 临时开启, mysql重启后失效


set global slow_query_log = ON;
set global long_query_time = 0;
  • 1.
  • 2.
  1. 永久开启, 通过修改配置文件, 永久生效
    找到my.ini配置文件, 修改:


slow-query-log=1
slow_query_log_file="C:/ProgramData/MySQL/MySQL Server 5.7/slow_query_log/WANGZAIPLUS-slow.log"
long_query_time=0
  • 1.
  • 2.
  • 3.

说明:

  • slow-query-log=1: 1表示开启, 0表示关闭
  • slow_query_log_file: 即日志文件保存路径, 自己指定即可
  • long_query_time=0: 为了测试, 修改为0, 记录所有, 具体阈值根据项目实际情况设定
  • 关于mysql配置文件位置, windows系统是my.ini, 文件位置: C:\Program Files\MySQL\MySQL Server 5.7C:\ProgramData\MySQL\MySQL Server 5.7
  • linux系统是my.cnf, 文件位置: /etc/my.cnf
  1. 修改配置文件后, 需要重启mysql

四、查看慢查询日志文件

重启mysql后, 找到slow_query_log_file配置的日志文件, 由于阈值为0, 里面记录了所有sql, 测试一下, 写一个查询语句

mysql 慢查询每日汇报与分析_mysql_03

image.png

再看log文件, 记录了一模一样的sql语句


image.png

简单解释下

  • # Time: sql执行的时间, 也是该日志记录的时间
  • # User@Host: 登录用户的连接信息, 用户和主机
  • 第三行:
    Query_time: sql执行消耗的时间
    Lock_time: 锁表的时间
    Rows_sent: 返回的行数
    Rows_examined: 扫描的行数
  • SET timestamp=1568771109;: 设置时间戳
  • SELECT id, username ...: 执行的sql语句

五、通过mysqldumpslow工具分析慢查询日志

1、安装perl环境

通过-slow.log日志文件可以看到, 每一条sql都用这样的格式记录着, 随着sql越来越多, 到时肯定看的眼花缭乱, 所以, 我们可以借助mysql提供的mysqldumpslow工具对慢查询日志进行统计和分析

找到mysql安装目录下的bin目录, 有一个mysqldumpslow.pl文件, 这是一个perl文件

image.png

运行它需要perl环境, 所以, 先安装环境, 具体安装教程可参考菜鸟教程:  https://www.runoob.com/perl/perl-environment.html

我用的是windows系统, 直接通过:  http://strawberryperl.com/下载perl文件安装就行了, 环境变量也自动配置好了

安装完成后查看: perl -version

mysql 慢查询每日汇报与分析_mysql_04

image.png

搞定

2、运行mysqldumpslow.pl工具分析慢查询日志

首先说明各个文件路径

  • mysql安装目录: C:\Program Files\MySQL\MySQL Server 5.7\
  • 慢查询日志文件保存目录: C:\ProgramData\MySQL\MySQL Server 5.7\slow_query_log\

进入到mysql安装目录下的bin目录: cd /d C:\Program Files\MySQL\MySQL Server 5.7\bin

运行命令: mysqldumpslow.pl -a -s at C:\ProgramData\MySQL\MySQL Server 5.7\slow_query_log\WANGZAIPLUS-slow.log > C:\Users\wangzaiplus\Desktop\slow.txt

运行命令说明:

  • 格式: mysqldumpslow.pl + 输出参数 + 慢查询日志路径 + 文件保存路径
  • 输出参数说明: -a: 禁止将sql中参数转换为NS, 如不加此参数, 类似于select * from user where username = 'wangzai'中的参数wangzai就会直接被替换为S, 即: select * from user where username = 'S'
  • -s at: -s: 排序, a: 倒序, t: 执行时间, 合起来就是按sql的执行时间倒序排序
  • 参数还有很多, 可以通过mysqldumpslow.pl --help查看

运行后发现出错, 如下图:

mysql 慢查询每日汇报与分析_MySQL_05

image.png

原因: 慢查询日志文件C:\ProgramData\MySQL\MySQL Server 5.7\slow_query_log\WANGZAIPLUS-slow.log路径包含空格... 找不到该文件, 坑, 将-slow.log文件保存到一个不含空格的目录就行了, 如:
D:\WANGZAIPLUS-slow.log, 或者, 最好的是在my.ini文件指定slow_query_log_file时不要包含空格

再来执行一遍: mysqldumpslow.pl -a -s at D:\WANGZAIPLUS-slow.log > C:\Users\wangzaiplus\Desktop\slow.txt

mysql 慢查询每日汇报与分析_慢查询_06

image.png

执行成功, 桌面也生成了slow.txt文件

3、分析slow.txt文件

查看slow.txt文件, 如图

mysql 慢查询每日汇报与分析_慢查询_07

image.png

说明:

  • Count: 6: 该sql执行了多少次
  • Time=12.42s: 每次执行消耗的时间
  • (74s): 总共执行的时间
  • Lock=0.00s (0s): 锁表的时间
  • Rows=36354.0: 每次返回的记录数
  • (218124) : 总共返回的记录数
  • root[root]@localhost: username[password]@[127.0.0.1]
  • select * from tbcategory ...: 执行的sql语句

可以看到, 该slow.txt文件是按照sql的执行时间倒序排序的, 可以通过输出参数指定排序规则或其他规则

OK, 目前为止, 我们已经开启慢查询日志功能, 并通过mysql工具mysqldumpslow.pl对慢查询日志文件进行统计和输出, 当然, 还有其他分析工具, 这里就不多说了

六、explain优化sql

五.3分析slow.txt文件中, 可以看到


SELECT
*
FROM
`tbcategory` t1
LEFT JOIN tbcategory t2 
ON t1._id = t2.parentId
  • 1.
  • 2.
  • 3.
  • 4.
  • 5.
  • 6.

这条查询语句执行了11.75s, 通过explain SELECT * FROM tbcategory t1 LEFT JOIN tbcategory t2 ON t1._id = t2.parentId发现, 没有使用任何索引, 查询太慢

mysql 慢查询每日汇报与分析_MySQL_08

image.png

parentId添加索引: create index idx_pid on tbcategory(parentId), 再次查询, 执行时间: 0.082s, 再次explain:

mysql 慢查询每日汇报与分析_MySQL_09

image.png

可以看到, 通过对慢sql进行优化, 可以大幅减少查询时间

七、总结

本文思路很简单:

  1. 修改my.ini配置文件开启慢查询日志功能
  2. 直接查看慢查询日志文件
  3. 通过mysql系统工具mysqldumpslow.pl统计分析日志文件, 找出耗时长的慢sql语句
  4. 通过explain分析慢查询语句, 并对其进行优化