[MDEV-13519] rpl.show_status_stop_slave_race-7126 and other rpl tests fail in buildbot on Assertion `!strcmp(table_list->get_db_name(), table_list->mdl_request.key.db_name()) && !strcmp(table_list->get_table_name(), table_list->mdl_request.key.name())' Created: 2017-08-14  Updated: 2017-08-28  Resolved: 2017-08-28

Status: Closed
Project: MariaDB Server
Component/s: Replication, Tests
Affects Version/s: 10.3
Fix Version/s: 10.3.1

Type: Bug Priority: Major
Reporter: Alice Sherepa Assignee: Andrei Elkin
Resolution: Fixed Votes: 0
Labels: None

Issue Links:
Duplicate
duplicates MDEV-13547 rpl.rpl_stm_flsh_tbls fails in buildbot Closed
duplicates MDEV-13576 rpl.rpl_parallel failed in buildbot Closed
duplicates MDEV-13578 rpl.rpl_row_corruption failed in buil... Closed
duplicates MDEV-13597 binlog_encryption.rpl_skip_replicatio... Closed
Sprint: 10.2.10

 Description   

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

rpl.show_status_stop_slave_race-7126 'stmt' w4 [ fail ]
        Test ended at 2017-08-11 16:56:48
 
CURRENT_TEST: rpl.show_status_stop_slave_race-7126
/mnt/buildbot/build/mariadb-10.3.1/client/mysqlslap: Cannot run query START SLAVE; STOP SLAVE; SHOW GLOBAL STATUS ERROR : Lost connection to MySQL server during query
/mnt/buildbot/build/mariadb-10.3.1/client/mysqlslap: Cannot run query START SLAVE; STOP SLAVE; SHOW GLOBAL STATUS ERROR : Lost connection to MySQL server during query
Warning:   16 bytes lost at 0x8f33928, allocated by T@0 at mysqltest: In included file "./include/wait_for_slave_param.inc": 
included from ./include/wait_for_slave_sql_to_stop.inc at line 36:
included from ./include/wait_for_slave_to_stop.inc at line 34:
included from /mnt/buildbot/build/mariadb-10.3.1/mysql-test/suite/rpl/t/show_status_stop_slave_race-7126.test at line 19:
At line 75: query 'let $_slave_check_configured= query_get_value("SHOW SLAVE STATUS", Slave_IO_Running, 1)' failed: 2013: Lost connection to MySQL server during query
 
The result from queries just before the failure was:
include/master-slave.inc
[connection master]
call mtr.add_suppression("Master is configured to log replication events");
connection slave;
connection slave;
include/wait_for_slave_to_stop.inc
 
 
Server [mysqld.2 - pid: 10033, winpid: 10033, exit: 256] failed during test run
Server log from this test:
----------SERVER LOG START-----------
2017-08-11 16:56:45 2767190848 [Note] Deleted Master_info file '/run/shm/var_auto_KOdk/4/mysqld.2/data/master.info'.
2017-08-11 16:56:45 2767190848 [Note] Deleted Master_info file '/run/shm/var_auto_KOdk/4/mysqld.2/data/relay-log.info'.
2017-08-11 16:56:45 2767190848 [Note] Master connection name: ''  Master_info_file: 'master.info'  Relay_info_file: 'relay-log.info'
2017-08-11 16:56:45 2767190848 [Note] 'CHANGE MASTER TO executed'. Previous state master_host='127.0.0.1', master_port='16020', master_log_file='', master_log_pos='4'. New state master_host='127.0.0.1', master_port='16020', master_log_file='master-bin.000001', master_log_pos='4'.
2017-08-11 16:56:45 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 4
2017-08-11 16:56:45 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 4, relay log './slave-relay-bin.000001' position: 4
2017-08-11 16:56:45 2850732864 [Note] Error reading relay log event: slave SQL thread was killed
2017-08-11 16:56:45 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:45 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:45 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:45 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:45 2851035968 [ERROR] Slave I/O: error connecting to master 'root@127.0.0.1:16020' - retry-time: 1  maximum-retries: 10  message: Lost connection to MySQL server at 'waiting for initial communication packet', system error: 4 "Interrupted system call", Internal MariaDB error code: 2013
2017-08-11 16:56:45 2851035968 [Note] Slave I/O thread killed while connecting to master
2017-08-11 16:56:45 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:45 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:45 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:45 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:45 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:45 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:45 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:45 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:45 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:45 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000002' position: 964
2017-08-11 16:56:46 2851035968 [Note] Error reading relay log event: slave SQL thread was killed
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000007' position: 556
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000007' position: 556
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000007' position: 556
2017-08-11 16:56:46 2850732864 [Note] Error reading relay log event: slave SQL thread was killed
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000009' position: 556
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000012' position: 304
2017-08-11 16:56:46 2851035968 [Note] Error reading relay log event: slave SQL thread was killed
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000022' position: 556
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000022' position: 556
2017-08-11 16:56:46 2850732864 [Note] Error reading relay log event: slave SQL thread was killed
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:46 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:46 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:46 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:47 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:47 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2850732864 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:47 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:47 2850732864 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2851035968 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:47 2851035968 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2850732864 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread killed while calling get_master_version_and_clock(...)
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 664
2017-08-11 16:56:47 2851035968 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'master-bin.000001' at position 664
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 664, relay log './slave-relay-bin.000024' position: 556
2017-08-11 16:56:47 2850732864 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 664
mysqld: /home/buildbot/buildbot/build/mariadb-10.3.1/sql/sql_base.cc:204: uint get_table_def_key(const TABLE_LIST*, const char**): Assertion `!strcmp(table_list->get_db_name(), table_list->mdl_request.key.db_name()) && !strcmp(table_list->get_table_name(), table_list->mdl_request.key.name())' failed.
170811 16:56:47 [ERROR] mysqld got signal 6 ;
This could be because you hit a bug. It is also possible that this binary
or one of the libraries it was linked against is corrupt, improperly built,
or misconfigured. This error can also be caused by malfunctioning hardware.
 
To report this bug, see https://mariadb.com/kb/en/reporting-bugs
 
We will try our best to scrape up some info that will hopefully help
diagnose the problem, but since we have already crashed, 
something is definitely wrong and this may fail.
 
Server version: 10.3.1-MariaDB-debug-log
key_buffer_size=1048576
read_buffer_size=131072
max_used_connections=7
max_threads=153
thread_count=16
It is possible that mysqld could use up to 
key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 61882 K  bytes of memory
Hope that's ok; if not, decrease some variables in the equation.
 
Thread pointer: 0xbe61508
Attempting backtrace. You can use the following information to find out
where mysqld died. If you see no messages after this, something went
terribly wrong...
stack_bottom = 0xa9ef5220 thread_stack 0x49000
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(my_print_stacktrace+0x32)[0x8d7a47e]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(handle_fatal_signal+0x3c7)[0x8625eb3]
[0xb7789400]
[0xb7789424]
/lib/i386-linux-gnu/libc.so.6(gsignal+0x4f)[0xb72651ef]
/lib/i386-linux-gnu/libc.so.6(abort+0x175)[0xb7268835]
/lib/i386-linux-gnu/libc.so.6(+0x27095)[0xb725e095]
/lib/i386-linux-gnu/libc.so.6(+0x27147)[0xb725e147]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_Z17get_table_def_keyPK10TABLE_LISTPPKc+0x97)[0x83044f4]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_Z17tdc_acquire_shareP3THDP10TABLE_LISTjPP5TABLE+0x25)[0x8576986]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_Z10open_tableP3THDP10TABLE_LISTP18Open_table_context+0x979)[0x8307376]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld[0x830a0e6]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_Z11open_tablesP3THDRK14DDL_options_stPP10TABLE_LISTPjjP19Prelocking_strategy+0x299)[0x830aff3]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_Z20open_and_lock_tablesP3THDRK14DDL_options_stP10TABLE_LISTbjP19Prelocking_strategy+0xbe)[0x830c4d3]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_Z20open_and_lock_tablesP3THDP10TABLE_LISTbj+0x5c)[0x83001fc]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_ZN15rpl_slave_state11record_gtidEP3THDPK8rpl_gtidybbPPv+0x252)[0x852a882]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_ZN15rpl_slave_state4loadEP3THDPKcjbb+0xff)[0x852bfe9]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld[0x82c7b16]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(handle_slave_io+0x8bc)[0x82ced2e]
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld[0x883a52c]
/lib/i386-linux-gnu/libpthread.so.0(+0x6d4c)[0xb7511d4c]
/lib/i386-linux-gnu/libc.so.6(clone+0x5e)[0xb7321ace]
 
Trying to get some variables.
Some pointers may be invalid and cause the dump to abort.
Query (0x0): 
Connection ID (thread ID): 210
Status: NOT_KILLED
 
Optimizer switch: index_merge=on,index_merge_union=on,index_merge_sort_union=on,index_merge_intersection=on,index_merge_sort_intersection=off,engine_condition_pushdown=off,index_condition_pushdown=on,derived_merge=on,derived_with_keys=on,firstmatch=on,loosescan=on,materialization=on,in_to_exists=on,semijoin=on,partial_match_rowid_merge=on,partial_match_table_scan=on,subquery_cache=on,mrr=off,mrr_cost_based=off,mrr_sort_keys=off,outer_join_with_cache=on,semijoin_with_cache=on,join_cache_incremental=on,join_cache_hashed=on,join_cache_bka=on,optimize_join_buffer_size=off,table_elimination=on,extended_keys=on,exists_to_in=on,orderby_uses_equalities=on,condition_pushdown_for_derived=on
 
The manual page at http://dev.mysql.com/doc/mysql/en/crashing.html contains
information that should help you find out what is causing the crash.
Writing a core file
----------SERVER LOG END-------------

