简单介绍MySQL打印死锁日志的方法

本文详细解读如何在MySQL中手动和自动获取死锁日志,包括通过showengineinnodbstatus命令查看死锁详情,以及设置innodb_print_all_deadlocks参数来自动记录死锁。通过实例解析死锁日志结构,帮助运维人员快速定位和解决死锁问题。

摘要生成于 C知道 ,由 DeepSeek-R1 满血版支持, 前往体验 >

导读本文主要介绍了MySQL打印死锁日志的方法步骤,文中通过示例代码介绍的非常详细,具有一定的参考价值,感兴趣的小伙伴们可以参考一下

前言:

在 MySQL 运维过程中,难免会遇到 MySQL 死锁的情况,一旦线上业务日渐复杂,各种业务操作之间往往会产生锁冲突,有些会导致死锁异常。这种死锁异常一般要在特定时间特定数据和特定业务操作才会复现,有时候处理起来毫无头绪,一般只能从死锁日志下手。本篇文章我们一起来看下 MySQL 的死锁日志。

1.手动打印死锁日志

当业务发生死锁时,首先是线上错误日志报警发现死锁异常,也会提示一些堆栈信息,然后会反馈到数据库层面进行排查。我们一般会在命令行执行 show engine innodb status\G 来输出死锁日志,\G 的作用是将查询到的结果,每行显示一个字段和字段值,方便查看。

show engine innodb status 是 MySQL 提供的一个用于查看 innodb 引擎系统信息的工具。它会输出大量的内部信息,内容分为很多小段,每一段对应 innodb 存储引擎不同部分的信息,其中 LATEST DETECTED DEADLOCK 部分显示的最近一次的死锁信息。

下面我们手动制造一次死锁,来看一下死锁日志相关信息:

------------------------
LATEST DETECTED DEADLOCK
------------------------
2021-11-10 17:03:10 0x7fb040672700
*** (1) TRANSACTION:
TRANSACTION 46913, ACTIVE 142 sec starting index read
mysql tables in use 1, locked 1
LOCK WAIT 4 lock struct(s), heap size 1136, 3 row lock(s), undo log entries 1
MySQL thread id 2997198, OS thread handle 140394973071104, query id 9145673 localhost root updating
update test_tb set stu_name = 'lisi' where stu_id = 1006
*** (1) WAITING FOR THIS LOCK TO BE GRANTED:
RECORD LOCKS space id 224 page no 4 n bits 80 index uk_stu_id of table `testdb`.`test_tb` trx id 46913 lock_mode X locks rec but not gap waiting
Record lock, heap no 7 PHYSICAL RECORD: n_fields 2; compact format; info bits 0
 0: len 4; hex 800003ee; asc     ;;
 1: len 4; hex 80000006; asc     ;;
 
*** (2) TRANSACTION:
TRANSACTION 46914, ACTIVE 103 sec starting index read
mysql tables in use 1, locked 1
4 lock struct(s), heap size 1136, 3 row lock(s), undo log entries 1
MySQL thread id 2997201, OS thread handle 140394971473664, query id 9145681 localhost root updating
update test_tb set age = 21  where stu_id = 1005
*** (2) HOLDS THE LOCK(S):
RECORD LOCKS space id 224 page no 4 n bits 80 index uk_stu_id of table `testdb`.`test_tb` trx id 46914 lock_mode X locks rec but not gap
Record lock, heap no 7 PHYSICAL RECORD: n_fields 2; compact format; info bits 0
 0: len 4; hex 800003ee; asc     ;;
 1: len 4; hex 80000006; asc     ;;
 
*** (2) WAITING FOR THIS LOCK TO BE GRANTED:
RECORD LOCKS space id 224 page no 4 n bits 80 index uk_stu_id of table `testdb`.`test_tb` trx id 46914 lock_mode X locks rec but not gap waiting
Record lock, heap no 6 PHYSICAL RECORD: n_fields 2; compact format; info bits 0
 0: len 4; hex 800003ed; asc     ;;
 1: len 4; hex 80000005; asc     ;;
 
*** WE ROLL BACK TRANSACTION (2)
 
