《叶问》34期，延迟从库加上MASTER_DELAY，主库宕机后如何快速恢复服务

柔光的暖阳◎ 2022-10-07 15:50 148阅读 0赞

本文首发于「GreatSQL社区」。

> 当主库宕机后，延迟从库如何才能"取消"主动延迟，以便恢复服务？

## 问题描述 ##

本问题来自一位群友，他遇到的情况我简单归纳一下：

*  实例A是主库，B是延迟从库（设置了延迟7200秒）。
 *  当A挂掉后（已无法连接，或无法启动），希望用B提升成主库。
 *  但是在B上执行 `change master to MASTER_DELAY=0` 后，B上已经保存的7200秒的relay文件也会被清除掉，并尝试再次从A获取binlog，这样会造成7200秒的数据丢失，未能达成目的。

TA想问：在这样的场景下，还有办法让B库尽快跑完这7200秒延迟数据吗，或者正确的办法是什么呢？

## 问题解决 ##

先回答问题：这个需求是有办法达成的（而且还不只一种方法），最正确的方法也并不麻烦/复杂（看到最后），只不过有些小窍门要注意下。

### 方法1，修改系统时间 ###

也就是修改B主机的系统时间，将其往后调整超过7200秒，然后重启slave线程，就能让**SQL\_THREAD**继续应用relay log了。所有relay log应用完毕后，再将系统时间修改回来。

# 修改系统时间，增加7200秒
    [root@yejr.run]# date -s "`date --date '7200 second'`"
    
    # 重启slave线程
    [root@yejr.run](none)>  STOP SLAVE; START SLAVE;

这种方法（潜在）影响很大，可能对其他系统应用有影响，或者MySQL里部分涉及到日期时间的结果也会受到影响，**非常不推荐**。

## 方法2，自行手动恢复relay log/binlog ##

当主库（A）宕机后，查看当前slave的状态：

[root@yejr.run](none)> SHOW SLAVE STATUS\G
    ...
                  Master_Log_File: binlog.000011
              Read_Master_Log_Pos: 2671
                   Relay_Log_File: relay-bin.000005
                    Relay_Log_Pos: 361
            Relay_Master_Log_File: binlog.000011
                 Slave_IO_Running: Connecting
                Slave_SQL_Running: Yes
    ...
              Exec_Master_Log_Pos: 746
                  Relay_Log_Space: 2704
    ...
            Seconds_Behind_Master: 387
    ...
                        SQL_Delay: 7200
              SQL_Remaining_Delay: 6814
          Slave_SQL_Running_State: Waiting until MASTER_DELAY seconds after master executed event

可以看到这时候有387秒的落后，主动延迟7200秒，还有6814秒之后才能应用最新的relay log。虽然事务有延迟，但其实slave已经把binlog都复制过来了，在relay log里。

Read_Master_Log_Pos: 2671  <-- 已读取到最新的binlog了，pos = 2671
                   Relay_Log_File: relay-bin.000005  <-- 对应的relay log
                    Relay_Log_Pos: 361  <-- 对应的relay log pos
    ...
              Exec_Master_Log_Pos: 746  <-- 但只apply到 pos = 746

现在，只需要手动把这中间的差异数据拿出来apply就可以了。解析relay log，找到对应master binlog pos = 746的位置，或者直接指定realy log pos = 361的位置也可以：

[root@yejr.run]# ls -la relay-bin.*
    -rw-r----- 1 mysql mysql  418 Jun 13 13:31 relay-bin.000004
    -rw-r----- 1 mysql mysql 2286 Jun 13 13:33 relay-bin.000005
    -rw-r----- 1 mysql mysql   58 Jun 13 13:31 relay-bin.index
    
    [root@yejr.run]# mysqlbinlog --base64-output=decode-rows -vvv relay-bin.000005
    ...
    # at 196
    #700101  8:00:00 server id 5001  end_log_pos 0 CRC32 0xaf7e0f79         Rotate to binlog.000011  pos: 746
    # at 240
    #210613 11:26:08 server id 5001  end_log_pos 0 CRC32 0xfa7fd769         Start: binlog v 4, server v 8.0.22-13 created 210613
     11:26:08
    # at 361
    #210613 13:33:41 server id 5001  end_log_pos 825 CRC32 0xd5161853       GTID    last_committed=1        sequence_number=3
           rbr_only=yes    original_committed_timestamp=1623562421106412   immediate_commit_timestamp=1623562421106412     transaction_length=275
    ...

确认对应的事务是存在的，接下来就可以利用relay log恢复数据了。

[root@yejr.run]# mysqlbinlog relay-bin.000005 --start-position=361 | mysql -S./mysql.sock -f

当然了，如果此时A主机还可以连接，只是mysqld服务无法启动的话，亦可直接用A主机上的binlog进行恢复。

这种方法需要细心谨慎，手眼配合密切，容易出错，**因此也不推荐**。

### 方法3，正确理解MASTER\_DELAY，一键搞定 ###

前面铺垫了那么多，看起来想要让延迟从库快速恢复好像有点麻烦的样子。

事实上，只要正确理解，一键命令就搞定了。

当主库发生故障宕机后，binlog其实已经都复制到从库并写入成relay log了。当然了，为避免误操作，建议先备份relay log。

接下来的操作很重要，看准了，一定不要做错：

# 只关闭SQL_THREAD，而不是直接关闭整个SLAVE服务
    [root@yejr.run](none)> STOP SLAVE SQL_THREAD;
    
    # 修改MASTER_DELAY，使之不再延迟
    [root@yejr.run](none)> CHANGE MASTER TO MASTER_DELAY=0;
    
    # 再次启动SQL_THREAD
    [root@yejr.run](none)> START SLAVE SQL_THREAD;

主库虽然宕机了，但从库上只有**IO\_THREAD**会报告连接错误，**SQL\_THREAD**还是可以正常工作的。

上述操作的关键点在于，**修改 MASTER\_DELAY 时并没有先停掉 IO\_THREAD，否则会清空所有的relay log，尝试去主库再次拉取**。

再次启动 **SQL\_THREAD** 之后，从库就会继续应用relay log，待到全部应用完毕后，完成必要的数据校验，即可提成成为新的主库，对外提供服务了。

看，真的挺简单的吧。

现在来验证下：**完全停掉SLAVE服务后修改MASTER\_DELAY值，再启动SLAVE服务，此时会清空重置relay log**。

# 主库宕机后，查看SLAVE状态
    [root@yejr.run](none)> SHOW SLAVE STATUS\G
    ...
                  Master_Log_File: binlog.000017
              Read_Master_Log_Pos: 471
                   Relay_Log_File: relay-bin.000002
                    Relay_Log_Pos: 321
            Relay_Master_Log_File: binlog.000017
                 Slave_IO_Running: Connecting
                Slave_SQL_Running: Yes
    ...
              Exec_Master_Log_Pos: 196
    ...
            Seconds_Behind_Master: 69
    ...
                        SQL_Delay: 7200
              SQL_Remaining_Delay: 7132
          Slave_SQL_Running_State: Waiting until MASTER_DELAY seconds after master executed event
    ...
    
    # 查看relay log状态
    [root@yejr.run]# ls -la relay-bin.*
    -rw-r----- 1 mysql mysql 213 Jun 13 15:11 relay-bin.000001
    -rw-r----- 1 mysql mysql 596 Jun 13 15:11 relay-bin.000002
    -rw-r----- 1 mysql mysql  58 Jun 13 15:11 relay-bin.index
    
    # 关闭SLAVE服务，修改MASTER_DELAY，再启动SLAVE服务
    [root@yejr.run](none)> STOP SLAVE; CHANGE MASTER TO MASTER_DELAY=0; START SLAVE;
    
    # 再次查看relay log，发现被清空重置了
    [root@yejr.run]# ls -la relay-bin.*
    -rw-r----- 1 mysql mysql 156 Jun 13 15:18 relay-bin.000001
    -rw-r----- 1 mysql mysql  29 Jun 13 15:18 relay-bin.index

所以，请记住了，**当延迟从库要修改延迟设置时，只需重启SQL\_THREAD，千万别图省事重启整个SLAVE服务，这样relay log就不会被清空重置了，也就能实现快速恢复并提升为主库。为以防万一，也请务必备份好relay log**。

因为relay log是由 **IO\_THREAD** 负责的，所以只要 **IO\_THREAD** 不重启，就不会清空重置。看下MySQL文档中关于relay log的说明：

#原文出处 https://dev.mysql.com/doc/refman/8.0/en/replica-logs.html
    
    The replica's relay log, which is written by the replication I/O thread, contains the transactions read from the replication source server's binary log. The transactions in the relay log are applied on the replica by the replication SQL thread. For information about the relay log, see Section 17.2.4.1, “The Relay Log”.

P.S，本文使用的GreatSQL 8.0.22-13，关于这个版本的说明详见 [GreatSQL，打造更好的MGR生态][GreatSQL_MGR]。

Enjoy MySQL :)

## 延伸阅读 ##

*  13.4.2.1 CHANGE MASTER TO Statement, https://dev.mysql.com/doc/refman/8.0/en/change-master-to.html
 *  17.2.4 Relay Log and Replication Metadata Repositories, https://dev.mysql.com/doc/refman/8.0/en/replica-logs.html
 *  17.4.11 Delayed Replication, https://dev.mysql.com/doc/refman/8.0/en/replication-delayed.html

--------------------

**文章推荐：**

*  [《叶问》33期，MGR最佳配置参考，PFS里的监测指标要全开吗，mysqld进程占用内存过高怎么排查][33_MGR_PFS_mysqld]
 *  [binlog server伪装master恢复增量数据][binlog server_master]
 *  [从库Seconds\_Behind\_Master延迟总结][Seconds_Behind_Master]
 *  [MySQL 复制延迟 Seconds\_Behind\_Master 究竟是如何计算的][MySQL _ Seconds_Behind_Master]  
    
 *  [MySQL MGR看着很美，却又为什么不敢用？][MySQL MGR]
 *  [GreatSQL MGR优化参考][GreatSQL MGR]
 *  [GreatSQL，打造更好的MGR生态][GreatSQL_MGR 1]

--------------------

点击文末“**阅读原文**”直达「叶问」专栏

[GreatSQL_MGR]: https://mp.weixin.qq.com/s?__biz=MzkzMTIzMDgwMg%3D%3D&idx=1&mid=2247483656&scene=21&sn=ca60b3875450cd3dfaad3519b12c9dcb#wechat_redirect
[33_MGR_PFS_mysqld]: http://mp.weixin.qq.com/s?__biz=MjM5NzAzMTY4NQ%3D%3D&chksm=bd3b436b8a4cca7ddf138db1d2342aa19f0452bff97beb2f5015cf0eb377a7d2a6899d1c3c05&idx=1&mid=2653935873&scene=21&sn=7511853d63145b7d72ae533586b6ad81#wechat_redirect
[binlog server_master]: http://mp.weixin.qq.com/s?__biz=MjM5NzAzMTY4NQ%3D%3D&chksm=bd3b4eb08a4cc7a6f46de41fe64e8eadbb55f93c514361c611c469adad369fac3a5b2b53f35f&idx=1&mid=2653934810&scene=21&sn=581f4562a5e5bc661946cfab2dda98c5#wechat_redirect
[Seconds_Behind_Master]: http://mp.weixin.qq.com/s?__biz=MjM5NzAzMTY4NQ%3D%3D&chksm=bd3b57588a4cde4e53742bc8160cd1602e73951bcd13f0c2d33c157a76db834ec2575ada690b&idx=1&mid=2653932850&scene=21&sn=722402793ebba0e7e8790bc9bd48813e#wechat_redirect
[MySQL _ Seconds_Behind_Master]: http://mp.weixin.qq.com/s?__biz=MjM5NzAzMTY4NQ%3D%3D&chksm=bd3b518d8a4cd89b8b5a4e5a97b8d55cc3cf179b767665ee2661991207baa5e74be4ef88fa2e&idx=1&mid=2653932519&scene=21&sn=e018ea5f3bc86f8a6862a35c4b805652#wechat_redirect
[MySQL MGR]: http://mp.weixin.qq.com/s?__biz=MjM5NzAzMTY4NQ%3D%3D&chksm=bd3b42b28a4ccba4699c1557d0f3ad0eeeb59cb9b0464fa4f008b46a80c66440e31353ccccd6&idx=1&mid=2653935832&scene=21&sn=87057f4f6837b70cd9a778d7b10381d1#wechat_redirect
[GreatSQL MGR]: http://mp.weixin.qq.com/s?__biz=MjM5NzAzMTY4NQ%3D%3D&chksm=bd3b42c78a4ccbd1d08d39f6869bfd01dca3645e5096e419ab35474c261317c71d55876a6543&idx=1&mid=2653935789&scene=21&sn=936dfa64b0e2e957bd23086c0212d8e9#wechat_redirect
[GreatSQL_MGR 1]: http://mp.weixin.qq.com/s?__biz=MjM5NzAzMTY4NQ%3D%3D&chksm=bd3b42fd8a4ccbebac385c47daf7bca40415b09b1298b6b1b7fc0c7822d147ab157ba35e7d03&idx=1&mid=2653935767&scene=21&sn=3f396b10f61629f6a09f29e364dc260b#wechat_redirect