之前写过一篇文章MySQL如何获取binlog的开始时间和结束时间^[1],文章里面介绍了如何获取MySQL数据库二进制日志（binlog）的开始时间与结束时间的一些方法。实际应用当中，我们可能还会遇到效率/性能方面的问题。最近对这个问题做了一些研究，这里就介绍一下如何快速获取MySQL二进制日志(binlog)的开始时间和结束时间。

我们下来看看当MySQL二进制日志（binlog）的Size很大的时候，获取起开始时间和结束时间，如下测试所示

$ du -sh mysql_binlog.0001051.1G    mysql_binlog.000105$ time mysqlbinlog  mysql_binlog.000105 |grep "Start: binlog" | awk -F "server id" '{print $1}'#240425  9:20:26 real    0m34.136suser    0m25.941ssys     0m11.985s
复制

从上面实验可以看出，在MySQL二进制日志（binlog）变大的情况下，这种方法需要34秒，非常低效和耗时，那么我们怎么提升性能呢？ 我们改写一下脚本，如下所示

$ time mysqlbinlog  mysql_binlog.000105 | head -10 | grep "Start: binlog" | awk -F "server id" '{print $1}'#240425  9:20:26 real    0m0.010suser    0m0.006ssys     0m0.005s
复制

如上所示，这样改进脚本后，性能效率已经提升到0.01秒，已经相当的高效了。那么获取结束时间能否也可以这样提升呢？ 很遗憾的是由于MySQL二进制日志（binlog）的结束时间/滚动时间(Rotate Time)位于文件的末尾，由于管道的一些基本特性，获取MySQL二进制日志(binlog)的结束时间无法通过上面方法来优化，这里不打算介绍Linux管道相关概念，所以我们只需知道这么一个事实。

如果你对Linux管道的一些原理不是很清楚，那么就用实验测试验证一下，如下所示：

$ time mysqlbinlog  mysql_binlog.000105  |grep Rotate | awk -F "server id" '{print $1}'#240426 11:11:37 real    0m34.223suser    0m27.202ssys     0m11.551s$ time mysqlbinlog  mysql_binlog.000105  | tail -10 | grep Rotate | awk -F "server id" '{print $1}'#240426 11:11:37 real    0m33.917suser    0m25.528ssys     0m11.395s
复制

那么怎么来优化获取MySQL二进制日志（binlog）的结束时间呢？经过一番观察与实验，我发现一个MySQL二进制日志（binlog）的结束时间，就是下一个二进制日志（binlog）的开始时间。如下实验所示

[mysql@dbtest04 bin_logs]$ ls -lrttotal 28-rw-r----- 1 mysql mysql 207 May  9 15:25 mysql_binlog.000055-rw-r----- 1 mysql mysql 207 May  9 15:27 mysql_binlog.000056-rw-r----- 1 mysql mysql 207 May 10 11:02 mysql_binlog.000057-rw-r----- 1 mysql mysql 207 May 10 11:34 mysql_binlog.000058-rw-r----- 1 mysql mysql 207 May 10 11:38 mysql_binlog.000059-rw-r----- 1 mysql mysql 157 May 10 11:38 mysql_binlog.000060-rw-r----- 1 mysql mysql 246 May 10 11:38 mysql_binlog.index[mysql@dbtest04 bin_logs]$ mysqlbinlog  mysql_binlog.000055 | head -10 | grep "Start: binlog" | awk -F "server id" '{print $1}'#240509 14:48:10 [mysql@dbtest04 bin_logs]$ mysqlbinlog  mysql_binlog.000055  |grep Rotate | awk -F "server id" '{print $1}'#240509 15:25:57 [mysql@dbtest04 bin_logs]$ mysqlbinlog  mysql_binlog.000056 | head -10 | grep "Start: binlog" | awk -F "server id" '{print $1}'#240509 15:25:57 [mysql@dbtest04 bin_logs]$ mysqlbinlog  mysql_binlog.000056  |grep Rotate | awk -F "server id" '{print $1}'#240509 15:27:37 [mysql@dbtest04 bin_logs]$ mysqlbinlog  mysql_binlog.000057 | head -10 | grep "Start: binlog" | awk -F "server id" '{print $1}'#240509 15:27:37 [mysql@dbtest04 bin_logs]$ mysqlbinlog  mysql_binlog.000057  |grep Rotate | awk -F "server id" '{print $1}'#240510 11:02:00 [mysql@dbtest04 bin_logs]$
复制

