MySQL实践篇-慢查询

为什么只查一行的语句，也执行这么慢？

如果是MySQL数据库本身就有很大的压力，导致数据库服务器CPU占用绿很高或ioutil(IO利用率)很高，这种情况下所有的语句的执行都有可能很慢，这里不讨论。

为了便于描述，我还是构造一个表，基于这个表来说明问题。这个表有两个字段id和c，并且我在里面插入了10万行记录。

mysql> CREATE TABLE `t` (
  `id` int(11) NOT NULL,
  `c` int(11) DEFAULT NULL,
  PRIMARY KEY (`id`)
) ENGINE=InnoDB;

delimiter ;;
create procedure idata()
begin
  declare i int;
  set i=1;
  while(i<=100000) do
    insert into t values(i,i);
    set i=i+1;
  end while;
end;;
delimiter ;

call idata();

第一类：查询长时间不返回

执行sql

mysql> select * from t where id=1;

查询结果上时间不返回。

一般碰到这种情况的话，大概率是表t被锁住了。一般都是首先执行一下show processlist命令，看看当前语句处于什么状态。

然后针对每种状态，分析产生的原因，如何复现，以及如何处理。

等MDL锁

使用show processlist命令查看Waiting for table metadata lock的示意图。

出现这个状态表示的是，现在有一个线程正在表t上请求或者持有MDL写锁，把select语句堵住了。

这类问题的处理方式，就是找到谁持有MDL写锁，然后把它kill掉。

但是，由于在show processlist的结果里面，sessionA的Command列是“Sleep”，导致查找起来不方便。不过有了performance_schema和sys系统库以后，就方便多了。(MySQL启动时需要设置performance_schema=on,相比于设置为off会有10%左右的性能损失)

通过查询sys.schema_table_lock_waits这张表，我们就可以直接找出造成阻塞的process id，把这个连接用kill命令断开即可。

等flush

在表t上，执行下面的SQL语句：

mysql> select * from information_schema.processlist where id=1;

这个状态表示的是，现在有一个线程正要对表t做flush操作。MySQL里面对表做flush操作的用法，一般有一下两个：

flush tables t with read lock;

flush tables with read lock;

这两个flush语句，如果指定表t的话，代表的是只关闭表t；如果没有指定具体的表名，则表示关闭MySQL里所有打开的表。

但是正常这个两个语句执行起来都很快，除非他们呢被别的线程堵住了。

所以，出现Waiting for table flush状态的可能情况是：有一个flush tables命令被别的语句堵住了，然后它又堵住了我们的select 语句。

复现步骤：

在sessionA中，故意没行都调用一次sleep(1),这样这个语句默认要执行10万秒，在这期间表t一直被sessionA”打开”着。然后，sessionB的flush tables t命令再要去关闭表t，就需要等sessionA的查询结果，这样session C要再次查询的话，就会被flush命令堵住了。

通过show processlist命令查看的结果：

等行锁

mysql> select * from t where id=1 lock in share mode; 

由于访问id=1这个记录时要加读锁，如果这个时候已经有事务在这行记录上持有一个写锁，select会被堵住。

复现步骤如下：

session A启动了事务，占有写锁，还提交，是导致sessionB被堵住的原因。

如果是MySQL5.7版本，可以通过sys.innodb_lock_waits表查到。

mysql> select * from t sys.innodb_lock_waits where locked_table='`test`.`t`'\G

可以看到，4号线程是造成堵塞的罪魁祸首。而干掉这个罪魁祸首的方式，就是KILL QUERY 4或KILL 4。

实际上，KILL 4 才有效，也就说直接断开这个连接。这里隐含的一个逻辑就是，连接断开的时候，会自动回滚这个连接里面正在执行的线程，也就释放了id=1上的行锁。

第二类：查询慢

mysql> select * from t where c=50000 limit 1;

由于字段c上没有索引，这个语句只能走id主键顺序扫描，因此需要扫描5万行。

注意：为了把所有语句记录到show log里，我在连接后先执行了set long_query_time=0,将慢查询日志的时间阀值设置为0。

Rows_examined显示扫描了50000行。坏查询不一定是慢查询

mysql> select * from t where id=1；

虽然扫描行数是1，但执行时间却长达800毫秒。

如果执行语句：

mysql> select * from t where id=1 lock in share mode;

执行扫描行数也是1行，执行时间是0.2毫秒。

按理说 lock in share mode还要加锁，时间应该更长才对。

第一个语句的查询结果里c=1,带lock in share mode的语句返回的是c=1000001。

复现步骤：

sessionA先用start transaction with consistent snapshot 命令启动了一个事务，之后session B才开始执行update语句。

sessionB执行完100万次update语句后 ID=1这行什么状态？

sessionB更新完100万次，生成了100万个回滚日志(undo log)。

带lock in share mode 的SQL语句，是当前读，因此会直接读到1000001这个结果，所以速度很快；而select * from t where id =1这个语句，是一致性读，因此需要从1000001开始，依次执行undo log，执行了100万次后，才将1这个结果返回。