mysql dba系统学习（9）slow query log慢查询日志功能

mingk

                      慢查询日志（不包括获取锁的时间）
1，开启慢查询日志功能
    以前的版本中开启慢查询日志功能的参数是--log_slow_queries在my.cnf文件中指定，但是现在新的版本中用参数--slow_query_log和--slow_query_log_file来指定
slow_query_log=1
slow_query_log_file=/tmp/mysqlslow.log
重新启动mysql
mysql> show variables like "%slow%";
+---------------------+--------------------+
| Variable_name       | Value              |
+---------------------+--------------------+
| log_slow_queries    | ON                 |
| slow_launch_time    | 2                  |
| slow_query_log      | ON                 |
| slow_query_log_file | /tmp/mysqlslow.log |
+---------------------+--------------------+
4 rows in set (0.00 sec)


2，慢查询相关的 参数long_query_time
当查询超过long_query_time指定的时间，那么就会记录在慢查询日志文件中，默认是10秒
mysql> show variables like "%long%";
+--------------------+-----------+
| Variable_name      | Value     |
+--------------------+-----------+
| long_query_time    | 10.000000 |

我们来吧时间调短试试，看看什么变化
mysql> set session long_query_time=1;   调到1秒
Query OK, 0 rows affected (0.00 sec)

mysql> show variables like "%long%";
+--------------------+----------+
| Variable_name      | Value    |
+--------------------+----------+
| long_query_time    | 1.000000 |
| max_long_data_size | 1048576  |
+--------------------+----------+
2 rows in set (0.00 sec)

mysql> use test;
Database changed
mysql> create table t as select * from information_schema.tables;
Query OK, 53 rows affected (0.12 sec)
Records: 53  Duplicates: 0  Warnings: 0
mysql> insert into t  select *  from t;
Query OK, 3392 rows affected (0.11 sec)
Records: 3392  Duplicates: 0  Warnings: 0

这个时候达到了1秒钟了所以就要记录sql语句
mysql> insert into t  select *  from t;
^[[AQuery OK, 6784 rows affected (1.15 sec)
Records: 6784  Duplicates: 0  Warnings: 0

mysql> system more /tmp/mysqlslow.log
/usr/local/mysql/libexec/mysqld, Version: 5.1.70-log (Source distribution). star
ted with:
Tcp port: 3306  Unix socket: /tmp/mysql.sock
Time                 Id Command    Argument
# Time: 130903 18:46:28
# User@Host: root[root] @ localhost []
# Query_time: 1.150157  Lock_time: 0.000205 Rows_sent: 0  Rows_examined: 13568
use test;
SET timestamp=1378205188;
insert into t  select *  from t;

3，慢查询相关的 参数log_queries_not_using_indexes
如果log_queries_not_using_indexes为ON的话，当执行一个sql语句的时候，如果一个表没有索引就会把这个信息记录在慢查询文件中
mysql> show variables like "%log_queries_not%"
   -> ;
+-------------------------------+-------+
| Variable_name                 | Value |
+-------------------------------+-------+
| log_queries_not_using_indexes | OFF   |
+-------------------------------+-------+
1 row in set (0.00 sec)
我们来吧log_queries_not_using_indexes设置为ON的时候来试试吧
mysql> set global log_queries_not_using_indexes=on;
Query OK, 0 rows affected (0.00 sec)

mysql> show variables like "%log_queries_not%";
+-------------------------------+-------+
| Variable_name                 | Value |
+-------------------------------+-------+
| log_queries_not_using_indexes | ON    |
+-------------------------------+-------+
1 row in set (0.01 sec)

mysql> show index from t;   表t没有索引
Empty set (0.00 sec)

mysql> select * from t where TABLE_NAME="xxxxxxxxxxx";
Empty set (0.11 sec)

这个时候慢日志文件记录下来了这个sql语句
mysql> system  tail /tmp/mysqlslow.log;
# User@Host: root[root] @ localhost []
# Query_time: 1.150157  Lock_time: 0.000205 Rows_sent: 0  Rows_examined: 13568
use test;
SET timestamp=1378205188;
insert into t  select *  from t;
# Time: 130903 18:58:17
# User@Host: root[root] @ localhost []
# Query_time: 0.100749  Lock_time: 0.057377 Rows_sent: 0  Rows_examined: 27136
SET timestamp=1378205897;
select * from t where TABLE_NAME="xxxxxxxxxxx";
mysql>

4，工具mysqldumpslow用来分析sql语句慢查询

[iyunv@test4 Desktop]# mysqldumpslow  -s t -t 2  /tmp/mysqlslow.log

Reading mysql slow query log from /tmp/mysqlslow.log
Count: 1  Time=1.15s (1s)  Lock=0.00s (0s)  Rows=0.0 (0), root[root]@localhost
insert into t  select *  from t

Count: 1  Time=0.04s (0s)  Lock=0.06s (0s)  Rows=0.0 (0), root[root]@localhost
select * from t where TABLE_NAME="S"

cheun

走自己的路，让别人打车去吧。

xuhang120814

也许,也许我只适合一个人,谁都不适合做我的朋友.