如果全部符合这个规律的话，那么我们直接用下一个binlog的开始时间作为上一个binlog的结束时间即可，于是我写了一个脚本find_binlog_start_end_time.sh:

#!/bin/bash##########################################################################################                                                                                       ## This script is used for get the binlog start time and end time                        ##                                                                                       ###########################################################################################                                                                                       ## ScriptName            :    find_binlog_start_end_time.sh                              ## Author                :    Kerry                                                      ## CreateDate            :    2024-05-10                                                 ## Email                 :    kerry2008code@qq.com                                       ##***************************************************************************************## 参数配置                                                                              ##---------------------------------------------------------------------------------------## 脚本参数   binlog文件存放的路径                                                       ##---------------------------------------------------------------------------------------## MYSQLBINLOG        mysqlbinlog的位置，以防没有设置环境变量                            ## BINLOG_BASENAME    binlog的前缀名                                                     ##---------------------------------------------------------------------------------------## 注意事项：                                                                            ##   1：如果维护的MySQL数据库都规范化安装、配置的化，下面很多参数都不需要修改            ##***************************************************************************************## Version        Modified Date            Description                                   ##***************************************************************************************## V.1.0          2024-05-10            创建此脚本                                       ########################################################################################### mysqlbinlog的路径，一般无需设置，以防没有设置环境变量时MYSQLBINLOG="/opt/mysql/mysql8.0/bin/mysqlbinlog"BINLOG_BASENAME="mysql_binlog"if [ $# = 0 ]then   echo "find_binlog_start_end_time.sh Usage:"   echo "for eg: find_binlog_start_end_time.sh  /data/mysql/binlogs"   exitfiBINLOG_FILE_PATH=$1if [ ! -d $BINLOG_FILE_PATH ];then    echo "the folder $BINLOG_FILE_PATH does not exist, please check it!"    exit 1fiindex=1start_time=""end_time=""last_binlog_name=""BINLOG_FILE_NUM=`ls -lrt $BINLOG_FILE_PATH |  grep $BINLOG_BASENAME |grep -v $BINLOG_BASENAME.index | wc -l`if [ $BINLOG_FILE_NUM -lt 1 ];then    echo "pelase check the binlog or the parameter of this script"    exit 1;ficd $BINLOG_FILE_PATHfor binlog_file in `ls -rt |  grep $BINLOG_BASENAME |grep -v $BINLOG_BASENAME.index`;  do      if [ $index -eq 1 ];then         start_time=`$MYSQLBINLOG  $binlog_file | head -10 | grep "Start: binlog" | awk -F "server id" '{print $1}'`         last_binlog_name=$binlog_file      else         end_time=`$MYSQLBINLOG  $binlog_file | head -10 | grep "Start: binlog" | awk -F "server id" '{print $1}'`         echo "file name:$last_binlog_name" , "start time:$start_time", "end time:$end_time"         if [ $index -eq $BINLOG_FILE_NUM ];then            last_end_time=`$MYSQLBINLOG  $binlog_file |tail -10 | egrep "Rotate|Stop" | awk -F "server id" '{print $1}'`            echo "file name:$binlog_file" , "start time:$end_time", "end time:$last_end_time"         else              start_time=$end_time            last_binlog_name=$binlog_file         fi       fi            let index++  done
复制

如下测试所示

