// Session 1 [umshastr@hod03]/export/umesh/server/source: md5sum mysql-5.6.23.tar.gz 60344f26eae136a267a0277407926e79 mysql-5.6.23.tar.gz // extract and cd to mysql-5.6.23, build with -DWITH_DEBUG [umshastr@hod03]/export/umesh/server/source/mysql-5.6.23: cmake -DWITH_DEBUG=1 .. . [umshastr@hod03]/export/umesh/server/source/mysql-5.6.23: [umshastr@hod03]/export/umesh/server/source/mysql-5.6.23: make . . [100%] Built target my_safe_process // bringup mysqld using mtr [umshastr@hod03]/export/umesh/server/source/mysql-5.6.23: cd mysql-test/ [umshastr@hod03]/export/umesh/server/source/mysql-5.6.23/mysql-test: ./mtr --start --mysqld=--log_bin=master-bin --mysqld='--default-storage-engine=innodb' Logging: ./mtr --start --mysqld=--log_bin=master-bin --mysqld=--default-storage-engine=innodb 2015-04-23 10:00:26 25394 [Note] Plugin 'FEDERATED' is disabled. 2015-04-23 10:00:26 25394 [Note] Binlog end 2015-04-23 10:00:26 25394 [Note] Shutting down plugin 'CSV' 2015-04-23 10:00:26 25394 [Note] Shutting down plugin 'MyISAM' MySQL Version 5.6.23 Using default engine 'innodb' Checking supported features... - SSL connections supported - binaries are debug compiled Using suites: main,sys_vars,binlog,federated,rpl,innodb,innodb_fts,innodb_zip,perfschema,funcs_1,opt_trace,parts,auth_sec Collecting tests... Removing old var directory... Creating var directory '/export/umesh/server/source/mysql-5.6.23/mysql-test/var'... Installing system database... ============================================================================== TEST RESULT TIME (ms) or COMMENT -------------------------------------------------------------------------- worker[1] Using MTR_BUILD_THREAD 300, with reserved ports 13000..13009 worker[1] Started [mysqld.1 - pid: 25420, winpid: 25420] worker[1] Using config for test main.1st worker[1] Port and socket path for server(s): worker[1] mysqld.1 13000 /export/umesh/server/source/mysql-5.6.23/mysql-test/var/tmp/mysqld.1.sock worker[1] Waiting for server(s) to exit... // Session 2 - try to insert data, inject simulate_binlog_flush_error and see inserted rows, events from binlog etc [umshastr@hod03]/export/umesh/server/source/mysql-5.6.23: client/mysql -uroot -p -S/export/umesh/server/source/mysql-5.6.23/mysql-test/var/tmp/mysqld.1.sock Enter password: Welcome to the MySQL monitor. Commands end with ; or \g. Your MySQL connection id is 1 Server version: 5.6.23-debug-log Source distribution Copyright (c) 2000, 2015, Oracle and/or its affiliates. All rights reserved. Oracle is a registered trademark of Oracle Corporation and/or its affiliates. Other names may be trademarks of their respective owners. Type 'help;' or '\h' for help. Type '\c' to clear the current input statement. mysql> show binary logs; +-------------------+-----------+ | Log_name | File_size | +-------------------+-----------+ | master-bin.000001 | 120 | +-------------------+-----------+ 1 row in set (0.00 sec) mysql> use test; Database changed mysql> create table t1 (a int); Query OK, 0 rows affected (0.01 sec) mysql> insert into t1 values(1); Query OK, 1 row affected (0.00 sec) mysql> select * from t1; +------+ | a | +------+ | 1 | +------+ 1 row in set (0.00 sec) mysql> show binary logs; +-------------------+-----------+ | Log_name | File_size | +-------------------+-----------+ | master-bin.000001 | 425 | +-------------------+-----------+ 1 row in set (0.00 sec) mysql> show binlog events; +-------------------+-----+-------------+-----------+-------------+---------------------------------------------+ | Log_name | Pos | Event_type | Server_id | End_log_pos | Info | +-------------------+-----+-------------+-----------+-------------+---------------------------------------------+ | master-bin.000001 | 4 | Format_desc | 1 | 120 | Server ver: 5.6.23-debug-log, Binlog ver: 4 | | master-bin.000001 | 120 | Query | 1 | 217 | use `test`; create table t1 (a int) | | master-bin.000001 | 217 | Query | 1 | 296 | BEGIN | | master-bin.000001 | 296 | Query | 1 | 394 | use `test`; insert into t1 values(1) | | master-bin.000001 | 394 | Xid | 1 | 425 | COMMIT /* xid=10 */ | +-------------------+-----+-------------+-----------+-------------+---------------------------------------------+ 5 rows in set (0.00 sec) mysql> set @@global.debug='+d,simulate_binlog_flush_error'; Query OK, 0 rows affected (0.00 sec) mysql> insert into t1 values(2); Query OK, 1 row affected (0.00 sec) mysql> show binary logs; +-------------------+-----------+ | Log_name | File_size | +-------------------+-----------+ | master-bin.000001 | 633 | +-------------------+-----------+ 1 row in set (0.00 sec) mysql> show binlog events; +-------------------+-----+-------------+-----------+-------------+---------------------------------------------+ | Log_name | Pos | Event_type | Server_id | End_log_pos | Info | +-------------------+-----+-------------+-----------+-------------+---------------------------------------------+ | master-bin.000001 | 4 | Format_desc | 1 | 120 | Server ver: 5.6.23-debug-log, Binlog ver: 4 | | master-bin.000001 | 120 | Query | 1 | 217 | use `test`; create table t1 (a int) | | master-bin.000001 | 217 | Query | 1 | 296 | BEGIN | | master-bin.000001 | 296 | Query | 1 | 394 | use `test`; insert into t1 values(1) | | master-bin.000001 | 394 | Xid | 1 | 425 | COMMIT /* xid=10 */ | +-------------------+-----+-------------+-----------+-------------+---------------------------------------------+ 5 rows in set (0.00 sec) mysql> select * from t1; +------+ | a | +------+ | 1 | | 2 | +------+ 2 rows in set (0.00 sec) ### [umshastr@hod03]/export/umesh/server/source/mysql-5.6.23: bin/mysqlbinlog --base64-output=DECODE-ROW --verbose /export/umesh/server/source/mysql-5.6.23/mysql-test/var/mysqld.1/data/master-bin.000001 /*!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 /*!*/; # at 4 #150423 10:07:07 server id 1 end_log_pos 120 CRC32 0x277ea392 Start: binlog v 4, server v 5.6.23-debug-log created 150423 10:07:07 at startup # Warning: this binlog is either in use or was not closed properly. ROLLBACK/*!*/; # at 120 #150423 10:07:46 server id 1 end_log_pos 217 CRC32 0xda446b78 Query thread_id=1 exec_time=0 error_code=0 use `test`/*!*/; SET TIMESTAMP=1429776466/*!*/; SET @@session.pseudo_thread_id=1/*!*/; SET @@session.foreign_key_checks=1, @@session.sql_auto_is_null=0, @@session.unique_checks=1, @@session.autocommit=1/*!*/; SET @@session.sql_mode=1073741824/*!*/; SET @@session.auto_increment_increment=1, @@session.auto_increment_offset=1/*!*/; /*!\C utf8 *//*!*/; SET @@session.character_set_client=33,@@session.collation_connection=33,@@session.collation_server=8/*!*/; SET @@session.lc_time_names=0/*!*/; SET @@session.collation_database=DEFAULT/*!*/; create table t1 (a int) /*!*/; # at 217 #150423 10:07:48 server id 1 end_log_pos 296 CRC32 0xbadf3ecf Query thread_id=1 exec_time=0 error_code=0 SET TIMESTAMP=1429776468/*!*/; BEGIN /*!*/; # at 296 #150423 10:07:48 server id 1 end_log_pos 394 CRC32 0x887e10bc Query thread_id=1 exec_time=0 error_code=0 SET TIMESTAMP=1429776468/*!*/; insert into t1 values(1) /*!*/; # at 394 #150423 10:07:48 server id 1 end_log_pos 425 CRC32 0x18e25f82 Xid = 10 COMMIT/*!*/; DELIMITER ; # End of log file ROLLBACK /* added by mysqlbinlog */; /*!50003 SET COMPLETION_TYPE=@OLD_COMPLETION_TYPE*/; /*!50530 SET @@SESSION.PSEUDO_SLAVE_MODE=0*/; // May be show binary logs showing wrong File size? [umshastr@hod03]/export/umesh/server/source/mysql-5.6.23: ls -l /export/umesh/server/source/mysql-5.6.23/mysql-test/var/mysqld.1/data/ total 22552 -rw-rw---- 1 umshastr common 56 Apr 23 10:07 auto.cnf -rw-r--r-- 1 umshastr common 12582912 Apr 23 10:09 ibdata1 -rw-r--r-- 1 umshastr common 5242880 Apr 23 10:09 ib_logfile0 -rw-r--r-- 1 umshastr common 5242880 Apr 23 10:07 ib_logfile1 -rw-rw---- 1 umshastr common 425 Apr 23 10:07 master-bin.000001 <------------------------------ File_size 425 -rw-rw---- 1 umshastr common 20 Apr 23 10:07 master-bin.index drwxr-xr-x 2 umshastr common 4096 Apr 23 10:07 mtr drwxr-xr-x 2 umshastr common 4096 Apr 23 10:07 mysql drwxr-xr-x 2 umshastr common 4096 Apr 23 10:07 performance_schema drwxr-xr-x 2 umshastr common 44 Apr 23 10:07 test mysql> SHOW BINARY logs; +-------------------+-----------+ | Log_name | File_size | +-------------------+-----------+ | master-bin.000001 | 633 | +-------------------+-----------+ 1 row in set (0.00 sec)