# 以上为原文 下面增加个人分析
------------------------
LATEST DETECTED DEADLOCK
------------------------
2021-11-10 17:03:10 0x7fb040672700 #这里显示了最近一次发生死锁的日期和时间
*** (1) TRANSACTION: #死锁相关的第一个事务
TRANSACTION 46913, ACTIVE 142 sec starting index read
#这行表示事务id为46913,事务处于活跃状态142s,starting index read表示正在使用索引读取数据行
mysql tables in use 1, locked 1
#这行表示该事务正在使用1个表,且涉及锁的表有1个
LOCK WAIT 4 lock struct(s), heap size 1136, 3 row lock(s), undo log entries 1
#这行表示在等待4把锁,占用内存1136字节,涉及3行记录
MySQL thread id 2997198, OS thread handle 140394973071104, query id 9145673 localhost root updating
#这行表示该事务的线程ID信息,操作系统句柄信息,连接来源、用户
update test_tb set stu_name = 'lisi' where stu_id = 1006
#这行表示事务执行的最后一条SQL信息
*** (1) WAITING FOR THIS LOCK TO BE GRANTED: #事务1想要获取的锁
RECORD LOCKS space id 224 page no 4 n bits 80 index uk_stu_id of table `testdb`.`test_tb` trx id 46913 lock_mode X locks rec but not gap waiting
#这行信息表示等待的锁是一个record lock,空间id是224,页编号为4,大概位置在页的80位处,锁发生在表testdb.test_tb的uk_stu_id索引上,是一个X锁,但是不是gap lock,waiting表示正在等待锁
Record lock, heap no 7 PHYSICAL RECORD: n_fields 2; compact format; info bits 0
 0: len 4; hex 800003ee; asc     ;;
 1: len 4; hex 80000006; asc     ;;
 
*** (2) TRANSACTION: #死锁相关的第一个事务
TRANSACTION 46914, ACTIVE 103 sec starting index read
#这行表示事务2的id为46914,事务处于活跃状态103s
mysql tables in use 1, locked 1
#正在使用1个表,涉及锁的表有1个
4 lock struct(s), heap size 1136, 3 row lock(s), undo log entries 1
#涉及4把锁,3行记录
MySQL thread id 2997201, OS thread handle 140394971473664, query id 9145681 localhost root updating
#事务2的线程ID信息,操作系统句柄信息,连接来源、用户
update test_tb set age = 21  where stu_id = 1005
#第二个事务的SQL
*** (2) HOLDS THE LOCK(S): # 事务2持有的锁 正是事务1想要获取的锁
RECORD LOCKS space id 224 page no 4 n bits 80 index uk_stu_id of table `testdb`.`test_tb` trx id 46914 lock_mode X locks rec but not gap
Record lock, heap no 7 PHYSICAL RECORD: n_fields 2; compact format; info bits 0
 0: len 4; hex 800003ee; asc     ;;
 1: len 4; hex 80000006; asc     ;;
 
*** (2) WAITING FOR THIS LOCK TO BE GRANTED:
RECORD LOCKS space id 224 page no 4 n bits 80 index uk_stu_id of table `testdb`.`test_tb` trx id 46914 lock_mode X locks rec but not gap waiting
Record lock, heap no 6 PHYSICAL RECORD: n_fields 2; compact format; info bits 0
 0: len 4; hex 800003ed; asc     ;;
 1: len 4; hex 80000005; asc     ;;
#上面这部分是事务二正在等待的锁,从信息上看,等待的是同一个表,同一个索引,同一个page上的record lock X锁,但是heap no位置不同,即不同的行上的锁
 
*** WE ROLL BACK TRANSACTION (2) #表示事务2被回滚

从死锁日志中可以看到关联的两个事务相关信息,当一个事务持有了其他事务需要的锁,同时又想获得其他事务持有的锁时,等待关系上就会产生循环,Innodb 不会显示所有持有和等待的锁,但死锁日志也显示了相关的信息来帮你确定,排查死锁发生的索引,这对于你确定能否避免死锁有较大的价值。

2.自动保存死锁日志

从上面内容我们知道 MySQL 的死锁可以通过 show engine innodb status 来查看,但是这个命令需要手动执行并且只能显示最新的一条死锁,该方式无法完全捕获到系统发生的死锁信息。那有没有办法记录所有的死锁日志呢,我们来看下 MySQL 的系统参数。

MySQL 系统内部提供一个 innodb_print_all_deadlocks 参数,该参数默认是关闭的,开启后可以将死锁信息自动记录到 MySQL 的错误日志中。下面我们来看下这个参数的作用:

# 查看参数是否开启
mysql> show variables like 'innodb_print_all_deadlocks';
+----------------------------+-------+
| Variable_name              | Value |
+----------------------------+-------+
| innodb_print_all_deadlocks | OFF   |
+----------------------------+-------+
 
