【MySQL】MySQL从库延迟排查一例

前言:周末春游的时候收到短信报警,从库延迟很高。手机VPN连进数据库以后排查情况,看到cpu使用率、磁盘IO、以及其他资源占用也不高。

一、登录数据库查看状态

MariaDB [trswcmtest]> show processlist;
+---------+-------------------+---------------------+------------+---------+------+-----------------------------------------------+------------------------------------------------------------------------------------------------------+----------+
| Id      | User              | Host                | db         | Command | Time | State                                         | Info                                                                                                 | Progress |
+---------+-------------------+---------------------+------------+---------+------+-----------------------------------------------+------------------------------------------------------------------------------------------------------+----------+
| 3769833 | system user       |                     | NULL       | Connect | 4484 | Waiting for master to send event              | NULL                                                                                                 |    0.000 |
| 3769885 | trs               | 10.200.74.146:63067 | trswcmtest | Sleep   | 4404 |                                               | NULL                                                                                                 |    0.000 |
| 3770353 | root              | localhost           | trswcmtest | Query   |    0 | init                                          | show processlist                                                                                     |    0.000 |
| 3770655 | system user       |                     | trswcmtest | Connect |    0 | updating                                      | update xxx set xxx=6925613 where xxx= 6925613                    |    0.000 |
| 3770656 | system user       |                     | trswcmtest | Connect |    0 | updating                                      | update xxxx set xxx=0,xxx=0,xxx=0,xxx='' where Me |    0.000 |
| 3770657 | trs               | %                   | trswcmtest | Connect |    0 | Sending data                                  | UPDATE xxxx SET xxx='<br>uwbdhlnqvybejm&nbsp;(d:\\temp\\收到附件,      |    0.000 |
| 3770658 | system user       |                     | trswcmtest | Connect |    0 | updating                                      | update xxxx set xxx=1032, xxx='system', xxx='2018-03-31 12:08:38' where xxx|    0.000 |
| 3770659 | system user       |                     | NULL       | Connect |    0 | Waiting for prior transaction to commit       | NULL                                                                                                 |    0.000 |
| 3770660 | system user       |                     | trswcmtest | Connect |    0 | updating                                      | UPDATE xxxx SET  xxx=1032,xxx='2018-03-31 12:08:38' where xxx=7150769             |    0.000 |
| 3770661 | system user       |                     | NULL       | Connect |    0 | Waiting for prior transaction to commit       | NULL                                                                                                 |    0.000 |
| 3770662 | system user       |                     | NULL       | Connect |    0 | Waiting for prior transaction to commit       | NULL                                                                                                 |    0.000 |
| 3770663 | system user       |                     | NULL       | Connect | 1583 | Waiting for room in worker thread event queue | 

二、原因分析

从上面看到,进程3770663一直处于Waiting for room in worker thread event queue的状态,因为该从库开启了并行复制,查阅MariaDB官方文档了解到执行 Replication 时,会有两个 Thread,一个是 SQL_THREAD,另一个是 IO_THREAD,顾名思义,SQL_THREAD 就是处理SQL 作业的 Thread,IO_THREAD 就是管理Binlog 从 Master 拿来然后回放在自己的 Relay Log 的 Thread。

  • 在没有启用并行复制时,sql线程就自己分配给自己,也因为没法先看一下Binlog后面的事务,也许后面可以先做的,但是还是得一个一个回放。

  • 当有并行复制时,sql线程除了自己变成分配工作的线程以外,会产生出slave_parallel_threads数量的线程来处理事务,在分配工作时就知道哪些事务没有顺序关系,哪些有一定的顺序,这样回放就会快得多。
    但是怎么会出现 Waiting for room in worker thread event queue.呢?
    从官方文档 slave-parallel-max-queued

文章看一半就不会注意到这个参数,如果你的事务在每个slave-parallel-max-queued大小的Transation Logs都能被解析,这样就有助于平行处理,但是如果无法解析,那就执行等到预读先做完,有空间了再读后面的Log并且继续执行,这样可能平行处理的顺序会被打乱。

所以适当地设定 slave-parallel-max-queued是必须的,但是它跟 slave_parallel_threads的使用是有关系的
slave_parallel_threads * slave_parallel_max_queued 为占用的总内存,如果太大会造成OOM,我这里设置的128M,后续再进行观察。

