[MDEV-23021] rpl.rpl_parallel_optimistic_until fails on BB with various pattern - Jira

Andrei Elkin created issue - 2020-06-26 06:53

Elena Stepanova made changes - 2020-07-30 12:32

Field	Original Value	New Value
Fix Version/s		10.4 [ 22408 ]
Fix Version/s		10.5 [ 23123 ]
Affects Version/s		10.4 [ 22408 ]
Affects Version/s		10.5 [ 23123 ]

Elena Stepanova added a comment - 2020-08-02 19:28

Fails on 10.2 too
http://buildbot.askmonty.org/buildbot/builders/kvm-rpm-centos74-amd64-debug/builds/4589

10.2 91ebf1844f4
rpl.rpl_parallel_optimistic_until 'innodb,row' w3 [ fail ]
Test ended at 2020-07-31 12:16:02

CURRENT_TEST: rpl.rpl_parallel_optimistic_until
mysqltest: At line 274: Query 'SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000003' FROM 508 LIMIT 1' didn't return a result set

The result from queries just before the failure was:
< snip >
1
SELECT count(*) = 0 as 'trx2 is not committed' FROM t1 WHERE b = 'trx2';
trx2 is not committed
1
Proof 2: Resume works out
include/start_slave.inc
connection master;
connection slave;
*** case 4 Relay-log UNTIL inside trx1
connection slave;
DELETE FROM t1 WHERE a <> 25;
UPDATE t1 SET b='trx0' WHERE a = 25;
connection slave1;
BEGIN;
INSERT INTO t1 SET a= 1; # block trx1;
connection slave;
include/stop_slave.inc
CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no;
START SLAVE IO_THREAD;
include/wait_for_slave_io_to_start.inc

More results from queries before failure can be found in /dev/shm/var/3/log/rpl_parallel_optimistic_until.log

Elena Stepanova added a comment - 2020-08-02 19:28 Fails on 10.2 too http://buildbot.askmonty.org/buildbot/builders/kvm-rpm-centos74-amd64-debug/builds/4589 10.2 91ebf1844f4 rpl.rpl_parallel_optimistic_until 'innodb,row' w3 [ fail ] Test ended at 2020-07-31 12:16:02 CURRENT_TEST: rpl.rpl_parallel_optimistic_until mysqltest: At line 274: Query 'SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000003' FROM 508 LIMIT 1' didn't return a result set The result from queries just before the failure was: < snip > 1 SELECT count(*) = 0 as 'trx2 is not committed' FROM t1 WHERE b = 'trx2'; trx2 is not committed 1 Proof 2: Resume works out include/start_slave.inc connection master; connection slave; *** case 4 Relay-log UNTIL inside trx1 connection slave; DELETE FROM t1 WHERE a <> 25; UPDATE t1 SET b='trx0' WHERE a = 25; connection slave1; BEGIN; INSERT INTO t1 SET a= 1; # block trx1; connection slave; include/stop_slave.inc CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no; START SLAVE IO_THREAD; include/wait_for_slave_io_to_start.inc More results from queries before failure can be found in /dev/shm/var/3/log/rpl_parallel_optimistic_until.log

Elena Stepanova made changes - 2020-08-02 19:28

Fix Version/s		10.2 [ 14601 ]
Affects Version/s		10.2 [ 14601 ]

Marko Mäkelä added a comment - 2020-09-22 05:22

Recent failure on 10.5: http://buildbot.askmonty.org/buildbot/builders/kvm-rpm-centos74-amd64-debug/builds/4885/steps/mtr/logs/stdio

10.5 6ab6b1510ed0851bda335a8919047c02860fe2e8
rpl.rpl_parallel_optimistic_until 'innodb,row' w2 [ fail ]
Test ended at 2020-09-20 17:13:55

CURRENT_TEST: rpl.rpl_parallel_optimistic_until
mysqltest: At line 274: Query 'SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000003' FROM 508 LIMIT 1' didn't return a result set