# 开启innodb_print_all_deadlocks,此参数是全局参数,可以动态调整。记得要加入到配置文件中
mysql> set global innodb_print_all_deadlocks = 1;
Query OK, 0 rows affected (0.00 sec)
 
mysql> show variables like 'innodb_print_all_deadlocks';
+----------------------------+-------+
| Variable_name              | Value |
+----------------------------+-------+
| innodb_print_all_deadlocks | ON    |
+----------------------------+-------+

建议将 innodb_print_all_deadlocks 参数设置为 1 ,这样每次发生死锁后,系统会自动将死锁信息输出到错误日志中,需要注意的是打开此参数后,只会记录死锁部分信息而不会记录 innodb 其他相关信息,即只会记录 show engine innodb status 中的 LATEST DETECTED DEADLOCK 部分。

其实 InnoDB 存储引擎还提供有 InnoDB Monitor 监视器,可以定期将 InnoDB 的状态信息输出到错误日志中,主要由 innodb_status_output 和 innodb_status_output_locks 参数控制,这两个系统变量是用来启用标准 InnoDB 监控和 InnoDB 锁监控的,开启后会将监控结果输出错误日志中,大约每隔 15 秒产生一次输出,输出内容与 show engine innodb status 一致。不过这会导致错误日志暴增,一般不建议开启这两个参数。

总结:

本篇文章介绍了 MySQL 死锁日志的获取方法,发生死锁后,可以根据死锁日志还获取相关信息。开启 innodb_print_all_deadlocks 参数可以自动将死锁信息输出到错误日志中,有助于我们及时发现并处理死锁异常。www.linuxprobe.com

