[MDEV-13567] rpl.rpl_start_stop_slave failed in buildbot with timeout in sync Created: 2017-08-17  Updated: 2023-04-27

Status: Open
Project: MariaDB Server
Component/s: Tests
Affects Version/s: 10.0, 10.1, 10.2, 10.3, 10.4, 10.5
Fix Version/s: 10.4, 10.5

Type: Bug Priority: Minor
Reporter: Elena Stepanova Assignee: Andrei Elkin
Resolution: Unresolved Votes: 0
Labels: None


 Description   

http://buildbot.askmonty.org/buildbot/builders/qa-kvm-linux/builds/1772/steps/stable_tests/logs/stdio

rpl.rpl_start_stop_slave 'row'           w3 [ fail ]
        Test ended at 2017-08-09 18:21:43
 
CURRENT_TEST: rpl.rpl_start_stop_slave
=== SHOW MASTER STATUS ===
---- 1. ----
File	slave-bin.000001
Position	328
Binlog_Do_DB	
Binlog_Ignore_DB	
==========================
 
=== SHOW SLAVE STATUS ===
---- 1. ----
Slave_IO_State	
Master_Host	127.0.0.1
Master_User	root
Master_Port	16020
Connect_Retry	1
Master_Log_File	master-bin.000001
Read_Master_Log_Pos	329
Relay_Log_File	slave-relay-bin.000002
Relay_Log_Pos	629
Relay_Master_Log_File	master-bin.000001
Slave_IO_Running	No
Slave_SQL_Running	Yes
Replicate_Do_DB	
Replicate_Ignore_DB	
Replicate_Do_Table	
Replicate_Ignore_Table	
Replicate_Wild_Do_Table	
Replicate_Wild_Ignore_Table	
Last_Errno	0
Last_Error	
Skip_Counter	0
Exec_Master_Log_Pos	329
Relay_Log_Space	938
Until_Condition	None
Until_Log_File	
Until_Log_Pos	0
Master_SSL_Allowed	No
Master_SSL_CA_File	
Master_SSL_CA_Path	
Master_SSL_Cert	
Master_SSL_Cipher	
Master_SSL_Key	
Seconds_Behind_Master	
Master_SSL_Verify_Server_Cert	No
Last_IO_Errno	0
Last_IO_Error	
Last_SQL_Errno	0
Last_SQL_Error	
Replicate_Ignore_Server_Ids	
Master_Server_Id	1
Master_SSL_Crl	
Master_SSL_Crlpath	
Using_Gtid	No
Gtid_IO_Pos	
Replicate_Do_Domain_Ids	
Replicate_Ignore_Domain_Ids	
Parallel_Mode	conservative
SQL_Delay	0
SQL_Remaining_Delay	
Slave_SQL_Running_State	Slave has read all relay log; waiting for the slave I/O thread to update it
=========================
 
=== SHOW PROCESSLIST ===
---- 1. ----
Id	1
User	system user
Host	
db	
Command	Daemon
Time	
State	
Info	
Progress	0.000
---- 2. ----
Id	2
User	system user
Host	
db	
Command	Daemon
Time	
State	
Info	
Progress	0.000
---- 3. ----
Id	3
User	system user
Host	
db	
Command	Daemon
Time	
State	
Info	
Progress	0.000
---- 4. ----
Id	4
User	system user
Host	
db	
Command	Daemon
Time	
State	InnoDB purge worker
Info	
Progress	0.000
---- 5. ----
Id	5
User	system user
Host	
db	
Command	Daemon
Time	
State	InnoDB shutdown handler
Info	
Progress	0.000
---- 6. ----
Id	10
User	root
Host	localhost:58041
db	test
Command	Sleep
Time	300
State	
Info	
Progress	0.000
---- 7. ----
Id	11
User	root
Host	localhost:58042
db	test
Command	Sleep
Time	300
State	
Info	
Progress	0.000
---- 8. ----
Id	13
User	system user
Host	
db	
Command	Slave_SQL
Time	300
State	Slave has read all relay log; waiting for the slave I/O thread to update it
Info	
Progress	0.000
---- 9. ----
Id	14
User	root
Host	localhost:58049
db	test
Command	Query
Time	0
State	init
Info	SHOW PROCESSLIST
Progress	0.000
---- 10. ----
Id	15
User	root
Host	localhost:58050
db	test
Command	Sleep
Time	300
State	
Info	
Progress	0.000
========================
 