The result from queries just before the failure was:
< snip >
1
SELECT count(*) = 0 as 'trx2 is not committed' FROM t1 WHERE b = 'trx2';
trx2 is not committed
1
Proof 2: Resume works out
include/start_slave.inc
connection master;
connection slave;
*** case 4 Relay-log UNTIL inside trx1
connection slave;
DELETE FROM t1 WHERE a <> 25;
UPDATE t1 SET b='trx0' WHERE a = 25;
connection slave1;
BEGIN;
INSERT INTO t1 SET a= 1; # block trx1;
connection slave;
include/stop_slave.inc
CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no;
START SLAVE IO_THREAD;
include/wait_for_slave_io_to_start.inc

More results from queries before failure can be found in /dev/shm/var/2/log/rpl_parallel_optimistic_until.log

- saving '/dev/shm/var/2/log/rpl.rpl_parallel_optimistic_until-innodb,row/' to '/dev/shm/var/log/rpl.rpl_parallel_optimistic_until-innodb,row/'

Retrying test rpl.rpl_parallel_optimistic_until, attempt(2/3)...

worker[2] > Restart - not started
worker[2] > Restart - not started
rpl.rpl_parallel_optimistic_until 'innodb,row' w2 [ retry-pass ] 3562

Marko Mäkelä added a comment - 2020-09-22 05:22 Recent failure on 10.5: http://buildbot.askmonty.org/buildbot/builders/kvm-rpm-centos74-amd64-debug/builds/4885/steps/mtr/logs/stdio 10.5 6ab6b1510ed0851bda335a8919047c02860fe2e8 rpl.rpl_parallel_optimistic_until 'innodb,row' w2 [ fail ] Test ended at 2020-09-20 17:13:55 CURRENT_TEST: rpl.rpl_parallel_optimistic_until mysqltest: At line 274: Query 'SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000003' FROM 508 LIMIT 1' didn't return a result set The result from queries just before the failure was: < snip > 1 SELECT count(*) = 0 as 'trx2 is not committed' FROM t1 WHERE b = 'trx2'; trx2 is not committed 1 Proof 2: Resume works out include/start_slave.inc connection master; connection slave; *** case 4 Relay-log UNTIL inside trx1 connection slave; DELETE FROM t1 WHERE a <> 25; UPDATE t1 SET b='trx0' WHERE a = 25; connection slave1; BEGIN; INSERT INTO t1 SET a= 1; # block trx1; connection slave; include/stop_slave.inc CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no; START SLAVE IO_THREAD; include/wait_for_slave_io_to_start.inc More results from queries before failure can be found in /dev/shm/var/2/log/rpl_parallel_optimistic_until.log - saving '/dev/shm/var/2/log/rpl.rpl_parallel_optimistic_until-innodb,row/' to '/dev/shm/var/log/rpl.rpl_parallel_optimistic_until-innodb,row/' Retrying test rpl.rpl_parallel_optimistic_until, attempt(2/3)... worker[2] > Restart - not started worker[2] > Restart - not started rpl.rpl_parallel_optimistic_until 'innodb,row' w2 [ retry-pass ] 3562

Alice Sherepa added a comment - 2020-10-29 09:57 - edited

on 10.1 test fails with result mismatch: http://buildbot.askmonty.org/buildbot/builders/kvm-bintar-centos6-amd64-debug/builds/3209/steps/mtr/logs/stdio

rpl.rpl_parallel_optimistic_until 'innodb_plugin,row' w4 [ fail ]

        Test ended at 2020-10-29 11:03:01

CURRENT_TEST: rpl.rpl_parallel_optimistic_until

--- /usr/local/mariadb-10.1.48-linux-x86_64/mysql-test/suite/rpl/r/rpl_parallel_optimistic_until.result	2020-10-29 09:33:01.000000000 +0200

+++ /usr/local/mariadb-10.1.48-linux-x86_64/mysql-test/suite/rpl/r/rpl_parallel_optimistic_until.reject	2020-10-29 11:03:01.628350106 +0200

@@ -52,7 +52,7 @@

 INSERT INTO t1 SET a= 1;

 SELECT <pos_0> <= <pos_until> AND <pos_until> < <pos_trx2> as "pos_until < trx0 and is within trx2";

 pos_until < trx0 and is within trx2

-1

