mysql二进制日志文件中同一事务的事件时间点会乱序验证

mysql> flush logs;  -- 切换日志
Query OK, 0 rows affected (0.02 sec)

mysql> show master status;
+------------------+----------+--------------+------------------+-------------------------------------------+
| File             | Position | Binlog_Do_DB | Binlog_Ignore_DB | Executed_Gtid_Set                         |
+------------------+----------+--------------+------------------+-------------------------------------------+
| mysql-bin.000008 |      195 |              |                  | 3d1b92a0-b919-11eb-87db-56c8a95977d1:1-32 |
+------------------+----------+--------------+------------------+-------------------------------------------+
1 row in set (0.00 sec)

mysql> begin;select now();   -- 开启事务
Query OK, 0 rows affected (0.00 sec)

+---------------------+
| now()               |
+---------------------+
| 2021-06-10 10:34:49 |
+---------------------+
1 row in set (0.00 sec)

mysql> update test set name='wwwwxxx' where id=2;select now();  --停留一段时间执行update，并记录时间
Query OK, 1 row affected (0.00 sec)
Rows matched: 1  Changed: 1  Warnings: 0

+---------------------+
| now()               |
+---------------------+
| 2021-06-10 10:38:42 |
+---------------------+
1 row in set (0.00 sec)

mysql> commit;select now();  -- 停留一段时间并进行commit
Query OK, 0 rows affected (0.00 sec)

+---------------------+
| now()               |
+---------------------+
| 2021-06-10 10:39:47 |
+---------------------+
1 row in set (0.00 sec)

mysql> flush logs;
Query OK, 0 rows affected (0.01 sec)

#210610 10:39:47 server id 2223306  end_log_pos 274 CRC32 0x4b5be137    GTID    last_committed=0
sequence_number=1       rbr_only=yes    original_committed_timestamp=1623292787365217   
immediate_commit_timestamp=1623292787365217     transaction_length=380
/*!50718 SET TRANSACTION ISOLATION LEVEL READ COMMITTED*//*!*/;
# original_commit_timestamp=1623292787365217 (2021-06-10 10:39:47.365217 CST)
# immediate_commit_timestamp=1623292787365217 (2021-06-10 10:39:47.365217 CST)
/*!80001 SET @@session.original_commit_timestamp=1623292787365217*//*!*/;
/*!80014 SET @@session.original_server_version=80018*//*!*/;
/*!80014 SET @@session.immediate_server_version=80018*//*!*/;
SET @@SESSION.GTID_NEXT= '3d1b92a0-b919-11eb-87db-56c8a95977d1:33'/*!*/;
# at 274
#210610 10:38:42 server id 2223306  end_log_pos 360 CRC32 0x3204f1cf    Query   thread_id=14    
exec_time=0     error_code=0
SET TIMESTAMP=1623292722/*!*/;
SET @@session.pseudo_thread_id=14/*!*/;
SET @@session.foreign_key_checks=1, @@session.sql_auto_is_null=0, @@session.unique_checks=1, 
@@session.autocommit=1/*!*/;
SET @@session.sql_mode=1168113696/*!*/;
SET @@session.auto_increment_increment=1, @@session.auto_increment_offset=1/*!*/;
/*!\C utf8mb4 *//*!*/;
SET @@session.character_set_client=255,@@session.collation_connection=255,@@session.collation_server=33/*!*/;
SET @@session.lc_time_names=0/*!*/;
SET @@session.collation_database=DEFAULT/*!*/;
/*!80011 SET @@session.default_collation_for_utf8mb4=255*//*!*/;
BEGIN
/*!*/;
# at 360
#210610 10:38:42 server id 2223306  end_log_pos 425 CRC32 0xe6c95c11    Rows_query
# update test set name='wwwwxxx' where id=2
# at 425
#210610 10:38:42 server id 2223306  end_log_pos 483 CRC32 0x4820792f    Table_map: `testdb`.`test` 
mapped to number 87
# at 483
#210610 10:38:42 server id 2223306  end_log_pos 544 CRC32 0x53d71b03    Update_rows: table id 87 
flags: STMT_END_F
### UPDATE `testdb`.`test`
### WHERE
###   @1=2 /* INT meta=0 nullable=0 is_null=0 */
###   @2='rowlog' /* VARSTRING(60) meta=60 nullable=1 is_null=0 */
### SET
###   @1=2 /* INT meta=0 nullable=0 is_null=0 */
###   @2='wwwwxxx' /* VARSTRING(60) meta=60 nullable=1 is_null=0 */
# at 544
#210610 10:39:47 server id 2223306  end_log_pos 575 CRC32 0x2c6dbb06    Xid = 67
COMMIT/*!*/;
# at 575