http://buildbot.askmonty.org/buildbot/builders/p8-rhel6-bintar-debug/builds/1129/steps/test/logs/stdio

63ad4fe5bbe77fe17ab441fcce0106bdee9b618d

mysqld: /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/sql/sql_base.cc:204: uint get_table_def_key(const TABLE_LIST*, const char**): Assertion `!strcmp(table_list->get_db_name(), table_list->mdl_request.key.db_name()) && !strcmp(table_list->get_table_name(), table_list->mdl_request.key.name())' failed.
170809 21:10:47 [ERROR] mysqld got signal 6 ;
 
#7  0x00000fffa344602c in .__assert_fail () from /opt/at7.0/lib64/power7/libc.so.6
#8  0x0000000037c10c64 in ._Z17get_table_def_keyPK10TABLE_LISTPPKc () at /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/sql/sql_base.cc:201
#9  0x0000000037f5c800 in ._Z17tdc_acquire_shareP3THDP10TABLE_LISTjPP5TABLE () at /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/sql/table_cache.cc:793
#10 0x0000000037c144d8 in ._Z10open_tableP3THDP10TABLE_LISTP18Open_table_context () at /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/sql/sql_base.cc:1742
#11 0x0000000037c17d74 in ._ZL22open_and_process_tableP3THDP3LEXP10TABLE_LISTPjjP19Prelocking_strategybP18Open_table_context () at /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/sql/sql_base.cc:3418
#12 0x0000000037c18fd0 in ._Z11open_tablesP3THDRK14DDL_options_stPP10TABLE_LISTPjjP19Prelocking_strategy () at /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/sql/sql_base.cc:3938
#13 0x0000000037c1acc0 in ._Z20open_and_lock_tablesP3THDRK14DDL_options_stP10TABLE_LISTbjP19Prelocking_strategy () at /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/sql/sql_base.cc:4693
#14 0x0000000037c09780 in ._Z20open_and_lock_tablesP3THDP10TABLE_LISTbj () at /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/sql/sql_base.h:495
#15 0x0000000037ef0c84 in ._ZN15rpl_slave_state11record_gtidEP3THDPK8rpl_gtidybbPPv () at /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/sql/rpl_gtid.cc:643
#16 0x0000000037ef2a50 in ._ZN15rpl_slave_state4loadEP3THDPKcmbb () at /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/sql/rpl_gtid.cc:1210
#17 0x0000000037bc36bc in ._ZL28get_master_version_and_clockP8st_mysqlP11Master_info () at /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/sql/slave.cc:2519
#18 0x0000000037bcb464 in .handle_slave_io () at /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/sql/slave.cc:4596
#19 0x00000000389b8bd0 in .pfs_spawn_thread () at /home/buildbot/maria-slave/p8-rhel6-bintar-debug/build/storage/perfschema/pfs.cc:1862
#20 0x00000fffa3cbc548 in .start_thread () from /opt/at7.0/lib64/power7/libpthread.so.0
#21 0x00000fffa3528454 in .__clone () at ../sysdeps/unix/sysv/linux/powerpc/powerpc64/clone.S:104



 Comments   
Comment by Elena Stepanova [ 2017-08-18 ]

rpl.rpl_stm_flsh_tbls and rpl.rpl_parallel are also affected: MDEV-13547 and MDEV-13576.
rpl.rpl_row_corruption failed with the same assertion MDEV-13578, I'm not closing it just yet because it has some debug output, maybe it will be useful.

Comment by Alice Sherepa [ 2017-08-21 ]

binlog_encryption.rpl_skip_replication, rpl.rpl_mdev6020 and rpl.rpl_parallel2 failed the same way. MDEV-13597

Comment by Sergey Vojtovich [ 2017-08-23 ]

We get broken (uninitialized?) table name here. Most probably comes from select_gtid_pos_table.

Comment by Sergey Vojtovich [ 2017-08-25 ]

Aims to be fixed by f753480c726c5c8137cb2f87cc3bc71e8d535098

I don't have strong replication background, but I generally find it suspicious:
How do you guarantee consistency for the SQL thread?
And why the same doesn't work with IO thread?

Comment by Andrei Elkin [ 2017-08-25 ]

Sergey, thanks for the help!

I've just progressed to reproduce the issue, only on BB, for which you already found the solution .
mtr --repeat 100 to [ pass ] which practically validates your guessing.
I am reviewing the Monty's patch to answer your questions really soon.

Andrei

Comment by Sergey Vojtovich [ 2017-08-25 ]

knielsen already answered this question: the lock is only needed if another thread is modifying the list at the time of reading. The lock prevents this in IO and other threads. It is prevented for the SQL threads by a check that prevents the modification while any SQL threads is running.

Comment by Andrei Elkin [ 2017-08-28 ]

Fixed by f753480c726c5c8137cb2f87cc3bc71e8d535098. BB does not show the test failure anymore since its pushing to 10.3.

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