MySQLbinlogROWPattern analysis
## After mysql5.6, the consistency of master-slave data The requirements have become higher, and the statement format is gradually less suitable for business needs, so everyone in the production environment adopts the row mode. The row mode is an insert module that transmits the lowest data changes to transmit master-slave data. Then in binlog What is the difference between it and the ordinary statement mode? Can you see the original sql statement?
mysql> create table test1(id int,c1 varchar(20),type int,address varchar(20),create_time datetime); Query OK, 0 rows affected (0.00 sec) mysql> insert into test1 select 1,'zhangsan','1','zhangsan road No 870,floor 602',now(); ERROR 1406 (22001): Data too long for column 'address' at row 1 mysql> mysql> show create table test1; +-------+--------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+ | Table | Create Table | +-------+--------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+ | test1 | CREATE TABLE `test1` ( `id` int(11) DEFAULT NULL, `c1` varchar(20) DEFAULT NULL, `type` int(11) DEFAULT NULL, `address` varchar(20) DEFAULT NULL, `create_time` datetime DEFAULT NULL ) ENGINE=InnoDB DEFAULT CHARSET=utf8 | +-------+--------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+ 1 row in set (0.00 sec) mysql> alter table test1 modify `address` varchar(200) DEFAULT NULL; Query OK, 0 rows affected (0.03 sec) Records: 0 Duplicates: 0 Warnings: 0 mysql> insert into test1 select 1,'zhangsan','1','zhangsan road No 870,floor 602',now(); Query OK, 1 row affected (0.00 sec) Records: 1 Duplicates: 0 Warnings: 0 mysql> insert into test1 select 2,'lisi','1','zhangsan road No 870,floor 602',now(); Query OK, 1 row affected (0.01 sec) Records: 1 Duplicates: 0 Warnings: 0 mysql> |
##[root@hch_test_dbm1_121_63 binlog]# /usr /local/mysql/bin/mysqlbinlog mysql-bin.000215
…… #The preceding ones are omitted here #160722 17:02: 38 server id 62 end_log_pos 4291 CRC32 0x369e3244 Query thread_id=60 exec_time=4294967271 error_code=0SET TIMESTAMP=1469178158/*!*/;CREATE DATABASE IF NOT EXISTS `percona` /* pt-table-checksum *//*!*/;# at 4291#160722 17:02:38 server id 62 end_log_pos 5079 CRC32 0x8abc6e67 Query thread_id =60 exec_time=4294967271 error_code=0use `percona`/*!*/;SET TIMESTAMP=1469178158/*!*/;CREATE TABLE IF NOT EXISTS `percona`.`checksums` ( db char(64) NOT NULL, tbl char(64) NOT NULL, chunk int NOT NULL, chunk_time float NULL, chunk_index varchar(200) NULL, lower_boundary text NULL, upper_boundary text This_crc NULL, this_crc char( 40) NOT NULL, this_cnt int NOT NULL, master_crc NULL, master_cnt int NULL , ts timestamp NOT NULL DEFAULT CURRENT_TIMESTAMP ON UPDATE CURRENT_TIMESTAMP, PRIMARY KEY (db, tbl, chunk), INDEX ts_db_tbl (ts, db, tbl) ) ENGINE=InnoDB/*!*/;# at 5079#160820 10:21:10 server id 63 end_log_pos 5280 CRC32 0xd147bd8e Query thread_id=16 exec_time=0 error_code=0SET TIMESTAMP=1471659670/*!*/;SET @@session.sql_mode=1075838976/*!*/;GRANT ALL PRIVILEGES ON *.* TO 'tim' @'192.168%' IDENTIFIED BY PASSWORD '*2976819BD2CCD13612E03F812A2CD297C1A18B23'/*!*/;# at 5280#160820 10:22:40 server id 63 end_log_pos 5445 CRC32 0x85811be7 Query thread_id=18 exec_time=0 error_code=0use `test`/*!*/;SET TIMESTAMP=1471659760/*!*/;create table test1(id int,c1 varchar(20),type int,address varchar(20),create_time datetime)/*!*/;# at 5445 #160820 10:24:34 server id 63 end_log_pos 5580 CRC32 0x2626220c Query thread_id=18 exec_time=0 error_code=0SET TIMESTAMP=1471659874/*!*/;alter table test1 modify `address` varchar(200) DEFAULT NULL/*!*/;# at 5580 #160820 10:24:36 server id 63 end_log_pos 5660 CRC32 0x7b7c645f Query thread_id=18 exec_time=0 error_code=0 SET TIMESTAMP=1471659876/*!*/; SET @@session.time_zone='SYSTEM'/*!*/; BEGIN /*!*/; # at 5660 # at 5764 #160820 10:24:36 server id 63 end_log_pos 5821 CRC32 0x08bc94c3 Table_map: `test`.`test1` mapped to number 74 # at 5821 #160820 10:24:36 server id 63 end_log_pos 5911 CRC32 0x2f577f52 Write_rows: table id 74 flags: STMT_END_F
BINLOG ' ZL+3VxM/AAAAOQAAAL0WAAAAAEoAAAAAAAEABHRlc3QABXRlc3QxAAUDDwMPEgU8AFgCAB/DlLwI ZL+3Vx4/AAAAWgAAABcXAAAAAEoAAAAAAAEAAgAF/+ABAAAACHpoYW5nc2FuAQAAAB4Aemhhbmdz YW4gcm9hZCBObyA4NzAsZmxvb3IgNjAymZoopiRSf1cv '/*!*/; # at 5911 #160820 10:24:36 server id 63 end_log_pos 5942 CRC32 0xb26af81b Xid = 199 COMMIT/*!*/; # at 5942 #160820 10:24:48 server id 63 end_log_pos 6022 CRC32 0x09eab31d Query thread_id=18 exec_time=0 error_code=0 SET TIMESTAMP=1471659888/*!*/; BEGIN /*!*/; # at 6022 # at 6122 #160820 10:24:48 server id 63 end_log_pos 6179 CRC32 0xdc6dc34b Table_map: `test`.`test1` mapped to number 74 # at 6179 #160820 10:24:48 server id 63 end_log_pos 6265 CRC32 0x5f7ad700 Write_rows: table id 74 flags: STMT_END_F
BINLOG ' cL+3VxM/AAAAOQAAACMYAAAAAEoAAAAAAAEABHRlc3QABXRlc3QxAAUDDwMPEgU8AFgCAB9Lw23c cL+3Vx4/AAAAVgAAAHkYAAAAAEoAAAAAAAEAAgAF/+ACAAAABGxpc2kBAAAAHgB6aGFuZ3NhbiBy b2FkIE5vIDg3MCxmbG9vciA2MDKZmiimMADXel8= '/*!*/; # at 6265 #160820 10:24:48 server id 63 end_log_pos 6296 CRC32 0xf6833d28 Xid = 200 COMMIT/*!*/; # at 6296 #160820 10:31:30 server id 63 end_log_pos 6343 CRC32 0xcfcdd344 Rotate to mysql-bin.000216 pos: 4 DELIMITER ; # End of log file ROLLBACK /* added by mysqlbinlog */; /*!50003 SET COMPLETION_TYPE=@OLD_COMPLETION_TYPE*/; /*!50530 SET @@SESSION.PSEUDO_SLAVE_MODE=0*/; [root@hch_test_dbm1_121_63 binlog] |
The execution command is: /usr/local/mysql/bin/mysqlbinlog --base64-output=decode-rows -v mysql-bin.000215
You can see the following effect, But they are all the original dml block sql statements:
[root@hch_test_dbm1_121_63 binlog]# /usr/local/mysql/bin/mysqlbinlog - -base64-output=decode-rows -v mysql-bin.000215 /*!50530 SET @@SESSION.PSEUDO_SLAVE_MODE=1*/; /*!40019 SET @@session .max_insert_delayed_threads=0*/; /*!50003 SET @OLD_COMPLETION_TYPE=@@COMPLETION_TYPE,COMPLETION_TYPE=0*/; DELIMITER /*!*/; …… #160820 10:24:36 server id 63 end_log_pos 5821 CRC32 0x08bc94c3 Table_map: `test`.`test1` mapped to number 74 # at 5821 #160820 10:24:36 server id 63 end_log_pos 5911 CRC32 0x2f577f52 Write_rows: table id 74 flags: STMT_END_F INSERT INTO `test`.`test1` SET
@1=1 @2='zhangsan' ## @3=1 @4='zhangsan road No 870,floor 602' @5='2016-08-20 10:24:36'# at 5911 #160820 10:24:36 server id 63 end_log_pos 5942 CRC32 0xb26af81b CRC32 0x09eab31d Query thread_id=18 exec_time=0 error_code=0 SET TIMESTAMP=1471659888/*!*/; BEGIN /*!*/; # at 6022 # at 6122 #160820 10:24:48 server id 63 end_log_pos 6179 CRC32 0xdc6dc34b Table_map: `test`.`test1` mapped to number 74 # at 6179 #160820 10:24:48 server id 63 end_log_pos 6265 CRC32 0x5f7ad700 Write_rows: table id 74 flags: STMT_END_F ## INSERT INTO ` test`.`test1` SET ## @1=2 @2='lisi'
@3=1 ## @4=' zhangsan road No 870,floor 602' @5='2016-08-20 10:24:48'# at 6265 #160820 10:24:48 server id 63 end_log_pos 6296 CRC32 0xf6833d28 Xid = 200 COMMIT/*!*/; # at 6296 #160820 10:31:30 server id 63 end_log_pos 6343 CRC32 0xcfcdd344 Rotate to mysql-bin.000216 pos: 4 DELIMITER ; # End of log file ROLLBACK /* added by mysqlbinlog */; /*!50003 SET COMPLETION_TYPE=@OLD_COMPLETION_TYPE*/; | /*!50530 SET @@SESSION.PSEUDO_SLAVE_MODE=0*/;
PS:You can see it this way# The insert statement of ##dml, but only the final insert block is seen, but not the The original insert statement. In many cases, troubleshooting requires the original insert statement instead of the underlying insertblock. So the question is, how to see the original insert sql statement?
( 4.1) First set the global binlog_rows_query_log_events parameters online and refresh the log:
mysql> set binlog_rows_query_log_events=1; #mysql> flush logs; Query OK, 0 rows affected (0.01 sec)
mysql>exit
|
4.2
)Then log in again and enter the new one Data record:
##[root@hch_test_dbm1_121_63 ~]# mysql -utim -ptimgood -h192.168.121.63Warning: Using a password on the command line interface can be insecure.
Welcome to the MySQL monitor. Commands end with ; or \g.Server version: 5.6.12-log Source distribution Copyright (c) 2000, 2013, Oracle and/or its affiliates. All rights reserved. Oracle is a registered trademark of Oracle Corporation and/or itsaffiliates. Other names may be trademarks of their respectiveowners. Type 'help;' or '\h' for help. Type '\c' to clear the current input statement. mysql>mysql> ; use test;Database changedmysql> insert into test1 select 3,'wanger','3','zhangsan road No 870,floor 603',now();Query OK, 1 row affected (0.00 sec)Records: 1 Duplicates: 0 Warnings: 0 mysql>
(4.3)解析binlog,没有看到原始的insert语句
(4.4)通过mysql的命令行查看最原始的insert sql语句,如下所示:
5、Test summaryBased on From the above experiments, it can be concluded that in row mode, you can view the bottom-level insert data module through mysqlbinlog --base64-output=decode-rows –v, or through the command Line show binlog events in 'mysql-bin.000216'; to view the original insertsql record in real time.
We can set it in advance in the startup parameter file my.cnf when building the database, as shown below:
## The above is MySQL decryption--> How to view the original binary log in ROW mode The content of the SQL statement, please pay attention to the PHP Chinese website (www.php.cn) for more related content! |