<think>我们正在分析MySQL死锁日志中的RECORD LOCKS部分。根据引用[1][2][3],RECORD LOCKS是行(记录)的信息,它定了索引上的特定记录。以下是如何分析死锁日志中的RECORD LOCKS部分以定位死锁原因: ### 1. **理解RECORD LOCKS日志结构** 在`SHOW ENGINE INNODB STATUS`输死锁日志中,`RECORD LOCKS`部分通常包含以下关键信息: ``` RECORD LOCKS space id 0 page no 46 n bits 72 index PRIMARY of table `test`.`t1` trx id 246047 lock_mode X locks rec but not gap ``` - **space id**:空间ID(0示系统空间)。 - **page no**:数据页编号(定位所在的物理页)。 - **n bits**:位图中的位数(用于管理的位图大小)。 - **index**:所在的索引(如`PRIMARY`示主键索引,`idx_user_id`示二级索引)。 - **table**:涉及的(格式为`` `数据库名`.`名` ``)。 - **trx id**:持有或等待的事务ID。 - **lock_mode**:模式,常见值: - `X`:排他(其他事务不能读写)。 - `S`:共享(其他事务可读不可写)。 - **范围类型**: - `locks rec but not gap`:仅定记录本身(记录)。 - `locks gap before rec`:定记录前的间隙(间隙)。 - `locks gap and rec`:定记录及间隙(临键)[^1][^2]。 ### 2. **分析死锁链** 死锁日志会展示两个事务(TRANSACTION 1和TRANSACTION 2)相互等待的情况: - **`WAITING FOR THIS LOCK`**:示事务正在等待获取某个。 - **`HOLDS THE LOCK(S)`**:示事务当前持有的。 **示例分析**(简化日志): ``` *** (1) TRANSACTION: TRANSACTION 12345, ACTIVE 0 sec inserting LOCK WAIT 2 lock struct(s) RECORD LOCKS ... index PRIMARY ... lock_mode X locks rec but not gap waiting // 等待主键X *** (1) WAITING FOR THIS LOCK: RECORD LOCKS ... index PRIMARY ... lock_mode X locks rec but not gap *** (2) TRANSACTION: TRANSACTION 12346, ACTIVE 0 sec updating HOLDS THE LOCK(S): RECORD LOCKS ... index PRIMARY ... lock_mode X locks rec but not gap // 持有主键X WAITING FOR THIS LOCK: RECORD LOCKS ... index idx_user_id ... lock_mode X // 等待二级索引X ``` **解读**: 1. 事务1(12345)正在等待主键索引上的排他记录(`lock_mode X locks rec but not gap`)。 2. 事务2(12346)持有该主键,但同时等待二级索引`idx_user_id`上的排他。 3. **死锁原因**:事务2持有事务1需要的,而事务1可能持有事务2需要的其他日志未完整展示时需结合其他部分)[^3]。 ### 3. **定位冲突操作** - **步骤1:确认竞争的资源** 对比两个事务的`RECORD LOCKS`信息,找到相同的`space id`、`page no`、`index`和记录(如主键值)。 - **步骤2:还原SQL执行顺序** 根据事务的SQL语句(日志末尾会打印)和等待关系,推断死锁场景: ```sql -- 事务1执行: INSERT INTO t1 (id, name) VALUES (10, 'Alice'); -- 尝试获取id=10的X -- 事务2执行: UPDATE t1 SET name = 'Bob' WHERE id = 10; -- 持有id=10的X,同时需要更新其他索引 ``` 若事务2更新时还需定二级索引,而事务1的插入恰好阻塞了对二级索引的操作,则形成死锁[^4]。 ### 4. **解决方案** - **调整索引**:确保所有写操作都使用索引查询,避免全扫描升级为。 - **统一操作顺序**:所有事务按相同顺序访问和行(如先按主键排序再更新)。 - **减少事务粒度**:将长事务拆分为短操作,及时提交。 ### 示例:死锁日志完整分析流程 假设日志如下: ``` ------------------------ LATEST DETECTED DEADLOCK ------------------------ *** (1) TRANSACTION: TRANSACTION 12345, ACTIVE 0 sec inserting mysql tables in use 1, locked 1 LOCK WAIT 3 lock struct(s), heap size 1136, 2 row lock(s) MySQL thread id 1001, OS thread handle 0x7f8a5c0b6700, query id 2001 localhost root update INSERT INTO orders (order_id, user_id) VALUES (100, 200) *** (1) WAITING FOR THIS LOCK TO BE GRANTED: RECORD LOCKS space id 10 page no 5 n bits 72 index `PRIMARY` of table `db`.`orders` trx id 12345 lock_mode X locks rec but not gap waiting *** (2) TRANSACTION: TRANSACTION 12346, ACTIVE 0 sec updating mysql tables in use 1, locked 1 3 lock struct(s), heap size 1136, 2 row lock(s), undo log entries 1 MySQL thread id 1002, OS thread handle 0x7f8a5c0b6800, query id 2002 localhost root update UPDATE orders SET amount=100 WHERE user_id=200 *** (2) HOLDS THE LOCK(S): RECORD LOCKS space id 10 page no 5 n bits 72 index `PRIMARY` of table `db`.`orders` trx id 12346 lock_mode X locks rec but not gap *** (2) WAITING FOR THIS LOCK TO BE GRANTED: RECORD LOCKS space id 10 page no 7 n bits 80 index `idx_user_id` of table `db`.`orders` trx id 12346 lock_mode X waiting ``` **分析**: 1. **事务1**:插入新订单(`order_id=100`),需要获取主键100的X,但被阻塞(`WAITING`)。 2. **事务2**:更新`user_id=200`的订单,持有某条记录的主键X(`HOLDS THE LOCK`),同时需要获取`idx_user_id`索引上的X(`WAITING`)。 3. **死锁链**: - 事务2持有主键X(假设是主键200),但需要`idx_user_id`索引。 - 事务1的插入操作可能涉及`idx_user_id`索引(因`user_id=200`),先获取了该索引的,进而阻塞事务2。 - 同时事务1需要主键100的(可能被事务2间接阻塞)。 4. **根本原因**:两个事务对主键索引和二级索引的加顺序不一致。 **优化方案**: - 为`user_id`添加索引(若已存在则检查是否有效)。 - 代码中保证对`orders`的操作先按主键排序再执行。 > **提示**:实际分析需结合结构和SQL语句[^1][^3]。 --- ### 相关问题 1. 如何通过`EXPLAIN`命令分析SQL语句是否会引发全扫描? 2. 间隙(Gap Lock)在死锁日志中如何示? 3. 除了调整索引,还有哪些方法可以避免死锁? 4. 如何监控MySQL中的死锁发生频率?</think>### 解读MySQL死锁日志中的RECORD LOCKS信息MySQL死锁日志中,`RECORD LOCKS`部分揭示了事务持有的类型、定位置和模式,是分析死锁原因的核心。以下是关键信息的解读方法: --- #### 1. **基础结构解析** ```log RECORD LOCKS space id 0 page no 46 n bits 72 index PRIMARY of table `test`.`t1` trx id 246047 lock_mode X locks rec but not gap ``` - **`space id 0`**:空间ID(0示系统空间) - **`page no 46`**:数据页编号(定位的物理位置) - **`n bits 72`**:位图中的位数(管理的位图大小) - **`index PRIMARY`**:所在的索引(`PRIMARY`示主键索引) - **`table test.t1`**:涉及的(`test`库的`t1`) - **`trx id 246047`**:持有的事务ID - **`lock_mode X`**:模式(`X`=排他,`S`=共享) - **`locks rec but not gap`**:范围类型(见下)[^1][^2] --- #### 2. **范围类型详解** | **类型** | **日志标识** | **作用范围** | **典型场景** | |--------------------------|----------------------------|---------------------------------------|----------------------------------| | **记录** | `locks rec but not gap` | 仅定单行记录 | `SELECT ... FOR UPDATE`精确匹配 | | **间隙** | `locks gap before rec` | 定记录前的区间(不包含记录本身) | 范围查询`WHERE id > 100` | | **临键**(Next-Key) | `locks gap and rec` | 定记录+前间隙(默认) | 事务隔离级别`REPEATABLE READ` | --- #### 3. **死锁分析四步法** 1. **定位冲突资源** 对比两个事务的`RECORD LOCKS`,找到相同的`space id` + `page no` + `index`组合 *示例:两个事务都在`page no 46`上等待* 2. **分析等待链** - `HOLDS THE LOCK(S)`:事务当前持有的 - `WAITING FOR THIS LOCK`:事务阻塞等待的 ```log TRANSACTION 1: HOLDS LOCK -> index PRIMARY (page 46) // 持有主键 WAITING -> index idx_user_id (page 50) // 等待二级索引 TRANSACTION 2: HOLDS LOCK -> index idx_user_id (page 50) // 持有二级索引 WAITING -> index PRIMARY (page 46) // 等待主键 ``` *死锁原因:事务1和2形成资源循环等待*[^3] 3. **结合SQL还原场景** 检查日志末尾导致死锁的SQL: ```sql -- 事务1执行: UPDATE orders SET amount=100 WHERE id=10; -- 持有主键,需要更新二级索引 -- 事务2执行: UPDATE orders SET status=1 WHERE user_id=5; -- 持有user_id索引,需要更新主键 ``` 4. **验证模式冲突** - 排他(`X`)与任何互斥 - 共享(`S`)仅与`X`互斥 *若事务1持有`X`,事务2尝试获取同行的`X/S`都会阻塞* --- #### 4. **典型案例解析 **案例:并发插入导致死锁** ```log -- 事务1日志: RECORD LOCKS ... index PRIMARY ... lock_mode X locks gap before rec insert intention waiting -- 事务2日志: RECORD LOCKS ... index PRIMARY ... lock_mode X locks gap before rec ``` **原因分析**: 1. 事务1尝试在间隙中插入数据(`insert intention`) 2. 事务2持有同一间隙的间隙(`gap lock`) 3. 间隙与插入意向冲突导致死锁 **解决方案**: - 降低隔离级别为`READ COMMITTED`(禁用间隙) - 或使用唯一索引避免间隙[^2] --- ### 优化建议 1. **索引优化** 为所有WHERE条件列添加索引,避免全扫描升级为 ```sql ALTER TABLE t1 ADD INDEX idx_user_id(user_id); ``` 2. **事务拆分** 将大事务拆分为小操作,减少持有时间 ```java // 错误做法(长事务) @Transactional void processOrder() { updateInventory(); // 耗时操作 insertPayment(); // 持有时间过长 } ``` 3. **检测重试** ```java try { executeTransaction(); } catch (MySQLTransactionRollbackException e) { if (e.getErrorCode() == 1213) { // 死锁错误码 Thread.sleep(50); retry(); // 指数退避重试 } } ``` > **关键提示**:完整分析需结合`SHOW ENGINE INNODB STATUS`输的`LATEST DETECTED DEADLOCK`部分[^1][^3]。 --- ### 相关问题 1. 如何通过`EXPLAIN`命令分析SQL语句的潜在行为? 2. 间隙(Gap Lock)在哪些场景下会导致死锁?如何避免? 3. 除了重试机制,还有哪些分布式事务方案可解决MySQL死锁问题? 4. 如何监控MySQL中的死锁发生频率和影响范围?
评论
添加红包

请填写红包祝福语或标题

红包个数最小为10个

红包金额最低5元

当前余额3.43前往充值 >
需支付:10.00
成就一亿技术人!
领取后你会自动成为博主和红包主的粉丝 规则
hope_wisdom
发出的红包
实付
使用余额支付
点击重新获取
扫码支付
钱包余额 0

抵扣说明:

1.余额是钱包充值的虚拟货币,按照1:1的比例进行支付金额的抵扣。
2.余额无法直接购买下载,可以购买VIP、付费专栏及课程。

余额充值