analyze: sync_with_master
mysqltest: At line 59: sync_slave_with_master failed: 'select master_pos_wait('master-bin.000001', 473, 300, '')' returned -1 indicating timeout after 300 seconds
 
The result from queries just before the failure was:
include/master-slave.inc
[connection master]
connection slave;
set @time_before_kill := (select CURRENT_TIMESTAMP);
[Time before the query]
[Connection ID of the slave I/O thread found]
kill <connection_id>;
set @time_after_kill := (select CURRENT_TIMESTAMP);
[Time after the query]
[Killing of the slave IO thread was successful]
START SLAVE IO_THREAD;
Warnings:
Note	1254	Slave is already running
connection master;
create table t1 (a int primary key);
 
 
 == /home/buildbot/build/mysql-test/var/3/tmp/analyze-sync_with_master-mysqld.2.err ==
 
############################## default ##############################
 
**** SHOW WARNINGS on default ****
SHOW WARNINGS;
Level	Code	Message
 
**** SELECT replication-related variables on default ****
SELECT NOW(), @@SERVER_ID;
NOW()	@@SERVER_ID
2017-08-09 18:21:42	2
 
**** SHOW SLAVE STATUS on default ****
SHOW SLAVE STATUS;
Slave_IO_State	
Master_Host	127.0.0.1
Master_User	root
Master_Port	16020
Connect_Retry	1
Master_Log_File	master-bin.000001
Read_Master_Log_Pos	329
Relay_Log_File	slave-relay-bin.000002
Relay_Log_Pos	629
Relay_Master_Log_File	master-bin.000001
Slave_IO_Running	No
Slave_SQL_Running	Yes
Replicate_Do_DB	
Replicate_Ignore_DB	
Replicate_Do_Table	
Replicate_Ignore_Table	
Replicate_Wild_Do_Table	
Replicate_Wild_Ignore_Table	
Last_Errno	0
Last_Error	
Skip_Counter	0
Exec_Master_Log_Pos	329
Relay_Log_Space	938
Until_Condition	None
Until_Log_File	
Until_Log_Pos	0
Master_SSL_Allowed	No
Master_SSL_CA_File	
Master_SSL_CA_Path	
Master_SSL_Cert	
Master_SSL_Cipher	
Master_SSL_Key	
Seconds_Behind_Master	NULL
Master_SSL_Verify_Server_Cert	No
Last_IO_Errno	0
Last_IO_Error	
Last_SQL_Errno	0
Last_SQL_Error	
Replicate_Ignore_Server_Ids	
Master_Server_Id	1
Master_SSL_Crl	
Master_SSL_Crlpath	
Using_Gtid	No
Gtid_IO_Pos	
Replicate_Do_Domain_Ids	
Replicate_Ignore_Domain_Ids	
Parallel_Mode	conservative
SQL_Delay	0
SQL_Remaining_Delay	NULL
Slave_SQL_Running_State	Slave has read all relay log; waiting for the slave I/O thread to update it
 
**** SHOW MASTER STATUS on default ****
SHOW MASTER STATUS;
File	slave-bin.000001
Position	328
Binlog_Do_DB	
Binlog_Ignore_DB	
 
**** SHOW SLAVE HOSTS on default ****
SHOW SLAVE HOSTS;
 
**** SHOW PROCESSLIST on default ****
SHOW PROCESSLIST;
Id	User	Host	db	Command	Time	State	Info	Progress
1	system user		NULL	Daemon	NULL		NULL	0.000
2	system user		NULL	Daemon	NULL		NULL	0.000
3	system user		NULL	Daemon	NULL		NULL	0.000
4	system user		NULL	Daemon	NULL	InnoDB purge worker	NULL	0.000
5	system user		NULL	Daemon	NULL	InnoDB shutdown handler	NULL	0.000
13	system user		NULL	Slave_SQL	300	Slave has read all relay log; waiting for the slave I/O thread to update it	NULL	0.000
16	root	localhost	NULL	Query	0	init	SHOW PROCESSLIST	0.000
 
