MySQL查询优化(3)慢查询开启、日志分析

说明

• Mysql的查询讯日志是Mysql提供的一种日志记录，它用来记录在Mysql中响应时间超过阈值的语句
• 具体指运行时间超过long_query_time值得SQL，则会被记录到慢查询日志中。long_query_time的默认为10，意识是运行10秒以上的语句。
• 由它来看那些SQL语句超出了我们的最大忍耐值，比如一条SQL执行超过了5秒，我们就算慢查询，我们就可以结合Explain进行分析。

查看是否开启及如何开启

默认Mysql没有开启慢查询，需要我们说动设置这个参数。当然，如果不是调优需要的话，一般不建议开启该参数，因为开启慢查询日志会或多或少带来一定的性能影响。慢查询日志支持将日志写入文件。

进入mysql终端查看是否开启（我这里都是自己改过的）

mysql> show variables like '%slow_query_log%';
+---------------------+----------------------------+
| Variable_name | Value |
+---------------------+----------------------------+
| slow_query_log | ON |
| slow_query_log_file | /data/mysql/mysql-slow.log |
+---------------------+----------------------------+

上面查询结果第一行，这里是开启的，第二行是默认查询路径文件名。

mysql> set global slow_query_log = 0|1; //设置开启或者关闭，0为关闭，1为开启

如果使用set global slow_query_log 命令开启慢查询日志，只对当前数据库生效，如果Mysql重启后则会失效。

补充：如果通过终端命令设定的话，再查询是看不到修改结果的，需要新开启一个窗口查看即可。

如果要永久生效，必须修改my.cnf配置文件(其他系统变量也是如此)，

修改my.cnf文件，[mysqld]下增加和修改参数slow_query_log和slow_query_log_file后，然后重启MySQL服务器，也即将如下两行配置进my.cnf文件
slow_query_log = 1

slow_query_log_file = /data/mysql/mysql-slow.log

[mysqld]
slow_query_log = 1
long_query_time = 1
slow_query_log_file = /data/mysql/mysql-slow.log

关于慢查询的参数slow_query_log_file，它指定慢查询日志文件的存放路径，系统默认会给一个缺省的host_name_show.log（如果没有指定参数slow_query_log_file的话）。

那么开启了慢日志后，怎么样的SQL才会记录到慢查询当中呢？

• 这个是由参数long_query_time控制，默认情况下long_query_time的值是10秒。
• 命令SHOW VARIABLES LIKE &＃8216;long_query_time&＃8217;;

mysql> show variables like 'long_query_time';
+-----------------+----------+
| Variable_name | Value |
+-----------------+----------+
| long_query_time | 10.00000 |
+-----------------+----------+

可以使用命令修改，也可以在my.cnf参数里面修改，修改完记得习惯性重启服务。还是那句话，不建议生产环境开启。

mysql> show variables like 'long_query_time';
+-----------------+----------+
| Variable_name | Value |
+-----------------+----------+
| long_query_time | 1.000000 |
+-----------------+----------+

假如SQL运行时间刚好等于long_query_time的情况，并不会被记录下来，也就是说，在Mysql源码里是判断大于long_query_time，而非大于等于。

Case

• 查看当前多少秒算慢：SHOW VARIABLES LIKE &＃8216;long_query_time%&＃8217;;
• 设置慢的阙值时间：set global long_query_time=3;

• 为什么设置后看不出变化：

1. 需要重新连接或新开一个回话才能看到修改值； SHOW VARIABLES LIKE &＃8216;long_query_time%&＃8217;;
2. SHOW GLOBAL VARIABLES LIKE &＃8216;long_query_time%&＃8217;;

• 记录慢SQL并后续分析：select sleep(4);

查看慢查询日志文件

# cat /data/mysql/mysql-slow.log
#
# select sleep(5);
# Time: 2018-01-20T18:10:24.443517Z
# User@Host: root[root] @ localhost [] Id: 3
# Query_time: 5.000564 Lock_time: 0.000000 Rows_sent: 1 Rows_examined: 0
use test_db; #使用的数据库
SET timestamp=1524276624; #时间戳
select sleep(5); #问题SQL

以上信息包括实际查询时间5.000564秒，时间戳timestamp=1524276624，还有库test_db，出问题的SQL。

• 查看当前系统中多少条满记录：show global status like &＃8216;%Slow_queries%&＃8217;;

mysql> show global status like '%Slow_queries%';
+---------------+-------+
| Variable_name | Value |
+---------------+-------+
| Slow_queries | 1 |
+---------------+-------+
1 row in set (0.03 sec)

可以作为系统健康检查度来查询。(什么意思：如果系统里面充满了大量的慢SQL，都超过阙值，这时系统就需要及时优化)

配置版

show_query_log = 1;
show_query_log_file=/var/lib/mysql/mysql_slow.log
log_query_time=3;
log_output=FILE

mysqldumpslow用法讲解

• 在生产环境中，如果要手动分析日志，查找、分析SQL，显然是一个体力活，MySQL提供了日志分析工具mysqldumpslow。

上面测试的慢查询SQL只有一条，假如在实际的生产环境中，慢查询SQL远远高于测试的数量，十几条甚至几十条，假如几条慢查询出现的频率很高，我们能做到根据轻重优先级来分析并排除那是不是更好？那么就用到了mysqldumpslow

[root@lig mysql]# mysqldumpslow --help ----------------------------------------------------//执行命令
Usage: mysqldumpslow [ OPTS... ] [ LOGS... ]
Parse and summarize the MySQL slow query log. Options are
--verbose verbose
--debug debug
--help write this text to standard output
-v verbose
-d debug
-s ORDER what to sort by (al, at, ar, c, l, r, t), 'at' is default
al: average lock time
ar: average rows sent
at: average query time
c: count
l: lock time
r: rows sent
t: query time
-r reverse the sort order (largest last instead of first)
-t NUM just show the top n queries
-a don't abstract all numbers to N and strings to 'S'
-n NUM abstract numbers with at least n digits within names
-g PATTERN grep: only consider stmts that include this string
-h HOSTNAME hostname of db server for *-slow.log filename (can be wildcard),
default is '*', i.e. match all
-i NAME name of server instance (if using mysql.server startup script)
-l don't subtract lock time from total time

s:是表示按照何种方式排序

c:访问次数

i：锁定时间

r：返回记录

t：查询时间

al:平均锁定时间

ar：平均返回记录数

at：平均查询时间

t：即为返回前面多少条数据

g：后边搭配一个正则匹配模式，大小写不敏感

mysqldumpslow -s r -t 10 /data/mysql/mysql-slow.log //得到返回记录集最多的10个SQL
mysqldumpslow -s c -t 10 /data/mysql/mysql-slow.log //得到访问次数最多的10个SQL
mysqldumpslow -s t -t 10 -g "left join" /data/mysql/mysql-slow.log //得到按照时间排序的前10条里面含有做了连接的查询SQL
mysqldumpslow -s r -t 10 /data/mysql/mysql-slow.log | more //另外建议在使用这些命令时结合|和more使用，否则有可能出现爆屏情况

OK~既然学习了，就运用到实际工作中吧~