实例讲解MySQL 慢查询

show variables like 'slow_query%';
+---------------------------+----------------------------------+
| Variable_name       | Value              |
+---------------------------+----------------------------------+
| slow_query_log      | OFF               |
| slow_query_log_file    | /mysql/data/localhost-slow.log  |
+---------------------------+----------------------------------+

show variables like 'long_query_time';
+-----------------+-----------+
| Variable_name  | Value   |
+-----------------+-----------+
| long_query_time | 10.000000 |
+-----------------+-----------+

--将 slow_query_log 全局变量设置为“ON”状态
  set global slow_query_log='ON'; 

--设置慢查询日志存放的位置
 set global slow_query_log_file='/usr/local/mysql/data/slow.log';

--查询超过1秒就记录
  set global long_query_time=1;

  slow_query_log = ON
  slow_query_log_file = /usr/local/mysql/data/slow.log
  long_query_time = 1

--s:是表示按照何种方式排序 
  --c:访问次数 
  --l:锁定时间 
  --r:返回记录 
  --t:查询时间 
  --al:平均锁定时间 
  --ar:平均返回记录数 
  --at:平均查询时间 
  --t:即为返回前面多少条的数据 
  --g:后面搭配一个正则匹配模式，大小写不敏感

--1.得到返回记录集最多的10个SQL
  mysqldumpslow -s -r -t 10 /logs/mysql-slow.log

 --2.得到访问次数最多的10个SQL
  mysqldumpslow -s -c -t 10 /logs/mysql-slow.log

 --3.得到按照时间排序的前10条里面含有做链接的查询语句
  mysqldumpslow -s t -t 10 -g "left join" /logs/mysql-slow.log
 
 --4.另外建议在使用这些命令时结合|和more使用，否则又可能出现爆屏情况
  mysqldumpslow -s r -t 10 /logs/mysql-slow.log | more

show variables like "profiling";--默认是关闭的
+---------------+-------+
| Variable_name | Value |
+---------------+-------+
| profiling   | OFF  |
+---------------+-------+

--开启
set profiling=1;

show profiles;--会列出所有在这个开启期间执行的SQL，并附上QUERY ID
+----------+------------+----------------------------+
| Query_ID | Duration  | Query           |
+----------+------------+----------------------------+
|    1 | 0.00168025 | select * from vhr.employee |
|    2 | 0.06573200 | select * from vhr.hr    |
+----------+------------+----------------------------+
--我们可以看到显示最近操作的两条语句，列表大小由profiling_history_size会话变量控制， 默认值为15.最大值为100

show profile cpu,block io for queryid --对应2中的query_id

SHOW PROFILE CPU FOR QUERY 1;--查询query_id为1的具体信息
+----------------------+----------+----------+------------+
| Status        | Duration | CPU_user | CPU_system |
+----------------------+----------+----------+------------+
| starting       | 0.000194 | 0.000000 |  0.000000 |
| checking permissions | 0.000012 | 0.000000 |  0.000000 |
| Opening tables    | 0.000030 | 0.000000 |  0.000000 |
| init         | 0.000053 | 0.000000 |  0.000000 |
| System lock     | 0.000011 | 0.000000 |  0.000000 |
| optimizing      | 0.000003 | 0.000000 |  0.000000 |
| statistics      | 0.000014 | 0.000000 |  0.000000 |
| preparing      | 0.000010 | 0.000000 |  0.000000 |
| executing      | 0.000001 | 0.000000 |  0.000000 |
| Sending data     | 0.001213 | 0.000000 |  0.000000 |
| end         | 0.000014 | 0.000000 |  0.000000 |
| query end      | 0.000012 | 0.000000 |  0.000000 |
| closing tables    | 0.000019 | 0.000000 |  0.000000 |
| freeing items    | 0.000070 | 0.000000 |  0.000000 |
| cleaning up     | 0.000025 | 0.000000 |  0.000000 |
+----------------------+----------+----------+------------+