Mysql-日志-慢查询日志

本篇文章主要记述Mysql慢查询的学习过程,内容目录如下:
慢查询日志是什么?
慢查询日志开启和配置
慢查询日志相关操作

慢查询日志是什么?

Mysql的慢查询日志是Mysql提供的一种日志记录,用来记录在Mysql中响应时间超过阈值的语句,具体所指运行时间超过long_query_time值的SQL,则会被记录在慢查询日志中。

慢查询日志开启和配置

1.慢查询日志默认是关闭的,可以通过如下的命令查看是否开启

mysql> show variables like 'slow_query_log%';
+---------------------+-------------------------------------+
| Variable_name       | Value                               |
+---------------------+-------------------------------------+
| slow_query_log      | OFF                                 |
| slow_query_log_file | /home/mysql/data/localhost-slow.log |
+---------------------+-------------------------------------+
2 rows in set (0.00 sec)

OFF表示是处于关闭状态,如果是开启状态就会是ON

2.开启慢查询

临时开启

set global slow_query_log = 1;

使用set global slow_query_log = 1;开启了慢查询日志,但是只对当前数据库生效,如果Mysql重启则会失效,如果要永久生效,就必须修改配置文件my.cnf

永久开启

将如下的两行配置进my.cnf文件:

slow_query_log=1
slow_query_log_file=/home/mysql/data/localhost-slow.log

然后重启Mysql服务器。
关于慢查询的参数slow_query_log_file,它指定慢查询日志文件的存放路径,系统默认会给一个缺省的文件host_name-slow.log(即如果我们开启了慢查询但是没有配置这个参数的话,那么就是用默认缺省的文件,有配过就是用我们配置的参数)

3.修改慢查询阈值

参数long_query_time用来控制执行时间超过多少会被记录进入满插入日志。默认情况下long_query_time的值为10秒。可以使用如下的命令查询和修改:

show variables like '%long_query_time';
set global long_query_time=3;

修改完之后我再执行show variables like '%long_query_time';发现还是10秒。
为什么设置后看不出变化?
其实是已经改变了,我们有两种方法可以看到修改过后的值:

  1. 需要重新连接获取开一个新的会话才能看到修改值。
  2. 使用show global variables like '%long_query_time';

ps:关于long_query_time,在mysql源码中是判断大于此值,而非大于等于,配置10秒,那么等于10秒的sql就不会被记录

慢查询日志相关操作

模拟慢查询语句

如果是自己在学习阶段可以通过select sleep(4);来模拟慢查询操作。因为我的这台服务器上有现成的慢查询日志,所以后面的分析就基于此日志。

获取有多少条慢查询日志:

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

如上面的查询结果,我的这台服务器上面有生产环境中记录24209条慢查询日志,这么多如果哟啊手工分析日志,查找、分析sql,显然不太高效。Mysql提供了日志分析工具mysqldumpslow,接下来我们就来看看这个工具。

mysqldumpslow

可以通过mysqldumpslow --help来查看此命令的帮助信息,当然这个命令和mysqldump类似不需要登录mysql。

详细看看此命令的常用参数

-s:表示按照什么方式排序,-s后面可以追加的排序方式如下,默认是降序:

c:访问次数
l:锁定时间
r:返回记录
t:查询时间
al:平均锁定时间
ar:平均返回记录数
at:平均查询时间

-t :即为返回前面多少条的数据,后面跟一个整数
-g:后面搭配一个正则匹配模式,大小写不敏感的;

工作常用参考

#返回访问次数最多的10条SQL,也就是被记录最多的10条SQL
mysqldumpslow -s c -t 10 /home/mysql/data/localhost-slow.log