**** SHOW BINARY LOGS on default ****
SHOW BINARY LOGS;
Log_name	File_size
slave-bin.000001	328
 
**** SHOW BINLOG EVENTS on default ****
binlog_name = 'slave-bin.000001'
SHOW BINLOG EVENTS IN 'slave-bin.000001';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
slave-bin.000001	4	Format_desc	2	256	Server ver: 10.2.8-MariaDB-debug-log, Binlog ver: 4
slave-bin.000001	256	Gtid_list	2	285	[]
slave-bin.000001	285	Binlog_checkpoint	2	328	slave-bin.000001
 
**** SHOW RELAYLOG EVENTS on default ****
relaylog_name = 'slave-relay-bin.000002'
SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000002';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
slave-relay-bin.000002	4	Format_desc	2	256	Server ver: 10.2.8-MariaDB-debug-log, Binlog ver: 4
slave-relay-bin.000002	256	Rotate	1	0	master-bin.000001;pos=4
slave-relay-bin.000002	304	Format_desc	1	256	Server ver: 10.2.8-MariaDB-debug-log, Binlog ver: 4
slave-relay-bin.000002	556	Gtid_list	1	285	[]
slave-relay-bin.000002	585	Binlog_checkpoint	1	329	master-bin.000001
connection default;
 
 == /home/buildbot/build/mysql-test/var/3/tmp/analyze-sync_with_master-mysqld.1.err ==
 
############################## default ##############################
 
**** SHOW WARNINGS on default ****
SHOW WARNINGS;
Level	Code	Message
Error	1160	Got an error writing communication packets
Error	1105	
 
**** SELECT replication-related variables on default ****
SELECT NOW(), @@SERVER_ID;
NOW()	@@SERVER_ID
2017-08-09 18:21:42	1
 
**** SHOW SLAVE STATUS on default ****
SHOW SLAVE STATUS;
 
**** SHOW MASTER STATUS on default ****
SHOW MASTER STATUS;
File	master-bin.000001
Position	473
Binlog_Do_DB	
Binlog_Ignore_DB	
 
**** SHOW SLAVE HOSTS on default ****
SHOW SLAVE HOSTS;
 
**** SHOW PROCESSLIST on default ****
SHOW PROCESSLIST;
Id	User	Host	db	Command	Time	State	Info	Progress
11	root	localhost	NULL	Query	0	init	SHOW PROCESSLIST	0.000
 
**** SHOW BINARY LOGS on default ****
SHOW BINARY LOGS;
Log_name	File_size
master-bin.000001	473
 
**** SHOW BINLOG EVENTS on default ****
binlog_name = 'master-bin.000001'
SHOW BINLOG EVENTS IN 'master-bin.000001';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
master-bin.000001	4	Format_desc	1	256	Server ver: 10.2.8-MariaDB-debug-log, Binlog ver: 4
master-bin.000001	256	Gtid_list	1	285	[]
master-bin.000001	285	Binlog_checkpoint	1	329	master-bin.000001
master-bin.000001	329	Gtid	1	371	GTID 0-1-1
master-bin.000001	371	Query	1	473	use `test`; create table t1 (a int primary key)
 
**** SHOW RELAYLOG EVENTS on default ****
relaylog_name = 'No such row'
SHOW RELAYLOG EVENTS IN 'No such row';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
connection default;



 Comments   
Comment by Elena Stepanova [ 2017-11-10 ]

http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/9977/steps/test_3/logs/stdio

rpl.rpl_start_stop_slave 'row'           w2 [ fail ]
        Test ended at 2017-10-11 03:22:36
 
CURRENT_TEST: rpl.rpl_start_stop_slave
=== SHOW MASTER STATUS ===
---- 1. ----
File	slave-bin.000001
Position	313
Binlog_Do_DB	
Binlog_Ignore_DB	
==========================
 