+0

 CHANGE MASTER TO MASTER_USE_GTID=no;

 START SLAVE UNTIL MASTER_LOG_FILE = 'file_2', MASTER_LOG_POS = <pos_until>;

 ROLLBACK;

@@ -63,7 +63,7 @@

 SELECT count(*) = 0 as 'trx3 is not committed' FROM t1 WHERE b = 'trx3';

 trx3 is not committed

-1

+0

 Proof 2: Resume works out

 include/start_slave.inc

 *** case 2 UNTIL inside trx2

@@ -74,7 +74,7 @@

 include/stop_slave.inc

 SELECT <pos_0> <= <pos_until> AND <pos_until> < <pos_trx2> as "pos_until >= trx0 and is within trx2";

 pos_until >= trx0 and is within trx2

-1

+0

 CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no;

 START SLAVE UNTIL MASTER_LOG_FILE = 'file_2', MASTER_LOG_POS = <pos_until>;

 ROLLBACK;

mysqltest: Result content mismatch

latest fail

Alice Sherepa added a comment - 2020-10-29 09:57 - edited on 10.1 test fails with result mismatch: http://buildbot.askmonty.org/buildbot/builders/kvm-bintar-centos6-amd64-debug/builds/3209/steps/mtr/logs/stdio rpl.rpl_parallel_optimistic_until 'innodb_plugin,row' w4 [ fail ] Test ended at 2020-10-29 11:03:01 CURRENT_TEST: rpl.rpl_parallel_optimistic_until --- /usr/local/mariadb-10.1.48-linux-x86_64/mysql-test/suite/rpl/r/rpl_parallel_optimistic_until.result 2020-10-29 09:33:01.000000000 +0200 +++ /usr/local/mariadb-10.1.48-linux-x86_64/mysql-test/suite/rpl/r/rpl_parallel_optimistic_until.reject 2020-10-29 11:03:01.628350106 +0200 @@ -52,7 +52,7 @@ INSERT INTO t1 SET a= 1; SELECT <pos_0> <= <pos_until> AND <pos_until> < <pos_trx2> as "pos_until < trx0 and is within trx2"; pos_until < trx0 and is within trx2 -1 +0 CHANGE MASTER TO MASTER_USE_GTID=no; START SLAVE UNTIL MASTER_LOG_FILE = 'file_2', MASTER_LOG_POS = <pos_until>; ROLLBACK; @@ -63,7 +63,7 @@ 1 SELECT count(*) = 0 as 'trx3 is not committed' FROM t1 WHERE b = 'trx3'; trx3 is not committed -1 +0 Proof 2: Resume works out include/start_slave.inc *** case 2 UNTIL inside trx2 @@ -74,7 +74,7 @@ include/stop_slave.inc SELECT <pos_0> <= <pos_until> AND <pos_until> < <pos_trx2> as "pos_until >= trx0 and is within trx2"; pos_until >= trx0 and is within trx2 -1 +0 CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no; START SLAVE UNTIL MASTER_LOG_FILE = 'file_2', MASTER_LOG_POS = <pos_until>; ROLLBACK; mysqltest: Result content mismatch latest fail

Alice Sherepa made changes - 2020-10-29 10:11

Affects Version/s		10.1 [ 16100 ]
Affects Version/s		10.3 [ 22126 ]

Alice Sherepa made changes - 2020-10-29 10:12

Fix Version/s

10.3 [ 22126 ]

Alice Sherepa added a comment - 2020-12-04 11:07

10.5 http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/25940/steps/mtr_nm/logs/stdio

Alice Sherepa added a comment - 2020-12-04 11:07 10.5 http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/25940/steps/mtr_nm/logs/stdio

Alice Sherepa added a comment - 2021-03-11 14:03

http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/27402/steps/mtr_nm/logs/stdio

10.2 374ec82f0828933a511f
rpl.rpl_parallel_optimistic_until 'innodb,row' w2 [ fail ]
Test ended at 2021-03-11 02:53:01

CURRENT_TEST: rpl.rpl_parallel_optimistic_until
mysqltest: At line 279:

The result from queries just before the failure was:
< snip >
SELECT count(*) = 0 as 'trx2 is not committed' FROM t1 WHERE b = 'trx2';
trx2 is not committed
1
Proof 2: Resume works out
include/start_slave.inc
connection master;
connection slave;
*** case 4 Relay-log UNTIL inside trx1
connection slave;
DELETE FROM t1 WHERE a <> 25;
UPDATE t1 SET b='trx0' WHERE a = 25;
connection slave1;
BEGIN;
INSERT INTO t1 SET a= 1; # block trx1;
connection slave;
include/stop_slave.inc
CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no;
START SLAVE IO_THREAD;
include/wait_for_slave_io_to_start.inc
*** Unexpected offset. Refine it to point to the correct XID event!

Alice Sherepa added a comment - 2021-03-11 14:03 http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/27402/steps/mtr_nm/logs/stdio 10.2 374ec82f0828933a511f rpl.rpl_parallel_optimistic_until 'innodb,row' w2 [ fail ] Test ended at 2021-03-11 02:53:01 CURRENT_TEST: rpl.rpl_parallel_optimistic_until mysqltest: At line 279: The result from queries just before the failure was: < snip > SELECT count(*) = 0 as 'trx2 is not committed' FROM t1 WHERE b = 'trx2'; trx2 is not committed 1 Proof 2: Resume works out include/start_slave.inc connection master; connection slave; *** case 4 Relay-log UNTIL inside trx1 connection slave; DELETE FROM t1 WHERE a <> 25; UPDATE t1 SET b='trx0' WHERE a = 25; connection slave1; BEGIN; INSERT INTO t1 SET a= 1; # block trx1; connection slave; include/stop_slave.inc CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no; START SLAVE IO_THREAD; include/wait_for_slave_io_to_start.inc *** Unexpected offset. Refine it to point to the correct XID event!

Alice Sherepa added a comment - 2021-04-30 11:46

http://buildbot.askmonty.org/buildbot/builders/kvm-rpm-centos74-amd64-debug/builds/6302/steps/mtr_centos_mix/logs/stdio
10.4 0cc811c633d1fe5290b10f

Alice Sherepa added a comment - 2021-04-30 11:46 http://buildbot.askmonty.org/buildbot/builders/kvm-rpm-centos74-amd64-debug/builds/6302/steps/mtr_centos_mix/logs/stdio 10.4 0cc811c633d1fe5290b10f

Alice Sherepa made changes - 2021-07-26 08:42

Affects Version/s

10.6 [ 24028 ]

Alice Sherepa made changes - 2021-07-26 08:42

Fix Version/s

10.6 [ 24028 ]

Marko Mäkelä added a comment - 2021-09-22 15:19

10.3 was not mentioned yet:

10.3 b46cf33ab8ce869af0f51c35026965d237d722c7
rpl.rpl_parallel_optimistic_until 'innodb,row' w21 [ fail ]
Test ended at 2021-09-22 18:05:05

CURRENT_TEST: rpl.rpl_parallel_optimistic_until
mysqltest: At line 274: Query 'SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000003' FROM 508 LIMIT 1' didn't return a result set

The result from queries just before the failure was:
< snip >
1
SELECT count(*) = 0 as 'trx2 is not committed' FROM t1 WHERE b = 'trx2';
trx2 is not committed
1
Proof 2: Resume works out
include/start_slave.inc
connection master;
connection slave;
*** case 4 Relay-log UNTIL inside trx1
connection slave;
DELETE FROM t1 WHERE a <> 25;
UPDATE t1 SET b='trx0' WHERE a = 25;
connection slave1;
BEGIN;
INSERT INTO t1 SET a= 1; # block trx1;
connection slave;
include/stop_slave.inc
CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no;
START SLAVE IO_THREAD;
include/wait_for_slave_io_to_start.inc

