Percona Server moved to https://jira.percona.com/projects/PS

  1. Bug #1313901
  2. Comment #2

Comment 2 for bug 1313901

Revision history for this message
Nilnandan Joshi (nilnandan-joshi) wrote :

Repeatable with PS 5.6.17

nil@Dell-XPS:~/sandboxes/rsandbox_Percona-Server-5_6_17/master/data$ mysqlbinlog -v mysql-bin.000003
/*!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*/;

...

# at 510
#140605 16:45:26 server id 1 end_log_pos 752 CRC32 0x07a704f4 Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966926/*!*/;
CREATE TABLE `t2` (
  `id` int(11) NOT NULL AUTO_INCREMENT,
  `c` char(32) DEFAULT NULL,
  PRIMARY KEY (`id`)
) ENGINE=InnoDB AUTO_INCREMENT=1018 DEFAULT CHARSET=latin1
/*!*/;
# at 752
#140605 16:45:30 server id 1 end_log_pos 831 CRC32 0x3461ce1d Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966930/*!*/;
BEGIN
/*!*/;
# at 831
#140605 16:45:30 server id 1 end_log_pos 992 CRC32 0xebe4b1af Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966930/*!*/;
INSERT INTO `t2` VALUES (1, 'dummy'), (2, 'foo'), (3, 'ping'), (4, 'ding'), (5, 'ring')
/*!*/;
# at 992
#140605 16:45:30 server id 1 end_log_pos 1023 CRC32 0xb1233f88 Xid = 34
COMMIT/*!*/;
# at 1023
#140605 16:45:35 server id 1 end_log_pos 1191 CRC32 0x9a2fca98 Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966935/*!*/;
create temporary table t2_temp(`id` int(11) NOT NULL, `c` char(32) DEFAULT NULL) ENGINE=InnoDB
/*!*/;
# at 1191
#140605 16:45:51 server id 1 end_log_pos 1297 CRC32 0xa0c429b6 Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966951/*!*/;
create index idx1 on t2_temp(id)
/*!*/;
# at 1297
#140605 16:45:55 server id 1 end_log_pos 1376 CRC32 0xceaf66ed Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966955/*!*/;
BEGIN
/*!*/;
# at 1376
#140605 16:45:55 server id 1 end_log_pos 1502 CRC32 0xbf32b6dd Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966955/*!*/;
insert into t2_temp values(4, 'hello'), (5, 'world')
/*!*/;
# at 1502
#140605 16:45:55 server id 1 end_log_pos 1582 CRC32 0x264c4a5e Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966955/*!*/;
COMMIT
/*!*/;
# at 1582
#140605 16:46:12 server id 1 end_log_pos 1663 CRC32 0x2fbc5e02 Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966972/*!*/;
BEGIN
/*!*/;
# at 1663
#140605 16:46:12 server id 1 end_log_pos 1711 CRC32 0xed6f2a3b Table_map: `test`.`t2` mapped to number 71
# at 1711
#140605 16:46:12 server id 1 end_log_pos 1793 CRC32 0x6eb2924f Update_rows: table id 71 flags: STMT_END_F

BINLOG '
fFGQUxMBAAAAMAAAAK8GAAAAAEcAAAAAAAEABHRlc3QAAnQyAAID/gL+IAI7Km/t
fFGQUx8BAAAAUgAAAAEHAAAAAEcAAAAAAAEAAgAC///8BAAAAARkaW5n/AQAAAAHdXBkYXRlZPwF
AAAABHJpbmf8BQAAAAd1cGRhdGVkT5Kybg==
'/*!*/;
### UPDATE `test`.`t2`
### WHERE
### @1=4
### @2='ding'
### SET
### @1=4
### @2='updated'
### UPDATE `test`.`t2`
### WHERE
### @1=5
### @2='ring'
### SET
### @1=5
### @2='updated'
# at 1793
#140605 16:46:12 server id 1 end_log_pos 1824 CRC32 0xd08404b8 Xid = 40
COMMIT/*!*/;
# at 1824
#140605 16:46:18 server id 1 end_log_pos 1896 CRC32 0x1160fc18 Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966978/*!*/;
BEGIN
/*!*/;
# at 1896
#140605 16:46:18 server id 1 end_log_pos 1944 CRC32 0xa85b425f Table_map: `test`.`t2` mapped to number 71
# at 1944
#140605 16:46:18 server id 1 end_log_pos 1998 CRC32 0xf3868589 Write_rows: table id 71 flags: STMT_END_F

BINLOG '
glGQUxMBAAAAMAAAAJgHAAAAAEcAAAAAAAEABHRlc3QAAnQyAAID/gL+IAJfQluo
glGQUx4BAAAANgAAAM4HAAAAAEcAAAAAAAEAAgAC//wGAAAADXNpbXBsZV9pbnNlcnSJhYbz
'/*!*/;
### INSERT INTO `test`.`t2`
### SET
### @1=6
### @2='simple_insert'
# at 1998
#140605 16:46:18 server id 1 end_log_pos 2029 CRC32 0xc9cde1a2 Xid = 41
COMMIT/*!*/;
DELIMITER ;
# End of log file
ROLLBACK /* added by mysqlbinlog */;
/*!50003 SET COMPLETION_TYPE=@OLD_COMPLETION_TYPE*/;
/*!50530 SET @@SESSION.PSEUDO_SLAVE_MODE=0*/;
nil@Dell-XPS:~/sandboxes/rsandbox_Percona-Server-5_6_17/master/data$