=== SHOW SLAVE STATUS ===
---- 1. ----
Slave_IO_State	
Master_Host	127.0.0.1
Master_User	root
Master_Port	16000
Connect_Retry	1
Master_Log_File	master-bin.000001
Read_Master_Log_Pos	314
Relay_Log_File	slave-relay-bin.000002
Relay_Log_Pos	603
Relay_Master_Log_File	master-bin.000001
Slave_IO_Running	No
Slave_SQL_Running	Yes
Replicate_Do_DB	
Replicate_Ignore_DB	
Replicate_Do_Table	
Replicate_Ignore_Table	
Replicate_Wild_Do_Table	
Replicate_Wild_Ignore_Table	
Last_Errno	0
Last_Error	
Skip_Counter	0
Exec_Master_Log_Pos	314
Relay_Log_Space	901
Until_Condition	None
Until_Log_File	
Until_Log_Pos	0
Master_SSL_Allowed	No
Master_SSL_CA_File	
Master_SSL_CA_Path	
Master_SSL_Cert	
Master_SSL_Cipher	
Master_SSL_Key	
Seconds_Behind_Master	
Master_SSL_Verify_Server_Cert	No
Last_IO_Errno	0
Last_IO_Error	
Last_SQL_Errno	0
Last_SQL_Error	
Replicate_Ignore_Server_Ids	
Master_Server_Id	1
Master_SSL_Crl	
Master_SSL_Crlpath	
Using_Gtid	No
Gtid_IO_Pos	
Replicate_Do_Domain_Ids	
Replicate_Ignore_Domain_Ids	
Parallel_Mode	conservative
=========================
 
=== SHOW PROCESSLIST ===
---- 1. ----
Id	4
User	root
Host	localhost:55618
db	test
Command	Sleep
Time	300
State	
Info	
Progress	0.000
---- 2. ----
Id	5
User	root
Host	localhost:55619
db	test
Command	Sleep
Time	300
State	
Info	
Progress	0.000
---- 3. ----
Id	7
User	system user
Host	
db	
Command	Connect
Time	300
State	Slave has read all relay log; waiting for the slave I/O thread to update it
Info	
Progress	0.000
---- 4. ----
Id	8
User	root
Host	localhost:55625
db	test
Command	Query
Time	0
State	init
Info	SHOW PROCESSLIST
Progress	0.000
---- 5. ----
Id	9
User	root
Host	localhost:55626
db	test
Command	Sleep
Time	300
State	
Info	
Progress	0.000
========================
 
analyze: sync_with_master
mysqltest: At line 59: sync_slave_with_master failed: 'select master_pos_wait('master-bin.000001', 450, 300, '')' returned -1 indicating timeout after 300 seconds
 
The result from queries just before the failure was:
include/master-slave.inc
[connection master]
set @time_before_kill := (select CURRENT_TIMESTAMP);
[Time before the query]
[Connection ID of the slave I/O thread found]
kill <connection_id>;
set @time_after_kill := (select CURRENT_TIMESTAMP);
[Time after the query]
[Killing of the slave IO thread was successful]
START SLAVE IO_THREAD;
Warnings:
Note	1254	Slave is already running
create table t1 (a int primary key);
 
 
 == /mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/2/tmp/analyze-sync_with_master-mysqld.1.err ==
 
############################## default ##############################
 
**** SHOW WARNINGS on default ****
SHOW WARNINGS;
Level	Code	Message
 
**** SELECT replication-related variables on default ****
SELECT NOW(), @@SERVER_ID;
NOW()	@@SERVER_ID
2017-10-11 03:22:36	1
 
**** SHOW SLAVE STATUS on default ****
SHOW SLAVE STATUS;
 
**** SHOW MASTER STATUS on default ****
SHOW MASTER STATUS;
File	master-bin.000001
Position	450
Binlog_Do_DB	
Binlog_Ignore_DB	
 
**** SHOW SLAVE HOSTS on default ****
SHOW SLAVE HOSTS;
 
**** SHOW PROCESSLIST on default ****
SHOW PROCESSLIST;
Id	User	Host	db	Command	Time	State	Info	Progress
10	root	localhost	NULL	Query	0	init	SHOW PROCESSLIST	0.000
 
**** SHOW BINARY LOGS on default ****
SHOW BINARY LOGS;
Log_name	File_size
master-bin.000001	450
 
