[MDEV-23591] galera_3nodes.GCF-354 MTR failed: 1047: WSREP has not yet prepared node for application use Created: 2020-08-26  Updated: 2023-04-11  Resolved: 2023-04-11

Status: Closed
Project: MariaDB Server
Component/s: Galera, Tests
Affects Version/s: 10.5.6
Fix Version/s: 10.5.7, 10.6.0, 10.7.1, 10.8.1, 10.9.1, 10.10.1, 10.11.1, 11.0.1

Type: Bug Priority: Major
Reporter: Stepan Patryshev (Inactive) Assignee: Julius Goryavsky
Resolution: Fixed Votes: 0
Labels: None
Environment:

kvm-rpm-centos74-aarch64


Issue Links:
Blocks
blocks MDEV-22122 Galera test failures on 10.5 Open
Relates
relates to MDEV-23587 galera_3nodes.galera_var_dirty_reads2... Closed

 Description   

galera_3nodes.GCF-354 failed on BB 10.5: "query 'DROP TABLE test.t1' failed: 1047: WSREP has not yet prepared node for application use".

stdio.log:

10.5.6 97a4a3872e5037b8db1e8c27152740190330ab9c

galera_3nodes.GCF-354 'innodb'           w1 [ fail ]
        Test ended at 2020-08-26 15:20:24
 
CURRENT_TEST: galera_3nodes.GCF-354
mysqltest: At line 36: query 'DROP TABLE test.t1' failed: 1047: WSREP has not yet prepared node for application use
 
The result from queries just before the failure was:
< snip >
SET wsrep_on=OFF;
CREATE TABLE test.t1 (f1 INTEGER);
connection node_1;
CREATE TABLE test.t1 (f1 INTEGER);
Timeout in wait_condition.inc for SELECT VARIABLE_VALUE = 'Primary' FROM INFORMATION_SCHEMA.GLOBAL_STATUS WHERE VARIABLE_NAME = 'wsrep_cluster_status'
Id	User	Host	db	Command	Time	State	Info	Progress
2	system user		NULL	Sleep	42	wsrep aborter idle	NULL	0.000
1	system user		NULL	Sleep	42	closing tables	NULL	0.000
10	root	localhost	test	Sleep	33		NULL	0.000
11	root	localhost:59516	test	Query	0	starting	show full processlist	0.000
SHOW STATUS LIKE 'wsrep_cluster_status';
Variable_name	Value
wsrep_cluster_status	non-Primary
DROP TABLE test.t1;



 Comments   
Comment by Jan Lindström (Inactive) [ 2020-09-14 ]

galera_3nodes.GCF-354 'innodb'           w1 [ fail ]
        Test ended at 2020-09-13 11:40:42
 
CURRENT_TEST: galera_3nodes.GCF-354
mysqltest: At line 36: query 'DROP TABLE test.t1' failed: 1047: WSREP has not yet prepared node for application use
 
The result from queries just before the failure was:
< snip >
SET wsrep_on=OFF;
CREATE TABLE test.t1 (f1 INTEGER);
connection node_1;
CREATE TABLE test.t1 (f1 INTEGER);
Timeout in wait_condition.inc for SELECT VARIABLE_VALUE = 'Primary' FROM INFORMATION_SCHEMA.GLOBAL_STATUS WHERE VARIABLE_NAME = 'wsrep_cluster_status'
Id	User	Host	db	Command	Time	State	Info	Progress
1	system user		NULL	Sleep	54	closing tables	NULL	0.000
2	system user		NULL	Sleep	54	wsrep aborter idle	NULL	0.000
10	root	localhost	test	Sleep	33		NULL	0.000
11	root	localhost:37284	test	Query	0	starting	show full processlist	0.000
SHOW STATUS LIKE 'wsrep_cluster_status';
Variable_name	Value
wsrep_cluster_status	non-Primary
DROP TABLE test.t1;
 
More results from queries before failure can be found in /dev/shm/var/1/log/GCF-354.log
 
 - saving '/dev/shm/var/1/log/galera_3nodes.GCF-354-innodb/' to '/dev/shm/var/log/galera_3nodes.GCF-354-innodb/'
 
Retrying test galera_3nodes.GCF-354, attempt(2/3)...
 
worker[1] > Restart  - not started
worker[1] > Restart  - not started
worker[1] > Restart  - not started
***Warnings generated in error logs during shutdown after running tests: galera_3nodes.GCF-354
 
2020-09-13 11:40:11 2 [ERROR] WSREP: Inconsistency detected: Inconsistent by consensus on d3acd8c9-f5b5-11ea-a0b0-32133b7e7efe:4
2020-09-13 11:40:11 1 [ERROR] WSREP: Inconsistency detected: Inconsistent by consensus on d3acd8c9-f5b5-11ea-a0b0-32133b7e7efe:4
 
galera_3nodes.galera_safe_to_bootstrap 'innodb' w2 [ pass ]  36587
galera_3nodes.GCF-354 'innodb'           w1 [ retry-fail ]
        Test ended at 2020-09-13 11:41:21
 
CURRENT_TEST: galera_3nodes.GCF-354
mysqltest: At line 36: query 'DROP TABLE test.t1' failed: 1047: WSREP has not yet prepared node for application use
 
The result from queries just before the failure was:
< snip >
SET wsrep_on=OFF;
CREATE TABLE test.t1 (f1 INTEGER);
connection node_1;
CREATE TABLE test.t1 (f1 INTEGER);
Timeout in wait_condition.inc for SELECT VARIABLE_VALUE = 'Primary' FROM INFORMATION_SCHEMA.GLOBAL_STATUS WHERE VARIABLE_NAME = 'wsrep_cluster_status'
Id	User	Host	db	Command	Time	State	Info	Progress
1	system user		NULL	Sleep	38	wsrep aborter idle	NULL	0.000
2	system user		NULL	Sleep	38	closing tables	NULL	0.000
10	root	localhost	test	Sleep	32		NULL	0.000
11	root	localhost:37518	test	Query	0	starting	show full processlist	0.000
SHOW STATUS LIKE 'wsrep_cluster_status';
Variable_name	Value
wsrep_cluster_status	non-Primary
DROP TABLE test.t1;
 
More results from queries before failure can be found in /dev/shm/var/1/log/GCF-354.log

Comment by Julius Goryavsky [ 2023-04-11 ]

Already fixed and merged with head revisions

Generated at Thu Feb 08 09:23:33 UTC 2024 using Jira 8.20.16#820016-sha1:9d11dbea5f4be3d4cc21f03a88dd11d8c8687422.