-----------------------On Slave -----------------------------------------
nil@Dell-XPS:~/sandboxes/rsandbox_Percona-Server-5_6_17/node1/data$
nil@Dell-XPS:~/sandboxes/rsandbox_Percona-Server-5_6_17/node1/data$ mysqlbinlog -v mysql-bin.000004
/*!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*/;
.....

# at 120
#140605 16:45:26 server id 1 end_log_pos 362 CRC32 0x267b0f1b Query thread_id=1 exec_time=0 error_code=0
use `test`/*!*/;
SET TIMESTAMP=1401966926/*!*/;
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 `t2` (
  `id` int(11) NOT NULL AUTO_INCREMENT,
  `c` char(32) DEFAULT NULL,
  PRIMARY KEY (`id`)
) ENGINE=InnoDB AUTO_INCREMENT=1018 DEFAULT CHARSET=latin1
/*!*/;
# at 362
#140605 16:45:30 server id 1 end_log_pos 441 CRC32 0x1e1f3c7e Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966930/*!*/;
BEGIN
/*!*/;
# at 441
#140605 16:45:30 server id 1 end_log_pos 602 CRC32 0x1a454ce1 Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966930/*!*/;
INSERT INTO `t2` VALUES (1, 'dummy'), (2, 'foo'), (3, 'ping'), (4, 'ding'), (5, 'ring')
/*!*/;
# at 602
#140605 16:45:30 server id 1 end_log_pos 633 CRC32 0xc566046b Xid = 30
COMMIT/*!*/;
# at 633
#140605 16:45:35 server id 1 end_log_pos 801 CRC32 0xdeba5e53 Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966935/*!*/;
create temporary table t2_temp(`id` int(11) NOT NULL, `c` char(32) DEFAULT NULL) ENGINE=InnoDB
/*!*/;
# at 801
#140605 16:45:51 server id 1 end_log_pos 907 CRC32 0xe77ac49a Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966951/*!*/;
create index idx1 on t2_temp(id)
/*!*/;
# at 907
#140605 16:45:55 server id 1 end_log_pos 986 CRC32 0xd8335067 Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966955/*!*/;
BEGIN
/*!*/;
# at 986
#140605 16:45:55 server id 1 end_log_pos 1112 CRC32 0xe8c73bfe Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966955/*!*/;
insert into t2_temp values(4, 'hello'), (5, 'world')
/*!*/;
# at 1112
#140605 16:45:55 server id 1 end_log_pos 1185 CRC32 0x38822f59 Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966955/*!*/;
COMMIT
/*!*/;
# at 1185
#140605 16:46:12 server id 1 end_log_pos 1248 CRC32 0xfb36361c Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966972/*!*/;
SET @@session.sql_mode=524288/*!*/;
BEGIN
/*!*/;
# at 1248
#140605 16:46:12 server id 1 end_log_pos 1296 CRC32 0xa40fa367 Table_map: `test`.`t2` mapped to number 70
# at 1296
#140605 16:46:12 server id 1 end_log_pos 1378 CRC32 0x0a8b3711 Update_rows: table id 70 flags: STMT_END_F

BINLOG '
fFGQUxMBAAAAMAAAABAFAAAAAEYAAAAAAAEABHRlc3QAAnQyAAID/gL+IAJnow+k
fFGQUx8BAAAAUgAAAGIFAAAAAEYAAAAAAAEAAgAC///8BAAAAARkaW5n/AQAAAAHdXBkYXRlZPwF
AAAABHJpbmf8BQAAAAd1cGRhdGVkETeLCg==
'/*!*/;
### UPDATE `test`.`t2`
### WHERE
### @1=4
### @2='ding'
### SET
### @1=4
### @2='updated'
### UPDATE `test`.`t2`
### WHERE
### @1=5
### @2='ring'
### SET
### @1=5
### @2='updated'
# at 1378
#140605 16:46:12 server id 1 end_log_pos 1409 CRC32 0xf8c5d26e Xid = 37
COMMIT/*!*/;
# at 1409
#140605 16:46:18 server id 1 end_log_pos 1472 CRC32 0xd6a0a456 Query thread_id=1 exec_time=0 error_code=0
SET TIMESTAMP=1401966978/*!*/;
BEGIN
/*!*/;
# at 1472
#140605 16:46:18 server id 1 end_log_pos 1520 CRC32 0x0aba766a Table_map: `test`.`t2` mapped to number 70
# at 1520
#140605 16:46:18 server id 1 end_log_pos 1574 CRC32 0x844f3016 Write_rows: table id 70 flags: STMT_END_F

BINLOG '
glGQUxMBAAAAMAAAAPAFAAAAAEYAAAAAAAEABHRlc3QAAnQyAAID/gL+IAJqdroK
glGQUx4BAAAANgAAACYGAAAAAEYAAAAAAAEAAgAC//wGAAAADXNpbXBsZV9pbnNlcnQWME+E
'/*!*/;
### INSERT INTO `test`.`t2`
### SET
### @1=6
### @2='simple_insert'
# at 1574
#140605 16:46:18 server id 1 end_log_pos 1605 CRC32 0x7c9fa319 Xid = 39
COMMIT/*!*/;
DELIMITER ;
# End of log file
ROLLBACK /* added by mysqlbinlog */;
/*!50003 SET COMPLETION_TYPE=@OLD_COMPLETION_TYPE*/;
/*!50530 SET @@SESSION.PSEUDO_SLAVE_MODE=0*/;
nil@Dell-XPS:~/sandboxes/rsandbox_Percona-Server-5_6_17/node1/data$