Uploaded image for project: 'MariaDB Server'
  1. MariaDB Server
  2. MDEV-4394

Sporadic failures in multi_source tests

    Details

    • Type: Bug
    • Status: Closed
    • Priority: Major
    • Resolution: Fixed
    • Affects Version/s: 10.0.1
    • Fix Version/s: 10.0.2
    • Component/s: None
    • Labels:

      Description

      http://buildbot.askmonty.org/buildbot/builders/kvm-bintar-precise-x86/builds/703/steps/test/logs/stdio

      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
      

      http://buildbot.askmonty.org/buildbot/builders/kvm-deb-debian6-x86/builds/1939/steps/test_3/logs/stdio

      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
      
      

        Attachments

          Activity

            People

            • Assignee:
              monty Michael Widenius
              Reporter:
              elenst Elena Stepanova
            • Votes:
              0 Vote for this issue
              Watchers:
              2 Start watching this issue

              Dates

              • Created:
                Updated:
                Resolved: