罕用慢查问剖析工具

引言在日常的业务开发中MySQL 呈现慢查问是很常见的大部分状况下会分为两种状况1、业务增长太快2、要么就是SQL 写的太xx了所以对慢查问 SQL 进行剖析和优化很重要其中 mysqldumpslow 是 MySQL 服务自带的一款很好的剖析调优工具

3.1 调优工具mysqldumpslow

3.1.1 调优工具罕用设置

1、什么是MySQL 慢查问日志

MySQL提供的一种慢查问日志记录,用来记录在MySQL查问中响应工夫超过阀值的记录
具体指运行工夫超过long_query_time值的SQL,则会被记录到慢查问日志中

2、如何查看慢查问设置状况

慢查问的工夫阈值设置
show variables like '%slow_query_log%';

解释

  • slow_query_log //是否开启,默认敞开,倡议调优时才开启
  • slow_query_log_file //慢查问日志寄存门路

3、如何开启慢查问日志记录

1) 命令开启

set global slow_query_log =1; //只对以后会话失效,重启生效

执行胜利

再次执行

show variables like '%slow_query_log%';

先敞开客户端连贯,再进行从新连贯,即可看到设置失效

发现开启了mysqldumpslow调优工具

mysql> show variables like '%slow_query_log%';+---------------------+-------------------------------------------+| Variable_name       | Value                                     |+---------------------+-------------------------------------------+| slow_query_log      | ON                                        || slow_query_log_file | /opt/mysql-5.7.28/data/linux-141-slow.log |+---------------------+-------------------------------------------+2 rows in set (0.02 sec)mysql> 

2)配置文件开启

vim my.cnf在[mysqld]下增加:slow_query_log = 1slow_query_log_file = /opt/mysql-5.7.28/data/linux-141-slow.log重启MySQL服务 

批改并且重启后

发现开启了mysqldumpslow调优工具

mysql> show variables like '%slow_query_log%';+---------------------+-------------------------------------------+| Variable_name       | Value                                     |+---------------------+-------------------------------------------+| slow_query_log      | ON                                        || slow_query_log_file | /opt/mysql-5.7.28/data/linux-141-slow.log |+---------------------+-------------------------------------------+2 rows in set (0.02 sec)mysql> 

3)哪些 SQL 会记录到慢查问日志

-- 查看阀值(大于),默认10sshow variables like 'long_query_time%';

默认值是10秒

4)如何设置查问阀值

  • 命令设置
-- 设置慢查问阀值set global long_query_time = 1;

备注:另外开一个session或从新连贯 ,才会看到变动

执行胜利发发现慢sql的工夫变成了1秒

配置文件设置

vim my.cnf[mysqld]long_query_time = 1log_output = FILE重启MySQL服务

执行胜利发发现慢sql的工夫变成了1秒

5)如何把未应用索引的 SQL 记录写入慢查问日志

-- 查看设置,默认敞开show variables like 'log_queries_not_using_indexes';

咱们发现,未应用索引的sql默认是不记录到慢查问日志的

开启配置

set global log_queries_not_using_indexes = on;

执行如下

6)模仿数据

-- 睡眠2s再执行select sleep(2);-- 查看慢查问条数show global status like '%Slow_queries%';

咱们发现,每执行一次select sleep(2),之后,再通过show global status ...命令,他的值就会+1

3.1.2 调优工具常用命令

语法格局

mysqldumpslow [ OPTS... ] [ LOGS... ] //命令行格局

罕用到的格局组合

-s 示意依照何种形式排序    c 拜访次数    l 锁定工夫    r 返回记录    t 查问工夫    al 均匀锁定工夫    ar 均匀返回记录数    at  均匀查问工夫-t 返回后面多少条数据-g 后边搭配一个正则匹配模式,大小写不敏感

1、拿到慢日志门路

show variables like '%slow_query_log%';

日志门路为:/opt/mysql-5.7.28/data/linux-141-slow.log

查看日志

[root@linux-141 mysql-5.7.28]# cat /opt/mysql-5.7.28/data/linux-141-slow.log/opt/mysql-5.7.28/bin/mysqld, Version: 5.7.28-log (MySQL Community Server (GPL)). started with:Tcp port: 3306  Unix socket: /tmp/mysql.sockTime                 Id Command    Argument# Time: 2021-09-15T01:40:31.342430Z# User@Host: root[root] @  [192.168.36.1]  Id:     2# Query_time: 2.000863  Lock_time: 0.000000 Rows_sent: 1  Rows_examined: 0use itcast;SET timestamp=1631670031;-- 睡眠2s再执行select sleep(2);[root@linux-141 mysql-5.7.28]#

2、失去拜访次数最多的10条SQL

[root@linux-141 mysql-5.7.28]# ./bin/mysqldumpslow -s r -t  10 /opt/mysql-5.7.28/data/linux-141-slow.log-bash: ./bin/mysqldumpslow: /usr/bin/perl: 坏的解释器: 没有那个文件或目录[root@linux-141 mysql-5.7.28]# yum -y install perl perl-devel[root@linux-141 mysql-5.7.28]# ./bin/mysqldumpslow -s r -t  10 /opt/mysql-5.7.28/data/linux-141-slow.log

3、依照工夫排序的前10条外面含有左连贯的SQL

[root@linux-141 mysql-5.7.28]# ./bin/mysqldumpslow -s t -t 10 -g "left join"  /opt/mysql-5.7.28/data/linux-141-slow.logReading mysql slow query log from /opt/mysql-5.7.28/data/linux-141-slow.logDied at ./bin/mysqldumpslow line 167, <> chunk 28.[root@linux-141 mysql-5.7.28]#