**** SHOW BINLOG EVENTS on default ****
binlog_name = 'master-bin.000001'
SHOW BINLOG EVENTS IN 'master-bin.000001';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
master-bin.000001	4	Format_desc	1	249	Server ver: 10.1.29-MariaDB-debug, Binlog ver: 4
master-bin.000001	249	Gtid_list	1	274	[]
master-bin.000001	274	Binlog_checkpoint	1	314	master-bin.000001
master-bin.000001	314	Gtid	1	352	GTID 0-1-1
master-bin.000001	352	Query	1	450	use `test`; create table t1 (a int primary key)
 
**** SHOW RELAYLOG EVENTS on default ****
relaylog_name = 'No such row'
SHOW RELAYLOG EVENTS IN 'No such row';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
 
 == /mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/2/tmp/analyze-sync_with_master-mysqld.2.err ==
 
############################## default ##############################
 
**** SHOW WARNINGS on default ****
SHOW WARNINGS;
Level	Code	Message
 
**** SELECT replication-related variables on default ****
SELECT NOW(), @@SERVER_ID;
NOW()	@@SERVER_ID
2017-10-11 03:22:36	2
 
**** SHOW SLAVE STATUS on default ****
SHOW SLAVE STATUS;
Slave_IO_State	
Master_Host	127.0.0.1
Master_User	root
Master_Port	16000
Connect_Retry	1
Master_Log_File	master-bin.000001
Read_Master_Log_Pos	314
Relay_Log_File	slave-relay-bin.000002
Relay_Log_Pos	603
Relay_Master_Log_File	master-bin.000001
Slave_IO_Running	No
Slave_SQL_Running	Yes
Replicate_Do_DB	
Replicate_Ignore_DB	
Replicate_Do_Table	
Replicate_Ignore_Table	
Replicate_Wild_Do_Table	
Replicate_Wild_Ignore_Table	
Last_Errno	0
Last_Error	
Skip_Counter	0
Exec_Master_Log_Pos	314
Relay_Log_Space	901
Until_Condition	None
Until_Log_File	
Until_Log_Pos	0
Master_SSL_Allowed	No
Master_SSL_CA_File	
Master_SSL_CA_Path	
Master_SSL_Cert	
Master_SSL_Cipher	
Master_SSL_Key	
Seconds_Behind_Master	NULL
Master_SSL_Verify_Server_Cert	No
Last_IO_Errno	0
Last_IO_Error	
Last_SQL_Errno	0
Last_SQL_Error	
Replicate_Ignore_Server_Ids	
Master_Server_Id	1
Master_SSL_Crl	
Master_SSL_Crlpath	
Using_Gtid	No
Gtid_IO_Pos	
Replicate_Do_Domain_Ids	
Replicate_Ignore_Domain_Ids	
Parallel_Mode	conservative
 
**** SHOW MASTER STATUS on default ****
SHOW MASTER STATUS;
File	slave-bin.000001
Position	313
Binlog_Do_DB	
Binlog_Ignore_DB	
 
**** SHOW SLAVE HOSTS on default ****
SHOW SLAVE HOSTS;
 
**** SHOW PROCESSLIST on default ****
SHOW PROCESSLIST;
Id	User	Host	db	Command	Time	State	Info	Progress
7	system user		NULL	Connect	300	Slave has read all relay log; waiting for the slave I/O thread to update it	NULL	0.000
10	root	localhost	NULL	Query	0	init	SHOW PROCESSLIST	0.000
 
**** SHOW BINARY LOGS on default ****
SHOW BINARY LOGS;
Log_name	File_size
slave-bin.000001	313
 
**** SHOW BINLOG EVENTS on default ****
binlog_name = 'slave-bin.000001'
SHOW BINLOG EVENTS IN 'slave-bin.000001';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
slave-bin.000001	4	Format_desc	2	249	Server ver: 10.1.29-MariaDB-debug, Binlog ver: 4
slave-bin.000001	249	Gtid_list	2	274	[]
slave-bin.000001	274	Binlog_checkpoint	2	313	slave-bin.000001
 
**** SHOW RELAYLOG EVENTS on default ****
relaylog_name = 'slave-relay-bin.000002'
SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000002';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
slave-relay-bin.000002	4	Format_desc	2	249	Server ver: 10.1.29-MariaDB-debug, Binlog ver: 4
slave-relay-bin.000002	249	Rotate	1	0	master-bin.000001;pos=4
slave-relay-bin.000002	293	Format_desc	1	249	Server ver: 10.1.29-MariaDB-debug, Binlog ver: 4
slave-relay-bin.000002	538	Gtid_list	1	274	[]
slave-relay-bin.000002	563	Binlog_checkpoint	1	314	master-bin.000001

