percona-toolkit 之 【pt-deadlock-logger】说明
摘要：
死锁：是指两个或则多个事务在同一个资源上相互占用，并请求锁定对方占用的资源，而导致恶性循环的现象；当产生死锁的时候，MySQL会回滚一个小事务的SQL，确保另一个完成。上面是死锁的概念，而在MySQL中innodb会出现死锁的情况，但是查看死锁却很不“智能”。只能通过 show engine innodb status 查看，但只保留最后一个死锁的信息，之前产生的死锁都被刷掉了。下面介绍的工具却很容易做到记录。
前提：
下载地址：wget www.percona.com/downloads/percona-toolkit/2.2.2/percona-toolkit-2.2.2.tar.gz
安装方法：perl Makefile.PL；make；make install
使用方法：
pt-deadlock-logger [OPTIONS] DSN
pt-deadlock-logger：显示指定的DSN的死锁日志信息，他能够标准输出到屏幕也可以把信息写日志文件中（--log参数）甚至可以保留到指定的表中（--dest参数），该工具默认是永久执行，除非指定--run-time 或 --iterations 。
用法：
pt-deadlock-logger --ask-pass --run-time=10 --interval=3 --create-dest-table --dest D=test,t=deadlocks u=root,P=3306,h=192.168.200.25 Enter MySQL password:
参数：
--create-dest-table ：创建指定的表。 --dest ：创建存储死锁信息的表。 --database ：-D，指定链接的数据库。 --table ：-t，指定存储的表名。 --log ：指定死锁日志信息写入到文件。 --run-time ：运行次数，默认永久 --interval ：运行间隔时间，默认30s。 u，p，h，P ：链接数据库的信息。
以上的参数，已经够用，更多的参数信息见官网说明。
测试：
运行pt-deadlock-logger，操作数据库：
session1:
root@localhost : test 04:46:11>select * from dead_tab; +----+------+------+---------+ | id | name | age | address | +----+------+------+---------+ | 1 | a | 33 | NULL | | 2 | bbb | 34 | NULL | | 3 | bbb | 35 | NULL | +----+------+------+---------+ 3 rows in set (0.00 sec) root@localhost : test 04:46:24>start transaction; Query OK, 0 rows affected (0.00 sec) root@localhost : test 04:46:31>update dead_tab set name ='A' where id >2; Query OK, 1 row affected (0.00 sec) Rows matched: 1 Changed: 1 Warnings: 0
section2:
root@localhost : test 04:46:13>start transaction; Query OK, 0 rows affected (0.01 sec) root@localhost : test 04:46:48>update dead_tab set name='AA' where id >1; ………… ………… 一直在等待着...
回到session1：
root@localhost : test 04:46:44>update dead_tab set name ='AA' where id >2; ERROR 1213 (40001): Deadlock found when trying to get lock; try restarting transaction 死锁出现了！
看pt-deadlock-logger的运行情况：
zhoujy@zhoujy:~$ pt-deadlock-logger --ask-pass --create-dest-table --dest D=test,t=deadlocks u=root,P=3306,h=192.168.200.25 Enter MySQL password: server ts thread txn_id txn_time user hostname ip db tbl idx lock_type lock_mode wait_hold victim query 192.168.200.25 2013-10-28T16:47:00 99 0 8 root localhost test dead_tab PRIMARY RECORD X w 0 update dead_tab set name='AA' where id >1 192.168.200.25 2013-10-28T16:47:00 100 0 16 root localhost test dead_tab PRIMARY RECORD X w 1 update dead_tab set name ='AA' where id >1
死锁被打印出来，看看是否写到表里：
root@localhost : test 04:32:45>select * from deadlocks\G; *************************** 1. row *************************** server: 192.168.200.25 ts: 2013-10-28 16:47:00 thread: 99 txn_id: 0 txn_time: 8 user: root hostname: localhost ip: db: test tbl: dead_tab idx: PRIMARY lock_type: RECORD lock_mode: X wait_hold: w victim: 0 query: update dead_tab set name='AA' where id >1 *************************** 2. row *************************** server: 192.168.200.25 ts: 2013-10-28 16:47:00 thread: 100 txn_id: 0 txn_time: 16 user: root hostname: localhost ip: db: test tbl: dead_tab idx: PRIMARY lock_type: RECORD lock_mode: X wait_hold: w victim: 1 query: update dead_tab set name ='AA' where id >1 2 rows in set (0.00 sec)
结果表明死锁信息已经写入到了表中，记录的内容是2条产生的sql。继续同样的步骤再执行2次出现死锁的SQL来验证是之前的死锁信息否被刷写掉：
root@localhost : test 04:53:29>select count(*) from deadlocks; +----------+ | count(*) | +----------+ | 6 | +----------+ 1 row in set (0.02 sec)
继续被写入到表中。可以看到多个产生死锁的sql，而不仅仅是最后一条产生死锁的sql。
总结：
在检查数据库是死锁信息的时候，又多了一个选择。该工具也是通过show engine innodb status的信息来计算的。在mysql 5.6.2中，innodb_print_all_deadlocks这个设置可以看到死锁的情况。