[mysql@dbtest04 kerry]$ sh  find_binlog_start_end_time.sh /data/mysql/bin_logs/file name:mysql_binlog.000055 , start time:#240509 14:48:10 , end time:#240509 15:25:57 file name:mysql_binlog.000056 , start time:#240509 15:25:57 , end time:#240509 15:27:37 file name:mysql_binlog.000057 , start time:#240509 15:27:37 , end time:#240510 11:02:00 file name:mysql_binlog.000058 , start time:#240510 11:02:00 , end time:#240510 11:34:01 file name:mysql_binlog.000059 , start time:#240510 11:34:01 , end time:#240510 11:38:24 file name:mysql_binlog.000060 , start time:#240510 11:38:24 , end time:#240510 16:45:34 file name:mysql_binlog.000061 , start time:#240510 16:45:34 , end time:
复制

另外，还有一种比较高效的方法是解析二进制日志的头部信息（此篇文章统统指binlog v 4），因为binlog的头部由固定的4个字节组成，而头部信息的FORMAT_DESCRIPTION_EVENT部分包含了binlog的开始时间，我在搜索/学习相关资料时，结果发现有人已经总结过这方面的内容，而且已经有相关Python脚本或shell脚本了，这里就重复造轮子了，Python脚本来自MySQL 查询binlog生成时间^[2]我们来看看实验结果，如下所示

$ python3 check_bintime.py  /data/mysql/bin_logs/mysql_binlog.index{'file_name': 'mysql_binlog.000055', 'binlog_size': '207.0 B', 'start_time': '2024-05-09 14:48:10', 'end_time': '2024-05-09 15:25:57'}{'file_name': 'mysql_binlog.000056', 'binlog_size': '207.0 B', 'start_time': '2024-05-09 15:25:57', 'end_time': '2024-05-09 15:27:37'}{'file_name': 'mysql_binlog.000057', 'binlog_size': '207.0 B', 'start_time': '2024-05-09 15:27:37', 'end_time': '2024-05-10 11:02:00'}{'file_name': 'mysql_binlog.000058', 'binlog_size': '207.0 B', 'start_time': '2024-05-10 11:02:00', 'end_time': '2024-05-10 11:34:01'}{'file_name': 'mysql_binlog.000059', 'binlog_size': '207.0 B', 'start_time': '2024-05-10 11:34:01', 'end_time': '2024-05-10 11:38:24'}{'file_name': 'mysql_binlog.000060', 'binlog_size': '180.0 B', 'start_time': '2024-05-10 11:38:24', 'end_time': '2024-05-10 16:45:34'}{'file_name': 'mysql_binlog.000061', 'binlog_size': '157.0 B', 'start_time': '2024-05-10 16:45:34', 'end_time': 'now'}
复制

shell脚本来自一种快速取得binlog开始时间的方法^[3]:

[mysql@dbtest04 kerry]$ function getBinlogStartTime()> {>         theFile="$1">         #取出文件头做分析>         binlogHead=`hexdump ${theFile} | head -1`>         #binlog文件校验>         binlogCrc=`echo $binlogHead | awk '{print $1$2$3}'`>         if [ "${binlogCrc}" != '000000062fe6e69' ]; then>                 echo '${theFile} is damage.'>                 exit 1>         fi>         #计算binlog的开始时间>         binlogBeginTimeInt=`echo $binlogHead | awk '{print $5$4}' | gawk ' { printf strtonum("0x" $0)}' `>         binlogBeginTime=`date -d "1970-01-01 UTC $binlogBeginTimeInt seconds" "+%F %T"`>         echo $binlogBeginTime> }[mysql@dbtest04 kerry]$ getBinlogStartTime /data/mysql/bin_logs/mysql_binlog.0000552024-05-09 14:48:10
复制

不过你看其脚本也会发现，解析MySQL的binlog的头部文件，比较容易获取binlog的开始时间，而获取binlog的结束时间/轮转时间就比较麻烦了。所以python脚本中获取binlog结束时间的思路跟我的思路也是一样的。

总结：

这里介绍了两种快速获取binlog的开始时间和结束时间的两种方法，这两种方法都非常高效，至于我写的脚本find_binlog_start_end_time.sh目前还比较粗糙，后面有时间再完善补充。

参考资料