#得到按照时间排序的前5条里面含有左连接的查询语句
mysqldumpslow -s t -t 5 -g "left join" /home/mysql/data/localhost-slow.log
©著作权归作者所有,转载或内容合作请联系作者
  • 序言:七十年代末,一起剥皮案震惊了整个滨河市,随后出现的几起案子,更是在滨河造成了极大的恐慌,老刑警刘岩,带你破解...
    沈念sama阅读 202,607评论 5 476
  • 序言:滨河连续发生了三起死亡事件,死亡现场离奇诡异,居然都是意外死亡,警方通过查阅死者的电脑和手机,发现死者居然都...
    沈念sama阅读 85,047评论 2 379
  • 文/潘晓璐 我一进店门,熙熙楼的掌柜王于贵愁眉苦脸地迎上来,“玉大人,你说我怎么就摊上这事。” “怎么了?”我有些...
    开封第一讲书人阅读 149,496评论 0 335
  • 文/不坏的土叔 我叫张陵,是天一观的道长。 经常有香客问我,道长,这世上最难降的妖魔是什么? 我笑而不...
    开封第一讲书人阅读 54,405评论 1 273
  • 正文 为了忘掉前任,我火速办了婚礼,结果婚礼上,老公的妹妹穿的比我还像新娘。我一直安慰自己,他们只是感情好,可当我...
    茶点故事阅读 63,400评论 5 364
  • 文/花漫 我一把揭开白布。 她就那样静静地躺着,像睡着了一般。 火红的嫁衣衬着肌肤如雪。 梳的纹丝不乱的头发上,一...
    开封第一讲书人阅读 48,479评论 1 281
  • 那天,我揣着相机与录音,去河边找鬼。 笑死,一个胖子当着我的面吹牛,可吹牛的内容都是我干的。 我是一名探鬼主播,决...
    沈念sama阅读 37,883评论 3 395
  • 文/苍兰香墨 我猛地睁开眼,长吁一口气:“原来是场噩梦啊……” “哼!你这毒妇竟也来了?” 一声冷哼从身侧响起,我...
    开封第一讲书人阅读 36,535评论 0 256
  • 序言:老挝万荣一对情侣失踪,失踪者是张志新(化名)和其女友刘颖,没想到半个月后,有当地人在树林里发现了一具尸体,经...
    沈念sama阅读 40,743评论 1 295
  • 正文 独居荒郊野岭守林人离奇死亡,尸身上长有42处带血的脓包…… 初始之章·张勋 以下内容为张勋视角 年9月15日...
    茶点故事阅读 35,544评论 2 319
  • 正文 我和宋清朗相恋三年,在试婚纱的时候发现自己被绿了。 大学时的朋友给我发了我未婚夫和他白月光在一起吃饭的照片。...
    茶点故事阅读 37,612评论 1 329
  • 序言:一个原本活蹦乱跳的男人离奇死亡,死状恐怖,灵堂内的尸体忽然破棺而出,到底是诈尸还是另有隐情,我是刑警宁泽,带...
    沈念sama阅读 33,309评论 4 318
  • 正文 年R本政府宣布,位于F岛的核电站,受9级特大地震影响,放射性物质发生泄漏。R本人自食恶果不足惜,却给世界环境...
    茶点故事阅读 38,881评论 3 306
  • 文/蒙蒙 一、第九天 我趴在偏房一处隐蔽的房顶上张望。 院中可真热闹,春花似锦、人声如沸。这庄子的主人今日做“春日...
    开封第一讲书人阅读 29,891评论 0 19
  • 文/苍兰香墨 我抬头看了看天上的太阳。三九已至,却和暖如春,着一层夹袄步出监牢的瞬间,已是汗流浃背。 一阵脚步声响...
    开封第一讲书人阅读 31,136评论 1 259
  • 我被黑心中介骗来泰国打工, 没想到刚下飞机就差点儿被人妖公主榨干…… 1. 我叫王不留,地道东北人。 一个月前我还...
    沈念sama阅读 42,783评论 2 349
  • 正文 我出身青楼,却偏偏与公主长得像,于是被迫代替她去往敌国和亲。 传闻我的和亲对象是个残疾皇子,可洞房花烛夜当晚...
    茶点故事阅读 42,316评论 2 342

推荐阅读更多精彩内容