Comment by Alice Sherepa [ 2017-12-04 ]

also on 10.3 http://buildbot.askmonty.org/buildbot/builders/kvm-rpm-fedora25-x86/builds/1393/steps/mtr/logs/stdio

Comment by Alice Sherepa [ 2020-08-31 ]

recently on 10.5 http://buildbot.askmonty.org/buildbot/builders/kvm-bintar-trusty-amd64/builds/18764/steps/mtr/logs/stdio:

10.5 9ef36faa614528b66e0a6ba5

rpl.rpl_start_stop_slave 'mix'           w1 [ fail ]
        Test ended at 2020-08-28 12:52:21
 
CURRENT_TEST: rpl.rpl_start_stop_slave
analyze: sync_with_master
mysqltest: At line 59: sync_slave_with_master failed: 'select master_pos_wait('master-bin.000001', 473, 300, '')' returned -1 indicating timeout after 300 seconds
 
The result from queries just before the failure was:
include/master-slave.inc
[connection master]
connection slave;
set @time_before_kill := (select CURRENT_TIMESTAMP);
[Time before the query]
[Connection ID of the slave I/O thread found]
kill <connection_id>;
set @time_after_kill := (select CURRENT_TIMESTAMP);
[Time after the query]
[Killing of the slave IO thread was successful]
START SLAVE IO_THREAD;
Warnings:
Note	1254	Slave is already running
connection master;
create table t1 (a int primary key);
 
 
 == /usr/local/mariadb-10.5.6-linux-x86_64/mysql-test/var/1/tmp/analyze-sync_with_master-mysqld.2.err ==
 
############################## default ##############################
 
**** SHOW WARNINGS on default ****
SHOW WARNINGS;
Level	Code	Message
 
**** SELECT replication-related variables on default ****
SELECT NOW(), @@SERVER_ID;
NOW()	@@SERVER_ID
2020-08-28 12:52:21	2
 
**** SHOW SLAVE STATUS on default ****
SHOW SLAVE STATUS;
Slave_IO_State	
Master_Host	127.0.0.1
Master_User	root
Master_Port	16000
Connect_Retry	1
Master_Log_File	master-bin.000001
Read_Master_Log_Pos	329
Relay_Log_File	slave-relay-bin.000002
Relay_Log_Pos	629
Relay_Master_Log_File	master-bin.000001
Slave_IO_Running	No
Slave_SQL_Running	Yes
Replicate_Do_DB	
Replicate_Ignore_DB	
Replicate_Do_Table	
Replicate_Ignore_Table	
Replicate_Wild_Do_Table	
Replicate_Wild_Ignore_Table	
Last_Errno	0
Last_Error	
Skip_Counter	0
Exec_Master_Log_Pos	329
Relay_Log_Space	938
Until_Condition	None
Until_Log_File	
Until_Log_Pos	0
Master_SSL_Allowed	No
Master_SSL_CA_File	
Master_SSL_CA_Path	
Master_SSL_Cert	
Master_SSL_Cipher	
Master_SSL_Key	
Seconds_Behind_Master	NULL
Master_SSL_Verify_Server_Cert	No
Last_IO_Errno	0
Last_IO_Error	
Last_SQL_Errno	0
Last_SQL_Error	
Replicate_Ignore_Server_Ids	
Master_Server_Id	1
Master_SSL_Crl	
Master_SSL_Crlpath	
Using_Gtid	No
Gtid_IO_Pos	
Replicate_Do_Domain_Ids	
Replicate_Ignore_Domain_Ids	
Parallel_Mode	optimistic
SQL_Delay	0
SQL_Remaining_Delay	NULL
Slave_SQL_Running_State	Slave has read all relay log; waiting for more updates
Slave_DDL_Groups	0
Slave_Non_Transactional_Groups	0
Slave_Transactional_Groups	0
 
**** SHOW MASTER STATUS on default ****
SHOW MASTER STATUS;
File	slave-bin.000001
Position	328
Binlog_Do_DB	
Binlog_Ignore_DB	
 