©著作权归作者所有,转载或内容合作请联系作者
  • 序言:七十年代末,一起剥皮案震惊了整个滨河市,随后出现的几起案子,更是在滨河造成了极大的恐慌,老刑警刘岩,带你破解...
    沈念sama阅读 204,921评论 6 478
  • 序言:滨河连续发生了三起死亡事件,死亡现场离奇诡异,居然都是意外死亡,警方通过查阅死者的电脑和手机,发现死者居然都...
    沈念sama阅读 87,635评论 2 381
  • 文/潘晓璐 我一进店门,熙熙楼的掌柜王于贵愁眉苦脸地迎上来,“玉大人,你说我怎么就摊上这事。” “怎么了?”我有些...
    开封第一讲书人阅读 151,393评论 0 338
  • 文/不坏的土叔 我叫张陵,是天一观的道长。 经常有香客问我,道长,这世上最难降的妖魔是什么? 我笑而不...
    开封第一讲书人阅读 54,836评论 1 277
  • 正文 为了忘掉前任,我火速办了婚礼,结果婚礼上,老公的妹妹穿的比我还像新娘。我一直安慰自己,他们只是感情好,可当我...
    茶点故事阅读 63,833评论 5 368
  • 文/花漫 我一把揭开白布。 她就那样静静地躺着,像睡着了一般。 火红的嫁衣衬着肌肤如雪。 梳的纹丝不乱的头发上,一...
    开封第一讲书人阅读 48,685评论 1 281
  • 那天,我揣着相机与录音,去河边找鬼。 笑死,一个胖子当着我的面吹牛,可吹牛的内容都是我干的。 我是一名探鬼主播,决...
    沈念sama阅读 38,043评论 3 399
  • 文/苍兰香墨 我猛地睁开眼,长吁一口气:“原来是场噩梦啊……” “哼!你这毒妇竟也来了?” 一声冷哼从身侧响起,我...
    开封第一讲书人阅读 36,694评论 0 258
  • 序言:老挝万荣一对情侣失踪,失踪者是张志新(化名)和其女友刘颖,没想到半个月后,有当地人在树林里发现了一具尸体,经...
    沈念sama阅读 42,671评论 1 300
  • 正文 独居荒郊野岭守林人离奇死亡,尸身上长有42处带血的脓包…… 初始之章·张勋 以下内容为张勋视角 年9月15日...
    茶点故事阅读 35,670评论 2 321
  • 正文 我和宋清朗相恋三年,在试婚纱的时候发现自己被绿了。 大学时的朋友给我发了我未婚夫和他白月光在一起吃饭的照片。...
    茶点故事阅读 37,779评论 1 332
  • 序言:一个原本活蹦乱跳的男人离奇死亡,死状恐怖,灵堂内的尸体忽然破棺而出,到底是诈尸还是另有隐情,我是刑警宁泽,带...
    沈念sama阅读 33,424评论 4 321
  • 正文 年R本政府宣布,位于F岛的核电站,受9级特大地震影响,放射性物质发生泄漏。R本人自食恶果不足惜,却给世界环境...
    茶点故事阅读 39,027评论 3 307
  • 文/蒙蒙 一、第九天 我趴在偏房一处隐蔽的房顶上张望。 院中可真热闹,春花似锦、人声如沸。这庄子的主人今日做“春日...
    开封第一讲书人阅读 29,984评论 0 19
  • 文/苍兰香墨 我抬头看了看天上的太阳。三九已至,却和暖如春,着一层夹袄步出监牢的瞬间,已是汗流浃背。 一阵脚步声响...
    开封第一讲书人阅读 31,214评论 1 260
  • 我被黑心中介骗来泰国打工, 没想到刚下飞机就差点儿被人妖公主榨干…… 1. 我叫王不留,地道东北人。 一个月前我还...
    沈念sama阅读 45,108评论 2 351
  • 正文 我出身青楼,却偏偏与公主长得像,于是被迫代替她去往敌国和亲。 传闻我的和亲对象是个残疾皇子,可洞房花烛夜当晚...
    茶点故事阅读 42,517评论 2 343

推荐阅读更多精彩内容