Marko Mäkelä added a comment - 2021-09-22 15:19 10.3 was not mentioned yet: 10.3 b46cf33ab8ce869af0f51c35026965d237d722c7 rpl.rpl_parallel_optimistic_until 'innodb,row' w21 [ fail ] Test ended at 2021-09-22 18:05:05 CURRENT_TEST: rpl.rpl_parallel_optimistic_until mysqltest: At line 274: Query 'SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000003' FROM 508 LIMIT 1' didn't return a result set The result from queries just before the failure was: < snip > 1 SELECT count(*) = 0 as 'trx2 is not committed' FROM t1 WHERE b = 'trx2'; trx2 is not committed 1 Proof 2: Resume works out include/start_slave.inc connection master; connection slave; *** case 4 Relay-log UNTIL inside trx1 connection slave; DELETE FROM t1 WHERE a <> 25; UPDATE t1 SET b='trx0' WHERE a = 25; connection slave1; BEGIN; INSERT INTO t1 SET a= 1; # block trx1; connection slave; include/stop_slave.inc CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no; START SLAVE IO_THREAD; include/wait_for_slave_io_to_start.inc

Marko Mäkelä added a comment - 2021-10-28 06:36

10.7 d7af7bfc2b6ab89801059406e1bd74846a2ca8e8
rpl.rpl_parallel_optimistic_until 'innodb,row' w8 [ fail ]
Test ended at 2021-10-28 09:27:10

CURRENT_TEST: rpl.rpl_parallel_optimistic_until
mysqltest: At line 274: Query 'SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000003' FROM 508 LIMIT 1' didn't return a result set

Marko Mäkelä added a comment - 2021-10-28 06:36 10.7 d7af7bfc2b6ab89801059406e1bd74846a2ca8e8 rpl.rpl_parallel_optimistic_until 'innodb,row' w8 [ fail ] Test ended at 2021-10-28 09:27:10 CURRENT_TEST: rpl.rpl_parallel_optimistic_until mysqltest: At line 274: Query 'SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000003' FROM 508 LIMIT 1' didn't return a result set

Marko Mäkelä made changes - 2021-10-28 06:36

Fix Version/s		10.7 [ 24805 ]
Affects Version/s		10.7 [ 24805 ]

Sergei Golubchik made changes - 2021-12-06 21:34

Workflow

MariaDB v3 [ 110523 ]

MariaDB v4 [ 142050 ]

Angelique Sklavounos (Inactive) made changes - 2022-02-18 12:42

Affects Version/s

10.8 [ 26121 ]

Angelique Sklavounos (Inactive) made changes - 2022-02-18 12:42

Fix Version/s

10.8 [ 26121 ]

Angelique Sklavounos (Inactive) added a comment - 2022-02-18 12:42

https://buildbot.mariadb.org/#/builders/192/builds/7772/steps/6/logs/stdio
10.8 1c5b099a9619c953e7510bbafca89353ad0a020c

https://buildbot.mariadb.org/#/builders/192/builds/7783/steps/6/logs/stdio
10.9 bbe99cd4e2d7c83a06dd93ea88af97f2d5796810

Angelique Sklavounos (Inactive) added a comment - 2022-02-18 12:42 https://buildbot.mariadb.org/#/builders/192/builds/7772/steps/6/logs/stdio 10.8 1c5b099a9619c953e7510bbafca89353ad0a020c https://buildbot.mariadb.org/#/builders/192/builds/7783/steps/6/logs/stdio 10.9 bbe99cd4e2d7c83a06dd93ea88af97f2d5796810

Angelique Sklavounos (Inactive) made changes - 2022-05-27 13:02

Link

This issue relates to TODO-3464 [ TODO-3464 ]

Ralf Gebhardt made changes - 2022-08-04 08:41

Fix Version/s

10.2 [ 14601 ]

Angelique Sklavounos (Inactive) made changes - 2023-02-15 01:17

Fix Version/s		10.9 [ 26905 ]
Fix Version/s		10.10 [ 27530 ]
Fix Version/s		10.11 [ 27614 ]
Fix Version/s		11.0 [ 28320 ]
Affects Version/s		10.9 [ 26905 ]
Affects Version/s		10.10 [ 27530 ]
Affects Version/s		10.11 [ 27614 ]
Affects Version/s		11.0 [ 28320 ]

Julien Fritsch made changes - 2023-03-03 17:27

Fix Version/s

10.7 [ 24805 ]