**** SHOW SLAVE HOSTS on default ****
SHOW SLAVE HOSTS;
 
**** SHOW PROCESSLIST on default ****
SHOW PROCESSLIST;
Id	User	Host	db	Command	Time	State	Info	Progress
8	system user		NULL	Slave_SQL	300	Slave has read all relay log; waiting for more updates	NULL	0.000
11	root	localhost	NULL	Query	0	starting	SHOW PROCESSLIST	0.000
 
**** SHOW BINARY LOGS on default ****
SHOW BINARY LOGS;
Log_name	File_size
slave-bin.000001	328
 
**** SHOW BINLOG EVENTS on default ****
binlog_name = 'slave-bin.000001'
SHOW BINLOG EVENTS IN 'slave-bin.000001';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
slave-bin.000001	4	Format_desc	2	256	Server ver: 10.5.6-MariaDB-log, Binlog ver: 4
slave-bin.000001	256	Gtid_list	2	285	[]
slave-bin.000001	285	Binlog_checkpoint	2	328	slave-bin.000001
 
**** SHOW RELAYLOG EVENTS on default ****
relaylog_name = 'slave-relay-bin.000002'
SHOW RELAYLOG EVENTS IN 'slave-relay-bin.000002';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
slave-relay-bin.000002	4	Format_desc	2	256	Server ver: 10.5.6-MariaDB-log, Binlog ver: 4
slave-relay-bin.000002	256	Rotate	1	0	master-bin.000001;pos=4
slave-relay-bin.000002	304	Format_desc	1	256	Server ver: 10.5.6-MariaDB-log, Binlog ver: 4
slave-relay-bin.000002	556	Gtid_list	1	285	[]
slave-relay-bin.000002	585	Binlog_checkpoint	1	329	master-bin.000001
connection default;
 
 == /usr/local/mariadb-10.5.6-linux-x86_64/mysql-test/var/1/tmp/analyze-sync_with_master-mysqld.1.err ==
 
############################## default ##############################
 
**** SHOW WARNINGS on default ****
SHOW WARNINGS;
Level	Code	Message
 
**** SELECT replication-related variables on default ****
SELECT NOW(), @@SERVER_ID;
NOW()	@@SERVER_ID
2020-08-28 12:52:21	1
 
**** SHOW SLAVE STATUS on default ****
SHOW SLAVE STATUS;
 
**** SHOW MASTER STATUS on default ****
SHOW MASTER STATUS;
File	master-bin.000001
Position	473
Binlog_Do_DB	
Binlog_Ignore_DB	
 
**** SHOW SLAVE HOSTS on default ****
SHOW SLAVE HOSTS;
 
**** SHOW PROCESSLIST on default ****
SHOW PROCESSLIST;
Id	User	Host	db	Command	Time	State	Info	Progress
11	root	localhost	NULL	Query	0	starting	SHOW PROCESSLIST	0.000
 
**** SHOW BINARY LOGS on default ****
SHOW BINARY LOGS;
Log_name	File_size
master-bin.000001	473
 
**** SHOW BINLOG EVENTS on default ****
binlog_name = 'master-bin.000001'
SHOW BINLOG EVENTS IN 'master-bin.000001';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
master-bin.000001	4	Format_desc	1	256	Server ver: 10.5.6-MariaDB-log, Binlog ver: 4
master-bin.000001	256	Gtid_list	1	285	[]
master-bin.000001	285	Binlog_checkpoint	1	329	master-bin.000001
master-bin.000001	329	Gtid	1	371	GTID 0-1-1
master-bin.000001	371	Query	1	473	use `test`; create table t1 (a int primary key)
 
**** SHOW RELAYLOG EVENTS on default ****
relaylog_name = 'No such row'
SHOW RELAYLOG EVENTS IN 'No such row';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
connection default;

Comment by Alice Sherepa [ 2021-09-03 ]

According to cross-reference, the latest occurrence was on the 2020-10-16, while the test was failing quite regularly before that. So probably fixed now.

Generated at Thu Feb 08 08:06:36 UTC 2024 using Jira 8.20.16#820016-sha1:9d11dbea5f4be3d4cc21f03a88dd11d8c8687422.