3.1.3 慢日志文件剖析

1、查看慢查问日志

[root@linux-141 mysql-5.7.28]# cat /opt/mysql-5.7.28/data/linux-141-slow.log/opt/mysql-5.7.28/bin/mysqld, Version: 5.7.28-log (MySQL Community Server (GPL)). started with:Tcp port: 3306  Unix socket: /tmp/mysql.sockTime                 Id Command    Argument# Time: 2021-09-15T01:40:31.342430Z# User@Host: root[root] @  [192.168.36.1]  Id:     2# Query_time: 2.000863  Lock_time: 0.000000 Rows_sent: 1  Rows_examined: 0use itcast;SET timestamp=1631670031;-- 睡眠2s再执行select sleep(2);# Time: 2021-09-15T01:50:32.130305Z# User@Host: root[root] @  [192.168.36.1]  Id:     2# Query_time: 3.001904  Lock_time: 0.000000 Rows_sent: 1  Rows_examined: 0SET timestamp=1631670632;select sleep(3);# Time: 2021-09-15T01:50:55.064372Z# User@Host: root[root] @  [192.168.36.1]  Id:     2# Query_time: 4.008082  Lock_time: 0.000000 Rows_sent: 1  Rows_examined: 0SET timestamp=1631670655;select sleep(4);# Time: 2021-09-15T01:51:01.343463Z# User@Host: root[root] @  [192.168.36.1]  Id:     2# Query_time: 5.007035  Lock_time: 0.000000 Rows_sent: 1  Rows_examined: 0SET timestamp=1631670661;select sleep(5);# Time: 2021-09-15T01:51:07.737834Z                                         ###### 执行SQL工夫# User@Host: root[root] @  [192.168.36.1]  Id:     2                        ###### 执行SQL的主机信息# Query_time: 6.009129  Lock_time: 0.000000 Rows_sent: 1  Rows_examined: 0    ###### SQL的执行信息SET timestamp=1631670667;                                                    ###### SQL执行工夫select sleep(6);                                                            ###### SQL内容[root@linux-141 mysql-5.7.28]#

属性解释

# Time: 2021-09-15T01:51:07.737834Z                                         ###### 执行SQL工夫# User@Host: root[root] @  [192.168.36.1]  Id:     2                        ###### 执行SQL的主机信息# Query_time: 6.009129  Lock_time: 0.000000 Rows_sent: 1  Rows_examined: 0    ###### SQL的执行信息SET timestamp=1631670667;                                                    ###### SQL执行工夫select sleep(6);                                                            ###### SQL内容

3.2 调优工具show profile

tips:

show profile,它也是调优工具

也是MySQL服务自带的剖析调优工具

不过这款更高级

比拟靠近底层硬件参数的调优。

简介:

show profile是MySQL服务自带更高级的剖析调优工具

比拟靠近底层硬件参数的调优

1、查看show profile设置

-- 默认敞开,保留近15次的运行后果show variables like 'profiling%';

通过下面咱们发现,show profile工具默认是敞开状态,15示意保留了近15次的运行后果。

2、开启调优工具

执行上面的命令开启

SET profiling = ON;

再次查看状态

show variables like 'profiling%';

3、查看最近15次的运行后果

-- 查看最近15次的运行后果show profiles;-- 能够显示正告和报错的信息show warnings;-- 慢查问语句SELECT * FROM product_list WHERE store_name = '联想北达兴科专卖店';

显示最近15次的运行后果

4、诊断运行的SQL

接下来,咱们一起诊断一下query id为23的慢查问

-- 语法SHOW PROFILE cpu,block io FOR QUERY query id;-- 示例SHOW PROFILE cpu,block io FOR QUERY 129;

开始执行

解释:通过Status一列,能够看到整条SQL的运行过程1. starting //开始2. checking permissions //查看权限3. Opening tables //关上数据表4. init //初始化5. System lock //锁机制6. optimizing //优化器7. statistics //剖析语法树8. prepareing //预筹备9. executing //引擎执行开始10. end //引擎执行完结11. query end //查问完结12. closing tables //开释数据表13. freeing items //开释内存14. cleaning up //彻底清理
查看类型选项SHOW PROFILE...前面的列,即:SHOW PROFILE ALL, BLOCK IO, ... FOR QUERY 209;ALL //显示索引的开销信息BLOCK IO //显示块IO相干开销CONTEXT SWITCHES  //上下文切换相干开销CPU //显示CPU相干开销信息IPC //显示发送和接管相干开销信息MEMORY //显示内存相干开销信息PAGE FAULTS //显示页面谬误相干开销信息SOURCE //显示和source_function,source_file,source_line相干的开销信息SWAPS //显示替换次数相干开销的信息

重要提醒

如呈现以下一种或者几种状况,阐明SQL执行性能极其低下,亟需优化* converting HEAP to MyISAM  //查问后果太大,内存都不够用了往磁盘上搬了* Creating tmp table //创立长期表:拷贝数据到长期表,用完再删* Copying to tmp table on disk //把内存中长期表复制到磁盘,危险* locked //呈现死锁

本文由传智教育博学谷 - 狂野架构师教研团队公布,转载请注明出处!

如果本文对您有帮忙,欢送关注和点赞;如果您有任何倡议也可留言评论或私信,您的反对是我保持创作的能源