一次Mariadb死锁排查过程回顾

机智的程序员小熊

发布于 2020-03-11 10:37:43

8660

发布于 2020-03-11 10:37:43

文章被收录于专栏：技术面面观

场景

在使用某个平台的时候，发现有些页面长时间，部分数据无法加载成功，开始排查问题。

确定是mariadb的问题的过程

访问了几个页面都是正常的，唯独某几个页面查询实时监控数据时无法加载出来，F12查看接口发现有几个业务相似的接口长时间不返回数据。

既然整体功能是正常的，只有部分页面出现问题，而且都是实时数据无法显示，怀疑是同一个地方出现问题，于是把接口放在一起发现共同点。

1. 都是timeout长时间无响应，而且不是前端资源加载的问题，F12可以看到一个接口的请求过程，例如下图

2. 查看代码逻辑，发现几个接口同时查询过一个表，登陆mariadb，发现SELECT长时间不返回。怀疑是锁表了。

以下所有示例使用docker启动mysql演示复现。

我先锁表

lock table test read;
lock table test write;

发现是卡住了

mysql> select * from test;
mysql> 2013 - Lost connection to MySQL server during query

查看长时间卡住的线程

查询进程（如果您有SUPER权限，您可以看到所有线程。否则，您只能看到您自己的线程）

show processlist;

（点击放大查看）

但是此命令只能显示前100条数据，要想看全部的数据，请输入

show full processlist;

假如发现锁表进程，请输入kill指令将他剔除。

mysql> kill 9;
Query OK, 0 rows affected (0.00 sec)
mysql> kill 11;
Query OK, 0 rows affected (0.00 sec)

再看已经没有了

（点击放大查看）

再看也能查询了。

mysql> select * from test;
+----+------+
| id | a    |
+----+------+
|  1 | test |
|  2 | a    |
+----+------+
2 rows in set (0.00 sec)

查询是否锁表

但是刚刚我加的锁并没有看到是哪个表被锁，也没看到状态，能修复纯属瞎猫碰上死耗子，而且线上生产环境最忌讳就是不知道线程是干嘛的随便杀了，一个有经验的运维是不会这么做的。

我重新把表锁上。用这个命令查看打开了哪些表 (不包括临时表)。

mysql> show OPEN TABLES where In_use > 0;
+------------+-------+--------+-------------+
| Database   | Table | In_use | Name_locked |
+------------+-------+--------+-------------+
| coding3min | test  |      1 |           0 |
+------------+-------+--------+-------------+
1 row in set (0.00 sec)

In_use 表的表锁或锁请求数(已经锁表，或等待锁表)

Name_locked 显示表名称是否被锁定(DDL)

mysql> unlock tables;
Query OK, 0 rows affected (0.00 sec)

mysql> show OPEN TABLES where In_use > 0;
Empty set

查看事物锁

事物锁不同于表锁

select trx_tables_locked,trx_tables_in_use,
       trx_rows_locked,trx_mysql_thread_id,trx_state
from information_schema.innodb_trx;

手动创建一个更新的事物

mysql> start transaction;
Query OK, 0 rows affected (0.01 sec)

mysql> update test2 set a='111';
Query OK, 2 rows affected (0.00 sec)
Rows matched: 2  Changed: 2  Warnings: 0

（点击放大查看）

只要

trx_tables_locked,trx_tables_in_use,

trx_rows_locked三个字段其中一个有值，说明此记录是事物锁。

try_mysql_thread_id 就是这个线程id，kill掉，即可。

我另开一个终端，再启动一个事物，因为前一个事物没有停止，所以会产生一个锁等待。

mysql> use coding3min;
Database changed
mysql> start transaction;
Query OK, 0 rows affected (0.00 sec)

mysql> update test2 set a='222'; 
1205 - Lock wait timeout exceeded; try restarting transaction

再查询一次

（点击放大查看）

mysql> kill 20;
1317 - Query execution was interrupted
mysql> kill 21;
Query OK, 0 rows affected (0.01 sec)

mysql> select trx_tables_locked,trx_tables_in_use,
trx_rows_locked,trx_mysql_thread_id,trx_state
from information_schema.innodb_trx;
Empty set

妥了，可能kill会等待好几分钟，耐心等待。