rpl.rpl_mdev6020 'innodb,row' w2 [ fail ]
|
Test ended at 2017-08-20 23:09:58
|
|
CURRENT_TEST: rpl.rpl_mdev6020
|
mysqltest: In included file "./include/wait_for_slave_param.inc":
|
included from ./include/wait_for_slave_io_to_start.inc at line 40:
|
included from ./include/wait_for_slave_to_start.inc at line 26:
|
included from ./include/start_slave.inc at line 35:
|
included from /mnt/buildbot/build/mariadb-10.3.1/mysql-test/suite/rpl/t/rpl_mdev6020.test at line 66:
|
At line 119: query 'let $_show_slave_status_value= query_get_value("SHOW SLAVE STATUS", $slave_param, 1)' failed: 2013: Lost connection to MySQL server during query
|
|
The result from queries just before the failure was:
|
< snip >
|
test.table1_int_autoinc 478809705
|
test.table1_key_pk_parts_2_int_autoinc 3032208641
|
test.table2_int_autoinc 854763867
|
test.table2_key_pk_parts_2_int_autoinc 4231615291
|
include/stop_slave.inc
|
SET GLOBAL default_storage_engine= @old_engine;
|
SET GLOBAL slave_parallel_threads=@old_parallel;
|
SET sql_log_bin=0;
|
DROP TABLE table0_int_autoinc;
|
DROP TABLE table0_key_pk_parts_2_int_autoinc;
|
DROP TABLE table100_int_autoinc;
|
DROP TABLE table100_key_pk_parts_2_int_autoinc;
|
DROP TABLE table10_int_autoinc;
|
DROP TABLE table10_key_pk_parts_2_int_autoinc;
|
DROP TABLE table1_int_autoinc;
|
DROP TABLE table1_key_pk_parts_2_int_autoinc;
|
DROP TABLE table2_int_autoinc;
|
DROP TABLE table2_key_pk_parts_2_int_autoinc;
|
SET sql_log_bin=1;
|
include/start_slave.inc
|
|
More results from queries before failure can be found in /mnt/buildbot/build/mariadb-10.3.1/mysql-test/var/2/log/rpl_mdev6020.log
|
|
|
Server [mysqld.2 - pid: 1149, winpid: 1149, exit: 256] failed during test run
|
Server log from this test:
|
----------SERVER LOG START-----------
|
2017-08-20 23:09:37 3072342336 [Note] /mnt/buildbot/build/mariadb-10.3.1/sql/mysqld (mysqld 10.3.1-MariaDB-debug-log) starting as process 1150 ...
|
2017-08-20 23:09:37 3072342336 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
|
2017-08-20 23:09:37 3072342336 [Note] InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
|
2017-08-20 23:09:37 3072342336 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
|
2017-08-20 23:09:37 3072342336 [Note] InnoDB: Uses event mutexes
|
2017-08-20 23:09:37 3072342336 [Note] InnoDB: Compressed tables use zlib 1.2.3.4
|
2017-08-20 23:09:37 3072342336 [Note] InnoDB: Using Linux native AIO
|
2017-08-20 23:09:37 3072342336 [Note] InnoDB: Number of pools: 1
|
2017-08-20 23:09:37 3072342336 [Note] InnoDB: Using generic crc32 instructions
|
2017-08-20 23:09:37 3072342336 [Note] InnoDB: Initializing buffer pool, total size = 8M, instances = 1, chunk size = 8M
|
2017-08-20 23:09:37 3072342336 [Note] InnoDB: Completed initialization of buffer pool
|
2017-08-20 23:09:37 2905316160 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
|
2017-08-20 23:09:38 3072342336 [Note] InnoDB: 128 out of 128 rollback segments are active.
|
2017-08-20 23:09:38 3072342336 [Note] InnoDB: Creating shared tablespace for temporary tables
|
2017-08-20 23:09:38 3072342336 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
|
2017-08-20 23:09:38 3072342336 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
|
2017-08-20 23:09:38 3072342336 [Note] InnoDB: Waiting for purge to start
|
2017-08-20 23:09:38 3072342336 [Note] InnoDB: 5.7.19 started; log sequence number 1632791
|
2017-08-20 23:09:38 2802842432 [Note] InnoDB: Loading buffer pool(s) from /run/shm/var_auto_Payq/2/mysqld.2/data/ib_buffer_pool
|
2017-08-20 23:09:38 2802842432 [Note] InnoDB: Buffer pool(s) load completed at 170820 23:09:38
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'SEQUENCE' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_CMP' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'FEEDBACK' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'user_variables' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_MUTEXES' is disabled.
|
2017-08-20 23:09:38 3072342336 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
|
2017-08-20 23:09:38 3072342336 [Warning] /mnt/buildbot/build/mariadb-10.3.1/sql/mysqld: unknown option '--loose-pam-debug'
|
2017-08-20 23:09:38 3072342336 [Note] Server socket created on IP: '127.0.0.1'.
|
2017-08-20 23:09:38 3072342336 [Note] Reading of all Master_info entries succeded
|
2017-08-20 23:09:38 3072342336 [Note] Added new Master_info '' to hash table
|
2017-08-20 23:09:38 3072342336 [Note] /mnt/buildbot/build/mariadb-10.3.1/sql/mysqld: ready for connections.
|
Version: '10.3.1-MariaDB-debug-log' socket: '/mnt/buildbot/build/mariadb-10.3.1/mysql-test/var/tmp/2/mysqld.2.sock' port: 16001 Source distribution
|
2017-08-20 23:09:38 2896923456 [Note] Deleted Master_info file '/mnt/buildbot/build/mariadb-10.3.1/mysql-test/var/2/mysqld.2/data/master.info'.
|
2017-08-20 23:09:38 2896923456 [Note] Deleted Master_info file '/mnt/buildbot/build/mariadb-10.3.1/mysql-test/var/2/mysqld.2/data/relay-log.info'.
|
2017-08-20 23:09:39 2896923456 [Note] Master connection name: '' Master_info_file: 'master.info' Relay_info_file: 'relay-log.info'
|
2017-08-20 23:09:39 2896923456 [Note] 'CHANGE MASTER TO executed'. Previous state master_host='', master_port='3306', master_log_file='', master_log_pos='4'. New state master_host='127.0.0.1', master_port='16000', master_log_file='master-bin.000001', master_log_pos='4'.
|
2017-08-20 23:09:39 2842643264 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16000',replication started in log 'master-bin.000001' at position 4
|
2017-08-20 23:09:39 2842340160 [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-20 23:09:39 2842340160 [Note] Error reading relay log event: slave SQL thread was killed
|
2017-08-20 23:09:39 2842340160 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 329
|
2017-08-20 23:09:39 2842643264 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 329
|
2017-08-20 23:09:43 2842037056 [Note] Master connection name: '' Master_info_file: 'master.info' Relay_info_file: 'relay-log.info'
|
2017-08-20 23:09:43 2842037056 [Note] 'CHANGE MASTER TO executed'. Previous state master_host='127.0.0.1', master_port='16000', master_log_file='master-bin.000001', master_log_pos='329'. New state master_host='127.0.0.1', master_port='16000', master_log_file='master-bin.000001', master_log_pos='4'.
|
2017-08-20 23:09:43 2842643264 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16000',replication started in log 'master-bin.000001' at position 4
|
2017-08-20 23:09:43 2842340160 [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-20 23:09:57 2842340160 [Note] Error reading relay log event: slave SQL thread was killed
|
2017-08-20 23:09:57 2842340160 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000002' at position 343
|
2017-08-20 23:09:57 2842643264 [Note] Slave I/O thread exiting, read up to log 'master-bin.000002', position 343
|
2017-08-20 23:09:57 2842340160 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16000',replication started in log 'master-bin.000002' at position 343
|
2017-08-20 23:09:57 2769271616 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000002' at position 343, relay log './slave-relay-bin.000003' position: 639
|
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.
|
170820 23:09:57 [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=4
|
max_threads=153
|
thread_count=13
|
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: 0xa21778d8
|
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 = 0xa96aa220 thread_stack 0x49000
|
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(my_print_stacktrace+0x32)[0x8d7e50e]
|
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(handle_fatal_signal+0x3c7)[0x86292ef]
|
[0xb7757400]
|
[0xb7757424]
|
/lib/i386-linux-gnu/libc.so.6(gsignal+0x4f)[0xb72331ef]
|
/lib/i386-linux-gnu/libc.so.6(abort+0x175)[0xb7236835]
|
/lib/i386-linux-gnu/libc.so.6(+0x27095)[0xb722c095]
|
/lib/i386-linux-gnu/libc.so.6(+0x27147)[0xb722c147]
|
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_Z17get_table_def_keyPK10TABLE_LISTPPKc+0x97)[0x8305860]
|
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_Z17tdc_acquire_shareP3THDP10TABLE_LISTjPP5TABLE+0x25)[0x857a1da]
|
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_Z10open_tableP3THDP10TABLE_LISTP18Open_table_context+0x979)[0x83086e2]
|
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld[0x830b452]
|
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_Z11open_tablesP3THDRK14DDL_options_stPP10TABLE_LISTPjjP19Prelocking_strategy+0x299)[0x830c35f]
|
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_Z20open_and_lock_tablesP3THDRK14DDL_options_stP10TABLE_LISTbjP19Prelocking_strategy+0xbe)[0x830d83f]
|
/mnt/buildbot/build/mariadb-10.3.1/sql/mysqld(_Z20open_and_lock_tablesP3THDP10TABLE_LISTbj+0x5c)[0x8301566]
|
mysys/stacktrace.c:267(my_print_stacktrace)[0x852df0a]
|
sql/sql_base.cc:206(get_table_def_key(TABLE_LIST const*, char const**))[0x852f671]
|
sql/table_cache.cc:793(tdc_acquire_share(THD*, TABLE_LIST*, unsigned int, TABLE**))[0x82c8e5e]
|
sql/rpl_gtid.cc:643(rpl_slave_state::record_gtid(THD*, rpl_gtid const*, unsigned long long, bool, bool, void**))[0x82d0076]
|
sql/slave.cc:2519(get_master_version_and_clock)[0x883dd98]
|
perfschema/pfs.cc:1864(pfs_spawn_thread)[0xb74dfd4c]
|
/lib/i386-linux-gnu/libc.so.6(clone+0x5e)[0xb72eface]
|
|
Trying to get some variables.
|
Some pointers may be invalid and cause the dump to abort.
|
Query (0x0):
|
Connection ID (thread ID): 30
|
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,split_grouping_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-------------
|