Julien Fritsch made changes - 2023-04-27 14:03

Fix Version/s

10.3 [ 22126 ]

Julien Fritsch made changes - 2023-04-27 14:50

Fix Version/s

10.8 [ 26121 ]

Roel Van de Paar made changes - 2023-07-23 22:40

Labels

sporadic

Roel Van de Paar added a comment - 2023-07-23 22:41 - edited

I ran into this also. Sporadic, but common, failure. Issue occurrence may be more pronounced after bb-10.4-~~MDEV-30619~~.

bb-10.4-MDEV-30619 10.4.31 006aca3111e0cbd5f172060774c74e328bea4b0a (Debug)
...
rpl.rpl_parallel_optimistic_until 'innodb,row' w21 [ 157 fail ]
Test ended at 2023-07-22 17:25:26

CURRENT_TEST: rpl.rpl_parallel_optimistic_until
mysqltest: At line 274: Query 'SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000003' FROM 508 LIMIT 1' didn't return a result set

The result from queries just before the failure was:
< snip >
1
SELECT count(*) = 0 as 'trx2 is not committed' FROM t1 WHERE b = 'trx2';
trx2 is not committed
1
Proof 2: Resume works out
include/start_slave.inc
connection master;
connection slave;
*** case 4 Relay-log UNTIL inside trx1
connection slave;
DELETE FROM t1 WHERE a <> 25;
UPDATE t1 SET b='trx0' WHERE a = 25;
connection slave1;
BEGIN;
INSERT INTO t1 SET a= 1; # block trx1;
connection slave;
include/stop_slave.inc
CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no;
START SLAVE IO_THREAD;
include/wait_for_slave_io_to_start.inc

Roel Van de Paar added a comment - 2023-07-23 22:41 - edited I ran into this also. Sporadic, but common, failure. Issue occurrence may be more pronounced after bb-10.4- MDEV-30619 . bb-10.4-MDEV-30619 10.4.31 006aca3111e0cbd5f172060774c74e328bea4b0a (Debug) ... rpl.rpl_parallel_optimistic_until 'innodb,row' w21 [ 157 fail ] Test ended at 2023-07-22 17:25:26 CURRENT_TEST: rpl.rpl_parallel_optimistic_until mysqltest: At line 274: Query 'SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000003' FROM 508 LIMIT 1' didn't return a result set The result from queries just before the failure was: < snip > 1 SELECT count(*) = 0 as 'trx2 is not committed' FROM t1 WHERE b = 'trx2'; trx2 is not committed 1 Proof 2: Resume works out include/start_slave.inc connection master; connection slave; *** case 4 Relay-log UNTIL inside trx1 connection slave; DELETE FROM t1 WHERE a <> 25; UPDATE t1 SET b='trx0' WHERE a = 25; connection slave1; BEGIN; INSERT INTO t1 SET a= 1; # block trx1; connection slave; include/stop_slave.inc CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no; START SLAVE IO_THREAD; include/wait_for_slave_io_to_start.inc

Roel Van de Paar made changes - 2023-07-23 22:41

Link

This issue relates to TODO-4062 [ TODO-4062 ]

Roel Van de Paar made changes - 2023-07-23 22:41

Labels

sporadic

affects-tests sporadic

Roel Van de Paar made changes - 2023-07-23 22:41

Priority

Major [ 3 ]

Critical [ 2 ]

Roel Van de Paar made changes - 2023-07-23 22:41

Status

Open [ 1 ]

Confirmed [ 10101 ]

Roel Van de Paar made changes - 2023-07-23 22:43

Link

This issue relates to ~~MDEV-30619~~ [ ~~MDEV-30619~~ ]

Roel Van de Paar added a comment - 2023-07-23 22:49

Also observed on same branch, also sporadic, though (much) less frequent:

10.4.31 006aca3111e0cbd5f172060774c74e328bea4b0a (Debug)
rpl.rpl_parallel_optimistic_until 'innodb,row' w43 [ 207 fail ]
Test ended at 2023-07-23 16:56:06

CURRENT_TEST: rpl.rpl_parallel_optimistic_until
mysqltest: At line 279:

