Sporadic failures in multi_source tests

multi_source.info_logs                   w2 [ fail ]

        Test ended at 2013-04-10 05:21:07

CURRENT_TEST: multi_source.info_logs

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 /usr/local/mariadb-10.0.1-linux-i686/mysql-test/suite/multi_source/info_logs.test at line 146:

At line 115: Cannot perform inc/dec on a non-numeric value

The result from queries just before the failure was:

< snip >

#   while 'MASTER 2.2' and '' are running

master-master@00202@002e2.info

master.info

multi-master.info

relay.bin-master@00202@002e2.info

relay.bin.info

# End of list

#

# Contents of multi-master.info

MASTER 2.2

# EOF

#

show all slaves status;

Connection_name	Slave_SQL_State	Slave_IO_State	Master_Host	Master_User	Master_Port	Connect_Retry	Master_Log_File	Read_Master_Log_Pos	Relay_Log_File	Relay_Log_Pos	Relay_Master_Log_File	Slave_IO_Running	Slave_SQL_Running	Replicate_Do_DB	Replicate_Ignore_DB	Replicate_Do_Table	Replicate_Ignore_Table	Replicate_Wild_Do_Table	Replicate_Wild_Ignore_Table	Last_Errno	Last_Error	Skip_Counter	Exec_Master_Log_Pos	Relay_Log_Space	Until_Condition	Until_Log_File	Until_Log_Pos	Master_SSL_Allowed	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	Last_IO_Errno	Last_IO_Error	Last_SQL_Errno	Last_SQL_Error	Replicate_Ignore_Server_Ids	Master_Server_Id	Retried_transactions	Max_relay_log_size	Executed_log_entries	Slave_received_heartbeats	Slave_heartbeat_period

	Slave has read all relay log; waiting for the slave I/O thread to update it	Waiting for master to send event	127.0.0.1	root	MYPORT_1	60	master-bin.000001	286	relay.000002	572	master-bin.000001	Yes	Yes							0		0	286	857	None		0	No						0	No	0		0			1	0	1073741824	6	0	60.000

MASTER 2.2	Slave has read all relay log; waiting for the slave I/O thread to update it	Waiting for master to send event	127.0.0.1	root	MYPORT_2	60	master-bin.000001	286	relay-master@00202@002e2.000002	572	master-bin.000001	Yes	Yes							0		0	286	876	None		0	No						0	No	0		0			2	0	1073741824	6	0	60.000

include/wait_for_slave_to_start.inc

set default_master_connection = 'MASTER 2.2';

include/wait_for_slave_to_start.inc

**** ERROR: timeout after 300 seconds while waiting for slave parameter Slave_SQL_Running = Yes ****

More results from queries before failure can be found in /run/shm/var_auto_qGxp/2/log/info_logs.log

 - saving '/run/shm/var_auto_qGxp/2/log/multi_source.info_logs/' to '/usr/local/mariadb-10.0.1-linux-i686/mysql-test/var/log/multi_source.info_logs/'

Retrying test multi_source.info_logs, attempt(2/3)...

multi_source.info_logs                   w2 [ retry-pass ]   1490

multi_source.multisource 'innodb_plugin' w4 [ fail ]

        Test ended at 2013-04-10 08:29:52

CURRENT_TEST: multi_source.multisource

--- /usr/share/mysql/mysql-test/suite/multi_source/multisource.result	2013-04-10 07:48:58.000000000 +0200

+++ /dev/shm/var/4/log/multisource.reject	2013-04-10 08:29:51.357212484 +0200

@@ -72,7 +72,7 @@

 include/wait_for_slave_to_start.inc

 show all slaves status;

 Connection_name	Slave_SQL_State	Slave_IO_State	Master_Host	Master_User	Master_Port	Connect_Retry	Master_Log_File	Read_Master_Log_Pos	Relay_Log_File	Relay_Log_Pos	Relay_Master_Log_File	Slave_IO_Running	Slave_SQL_Running	Replicate_Do_DB	Replicate_Ignore_DB	Replicate_Do_Table	Replicate_Ignore_Table	Replicate_Wild_Do_Table	Replicate_Wild_Ignore_Table	Last_Errno	Last_Error	Skip_Counter	Exec_Master_Log_Pos	Relay_Log_Space	Until_Condition	Until_Log_File	Until_Log_Pos	Master_SSL_Allowed	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	Last_IO_Errno	Last_IO_Error	Last_SQL_Errno	Last_SQL_Error	Replicate_Ignore_Server_Ids	Master_Server_Id	Retried_transactions	Max_relay_log_size	Executed_log_entries	Slave_received_heartbeats	Slave_heartbeat_period

-	Slave has read all relay log; waiting for the slave I/O thread to update it	Waiting for master to send event	127.0.0.1	root	MYPORT_2	60	master-bin.000001	286	mysqld-relay-bin.000002	572	master-bin.000001	Yes	Yes							0		0	286	868	None		0	No						0	No	0		0			2	0	1073741824	6	0	60.000

+	Slave has read all relay log; waiting for the slave I/O thread to update it	Checking master version	127.0.0.1	root	MYPORT_2	60		4	mysqld-relay-bin.000001	4		Yes	Yes							0		0	0	246	None		0	No						0	No	0		0			0	0	1073741824	1	0	60.000

 master1	Slave has read all relay log; waiting for the slave I/O thread to update it	Waiting for master to send event	127.0.0.1	root	MYPORT_1	60	master-bin.000001	876	mysqld-relay-bin-master1.000002	1162	master-bin.000001	Yes	Yes							0		0	876	1466	None		0	No						0	No	0		0			1	0	1073741824	13	0	60.000

 insert into t1 (f1) values ('three');

 drop database if exists db2;

mysqltest: Result length mismatch

 - saving '/dev/shm/var/4/log/multi_source.multisource-innodb_plugin/' to '/dev/shm/var/log/multi_source.multisource-innodb_plugin/'

Retrying test multi_source.multisource, attempt(2/3)...

multi_source.relaylog_events             w2 [ pass ]    461

multi_source.reset_slave                 w2 [ pass ]    316

multi_source.info_logs                   w3 [ pass ]   3664

multi_source.multisource 'xtradb'        w1 [ pass ]   1518

multi_source.simple                      w2 [ pass ]    576

perfschema.cnf_option                    w3 [ pass ]      5

multi_source.multisource 'innodb_plugin' w4 [ retry-pass ]   1209

Retrying test multi_source.multisource, attempt(3/3)...

multi_source.multisource 'innodb_plugin' w4 [ retry-fail ]

        Test ended at 2013-04-10 08:30:03

CURRENT_TEST: multi_source.multisource

mysqltest: At line 14: query 'change master 'abc' to relay_log_file=''' failed with wrong errno 1201: 'Could not initialize master info structure for 'abc'; more error messages can be found in the MariaDB error log', instead of 1380...

The result from queries just before the failure was:

change master 'abc' to relay_log_file='';

 - skipping '/dev/shm/var/4/log/multi_source.multisource-innodb_plugin/'

multi_source.skip_counter                w2 [ pass ]   1008

***Warnings generated in error logs during shutdown after running tests: multi_source.multisource

130410  8:30:02 [ERROR] Failed to open the relay log './' (relay_log_pos 4)

130410  8:30:02 [ERROR] Could not find target log during relay log initialization

rpl.rpl_auto_increment 'innodb_plugin,mix' w1 [ pass ]   1956