[MDEV-12729] rpl.rpl_domain_id_filter_io_crash failed in buildbot with timeout in include file Created: 2017-05-08  Updated: 2022-02-23  Resolved: 2022-02-23

Status: Closed
Project: MariaDB Server
Component/s: Tests
Affects Version/s: 10.2
Fix Version/s: 10.2.13

Type: Bug Priority: Major
Reporter: Elena Stepanova Assignee: Angelique Sklavounos (Inactive)
Resolution: Done Votes: 0
Labels: None

Issue Links:
Relates
relates to MDEV-13677 rpl.rpl_domain_id_filter_io_crash fai... Closed

 Description   

http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/7873/steps/test_2/logs/stdio

rpl.rpl_domain_id_filter_io_crash 'innodb,row' w1 [ fail ]
        Test ended at 2017-04-26 07:07:47
 
CURRENT_TEST: rpl.rpl_domain_id_filter_io_crash
mysqltest: In included file "./include/wait_for_slave_param.inc": 
included from ./include/wait_for_slave_sql_to_start.inc at line 32:
included from ./include/wait_for_slave_to_start.inc at line 27:
included from ./include/start_slave.inc at line 35:
included from /mnt/buildbot/build/mariadb-10.2.6/mysql-test/suite/rpl/t/rpl_domain_id_filter_io_crash.test at line 382:
At line 119: Timeout in include/wait_for_slave_param.inc
 
The result from queries just before the failure was:
< snip >
master-bin.000001	4862	Annotate_rows	1	4910	INSERT INTO t1 VALUES(27)
master-bin.000001	4910	Table_map	1	4955	table_id: 110 (test.t1)
master-bin.000001	4955	Write_rows_v1	1	4993	table_id: 110 flags: STMT_END_F
master-bin.000001	4993	Xid	1	5024	COMMIT /* xid=41061 */
master-bin.000001	5024	Gtid	1	5066	BEGIN GTID 2-1-4
master-bin.000001	5066	Annotate_rows	1	5114	INSERT INTO t1 VALUES(28)
master-bin.000001	5114	Table_map	1	5159	table_id: 110 (test.t1)
master-bin.000001	5159	Write_rows_v1	1	5197	table_id: 110 flags: STMT_END_F
master-bin.000001	5197	Annotate_rows	1	5245	INSERT INTO t1 VALUES(29)
master-bin.000001	5245	Table_map	1	5290	table_id: 110 (test.t1)
master-bin.000001	5290	Write_rows_v1	1	5328	table_id: 110 flags: STMT_END_F
master-bin.000001	5328	Xid	1	5359	COMMIT /* xid=41066 */
master-bin.000001	5359	Gtid	1	5401	GTID 2-1-5
master-bin.000001	5401	Query	1	5509	use `test`; DROP TABLE `t1` /* generated by server */
 
**** SHOW RELAYLOG EVENTS on server_1 ****
relaylog_name = 'No such row'
SHOW RELAYLOG EVENTS IN 'No such row';
Log_name	Pos	Event_type	Server_id	End_log_pos	Info
connection slave;
 
More results from queries before failure can be found in /mnt/buildbot/build/mariadb-10.2.6/mysql-test/var/1/log/rpl_domain_id_filter_io_crash.log
 
 - saving '/mnt/buildbot/build/mariadb-10.2.6/mysql-test/var/1/log/rpl.rpl_domain_id_filter_io_crash-innodb,row/' to '/mnt/buildbot/build/mariadb-10.2.6/mysql-test/var/log/rpl.rpl_domain_id_filter_io_crash-innodb,row/'
 
Retrying test rpl.rpl_domain_id_filter_io_crash, attempt(2/3)...
 
worker[1] > Restart  - not started
worker[1] > Restart  - not started
***Warnings generated in error logs during shutdown after running tests: rpl.rpl_bug26395 rpl.rpl_commit_after_flush rpl.rpl_domain_id_filter_io_crash rpl.rpl_domain_id_filter rpl.rpl_delayed_slave2 rpl.rpl_checksum_cache
 
2017-04-26  7:02:41 2768960320 [ERROR] Slave I/O: Relay log write failure: could not queue event from master, Internal MariaDB error code: 1595
2017-04-26  7:02:41 2768960320 [ERROR] Slave I/O: Relay log write failure: could not queue event from master, Internal MariaDB error code: 1595
2017-04-26  7:02:41 2768960320 [ERROR] Slave I/O: Relay log write failure: could not queue event from master, Internal MariaDB error code: 1595
2017-04-26  7:02:42 2842643264 [ERROR] Slave I/O: Relay log write failure: could not queue event from master, Internal MariaDB error code: 1595
2017-04-26  7:02:42 2768960320 [ERROR] Slave I/O: Relay log write failure: could not queue event from master, Internal MariaDB error code: 1595
2017-04-26  7:02:42 2842643264 [ERROR] Slave I/O: Relay log write failure: could not queue event from master, Internal MariaDB error code: 1595
2017-04-26  7:02:43 2768960320 [Warning] Slave: Table 'test.t1' doesn't exist Error_code: 1146



 Comments   
Comment by Andrei Elkin [ 2022-02-22 ]

angelique.sklavounos: This is an old ticket so needs verification first.

Comment by Angelique Sklavounos (Inactive) [ 2022-02-23 ]

From a search on Multi-CI Cross reference, this fail happened twice more on development branches in 2017, but not since then for this test.

However the message "At line 119: Timeout in include/wait_for_slave_param.inc" intermittently shows up in other rpl and binlog tests.

Comment by Andrei Elkin [ 2022-02-23 ]

angelique.sklavounos: Basing on no more incidents since 2017 it should be more that OK to close this one. I am leaving that to you.
To other _ Timeout in include/wait_for_slave_param.inc_, it is normal 'cos a lot of tests employ this macro, each may time out for a "personal" reason.

Comment by Angelique Sklavounos (Inactive) [ 2022-02-23 ]

The last fail of this test with this error was at 2017-12-05 20:40:38 on kvm-fulltest2 with revision b863106917e14df62b51d1f944f7046d. Test is stable now.

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