The result from queries just before the failure was:
< snip >
SELECT count(*) = 0 as 'trx2 is not committed' FROM t1 WHERE b = 'trx2';
trx2 is not committed
1
Proof 2: Resume works out
include/start_slave.inc
connection master;
connection slave;
*** case 4 Relay-log UNTIL inside trx1
connection slave;
DELETE FROM t1 WHERE a <> 25;
UPDATE t1 SET b='trx0' WHERE a = 25;
connection slave1;
BEGIN;
INSERT INTO t1 SET a= 1; # block trx1;
connection slave;
include/stop_slave.inc
CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no;
START SLAVE IO_THREAD;
include/wait_for_slave_io_to_start.inc
*** Unexpected offset. Refine it to point to the correct XID event!

Roel Van de Paar added a comment - 2023-07-23 22:49 Also observed on same branch, also sporadic, though (much) less frequent: 10.4.31 006aca3111e0cbd5f172060774c74e328bea4b0a (Debug) rpl.rpl_parallel_optimistic_until 'innodb,row' w43 [ 207 fail ] Test ended at 2023-07-23 16:56:06 CURRENT_TEST: rpl.rpl_parallel_optimistic_until mysqltest: At line 279: The result from queries just before the failure was: < snip > SELECT count(*) = 0 as 'trx2 is not committed' FROM t1 WHERE b = 'trx2'; trx2 is not committed 1 Proof 2: Resume works out include/start_slave.inc connection master; connection slave; *** case 4 Relay-log UNTIL inside trx1 connection slave; DELETE FROM t1 WHERE a <> 25; UPDATE t1 SET b='trx0' WHERE a = 25; connection slave1; BEGIN; INSERT INTO t1 SET a= 1; # block trx1; connection slave; include/stop_slave.inc CHANGE MASTER TO MASTER_LOG_FILE = 'file_1', MASTER_LOG_POS = <pos_trx0>, MASTER_USE_GTID=no; START SLAVE IO_THREAD; include/wait_for_slave_io_to_start.inc *** Unexpected offset. Refine it to point to the correct XID event!

Roel Van de Paar made changes - 2023-07-23 22:50

Comment

[ [~Elkin] A fix for this bug would be appreciated as this bug affects testing (terminated runs). ]

Kristian Nielsen made changes - 2023-08-08 14:07

Assignee

Andrei Elkin [ elkin ]

Kristian Nielsen [ knielsen ]

Kristian Nielsen made changes - 2023-08-08 14:08

Status

Confirmed [ 10101 ]

In Progress [ 3 ]

Kristian Nielsen added a comment - 2023-08-10 18:37

Fix pushed to 10.4

Kristian Nielsen added a comment - 2023-08-10 18:37 Fix pushed to 10.4

Kristian Nielsen made changes - 2023-08-10 18:37

Fix Version/s		10.4.31 [ 29010 ]
Fix Version/s	10.4 [ 22408 ]
Fix Version/s	10.5 [ 23123 ]
Fix Version/s	10.6 [ 24028 ]
Fix Version/s	10.9 [ 26905 ]
Fix Version/s	10.10 [ 27530 ]
Fix Version/s	10.11 [ 27614 ]
Fix Version/s	11.0 [ 28320 ]
Resolution		Fixed [ 1 ]
Status	In Progress [ 3 ]	Closed [ 6 ]

Daniel Bartholomew made changes - 2023-08-14 16:56

Fix Version/s		10.4.32 [ 29300 ]
Fix Version/s		10.5.23 [ 29012 ]
Fix Version/s		10.6.16 [ 29014 ]
Fix Version/s		10.10.7 [ 29018 ]
Fix Version/s		10.11.6 [ 29020 ]
Fix Version/s		11.0.4 [ 29021 ]
Fix Version/s	10.4.31 [ 29010 ]

Roel Van de Paar made changes - 2023-10-05 02:37

Link

This issue relates to TODO-4062 [ TODO-4062 ]

MariaDB Server

rpl.rpl_parallel_optimistic_until fails on BB with various pattern

Details

Description

Attachments

Issue Links

Activity

People

Dates

Git Integration