Skip to:

  1. Skip to Jira Navigation
  2. Skip to Side Navigation
  3. Skip to Main Content

Assertion `innodb_trx_id == 0 || innodb_trx_id == trx_id || trx_id == 0' durin CHANGE MASTER

Description

 

Thread 1 (Thread 0x7f6a988b1700 (LWP 165054)): #0 __pthread_kill (threadid=<optimized out>, signo=6) at ../sysdeps/unix/sysv/linux/pthread_kill.c:56 #1 0x00005559d888107f in my_write_core (sig=6) at /home/venki/work/ps/57/mysys/stacktrace.c:370 #2 0x00005559d85cdf16 in handle_fatal_signal (sig=6) at /home/venki/work/ps/57/sql/signal_handler.cc:255 #3 <signal handler called> #4 __GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:50 #5 0x00007f6aa007e859 in __GI_abort () at abort.c:79 #6 0x00007f6aa007e729 in __assert_fail_base (fmt=0x7f6aa0214588 "%s%s%s:%u: %s%sAssertion `%s' failed.\n%n", assertion=0x5559d8fb5c28 "innodb_trx_id == 0 || innodb_trx_id == trx_id || trx_id == 0", file=0x5559d8fb5b70 "/home/venki/work/ps/57/sql/sql_class.h", line=2251, function=<optimized out>) at assert.c:92 #7 0x00007f6aa008ff36 in __GI___assert_fail (assertion=0x5559d8fb5c28 "innodb_trx_id == 0 || innodb_trx_id == trx_id || trx_id == 0", file=0x5559d8fb5b70 "/home/venki/work/ps/57/sql/sql_class.h", line=2251, function=0x5559d8fb7140 <THD::mark_innodb_used(unsigned long long)::__PRETTY_FUNCTION__> "void THD::mark_innodb_used(ulonglong)") at assert.c:101 #8 0x00005559d8406936 in THD::mark_innodb_used (this=0x7f6a18000e10, trx_id=1287) at /home/venki/work/ps/57/sql/sql_class.h:2251 #9 0x00005559d83f8a25 in thd_report_innodb_stat (thd=0x7f6a18000e10, trx_id=1287, type=MYSQL_TRX_STAT_ACCESS_PAGE_ID, value=16777235) at /home/venki/work/ps/57/sql/sql_class.cc:902 #10 0x00005559d8c49f30 in trx_stats::inc_page_get (trx=..., page_id_fold=16777235) at /home/venki/work/ps/57/storage/innobase/include/trx0trx.h:1533 #11 0x00005559d8c49ef2 in trx_stats::inc_page_get (trx=0x7f6a9ac79aa0, page_id_fold=16777235) at /home/venki/work/ps/57/storage/innobase/include/trx0trx.h:1527 #12 0x00005559d8c420e2 in buf_page_get_gen (page_id=..., page_size=..., rw_latch=1, guess=0x7f6a98b39dd0, mode=10, file=0x5559d932dac0 "/home/venki/work/ps/57/storage/innobase/row/row0sel.cc", line=5345, mtr=0x7f6a988ad890, dirty_with_no_latch=false, err=0x7f6a988ac100) at /home/venki/work/ps/57/storage/innobase/buf/buf0buf.cc:4931 #13 0x00005559d8bffbb4 in btr_cur_search_to_nth_level (index=0x5559da915480, level=0, tuple=0x7f6a18005b58, mode=PAGE_CUR_GE, latch_mode=1, cursor=0x7f6a18005948, has_search_latch=0, file=0x5559d932dac0 "/home/venki/work/ps/57/storage/innobase/row/row0sel.cc", line=5345, mtr=0x7f6a988ad890) at /home/venki/work/ps/57/storage/innobase/btr/btr0cur.cc:1128 #14 0x00005559d8b17813 in btr_pcur_open_with_no_init_func (index=0x5559da915480, tuple=0x7f6a18005b58, mode=PAGE_CUR_GE, latch_mode=1, cursor=0x7f6a18005948, has_search_latch=0, file=0x5559d932dac0 "/home/venki/work/ps/57/storage/innobase/row/row0sel.cc", line=5345, mtr=0x7f6a988ad890) at /home/venki/work/ps/57/storage/innobase/include/btr0pcur.ic:542 #15 0x00005559d8b23606 in row_search_mvcc (buf=0x7f6a184eebd0 "\377\377", mode=PAGE_CUR_GE, prebuilt=0x7f6a18005730, match_mode=1, direction=0) at /home/venki/work/ps/57/storage/innobase/row/row0sel.cc:5343 #16 0x00005559d895ee7d in ha_innobase::index_read (this=0x7f6a184ee690, buf=0x7f6a184eebd0 "\377\377", key_ptr=0x7f6a988adff0 ' ' <repeats 192 times>, "\260\301\210\332YU", key_len=192, find_flag=HA_READ_KEY_EXACT) at /home/venki/work/ps/57/storage/innobase/handler/ha_innodb.cc:10014 #17 0x00005559d7e0169e in handler::index_read_map (this=0x7f6a184ee690, buf=0x7f6a184eebd0 "\377\377", key=0x7f6a988adff0 ' ' <repeats 192 times>, "\260\301\210\332YU", keypart_map=18446744073709551615, find_flag=HA_READ_KEY_EXACT) at /home/venki/work/ps/57/sql/handler.h:2996 #18 0x00005559d7dfce39 in handler::index_read_idx_map (this=0x7f6a184ee690, buf=0x7f6a184eebd0 "\377\377", index=0, key=0x7f6a988adff0 ' ' <repeats 192 times>, "\260\301\210\332YU", keypart_map=18446744073709551615, find_flag=HA_READ_KEY_EXACT) at /home/venki/work/ps/57/sql/handler.cc:8065 #19 0x00005559d7df1ca9 in handler::ha_index_read_idx_map (this=0x7f6a184ee690, buf=0x7f6a184eebd0 "\377\377", index=0, key=0x7f6a988adff0 ' ' <repeats 192 times>, "\260\301\210\332YU", keypart_map=18446744073709551615, find_flag=HA_READ_KEY_EXACT) at /home/venki/work/ps/57/sql/handler.cc:3337 #20 0x00005559d883ea07 in Rpl_info_table_access::find_info (this=0x5559da88c1b0, field_values=0x5559da8ecf60, table=0x7f6a181d2a20) at /home/venki/work/ps/57/sql/rpl_info_table_access.cc:140 #21 0x00005559d8856c97 in Rpl_info_table::do_flush_info (this=0x5559da913960, force=true) at /home/venki/work/ps/57/sql/rpl_info_table.cc:194 #22 0x00005559d8830bde in Rpl_info_handler::flush_info (this=0x5559da913960, force=true) at /home/venki/work/ps/57/sql/rpl_info_handler.h:101 #23 0x00005559d882f9d5 in Master_info::flush_info (this=0x5559da8c18a0, force=true) at /home/venki/work/ps/57/sql/rpl_mi.cc:281 #24 0x00005559d882fb80 in Master_info::mi_init_info (this=0x5559da8c18a0) at /home/venki/work/ps/57/sql/rpl_mi.cc:328 #25 0x00005559d880beb4 in load_mi_and_rli_from_repositories (mi=0x5559da8c18a0, ignore_if_no_info=false, thread_mask=3) at /home/venki/work/ps/57/sql/rpl_slave.cc:1355 #26 0x00005559d8828b29 in change_master (thd=0x7f6a18000e10, mi=0x5559da8c18a0, lex_mi=0x7f6a18003b08, preserve_logs=false) at /home/venki/work/ps/57/sql/rpl_slave.cc:11313 #27 0x00005559d8829cdd in change_master_cmd (thd=0x7f6a18000e10) at /home/venki/work/ps/57/sql/rpl_slave.cc:11836 #28 0x00005559d8466697 in mysql_execute_command (thd=0x7f6a18000e10, first_level=true) at /home/venki/work/ps/57/sql/sql_parse.cc:3202 #29 0x00005559d846e60c in mysql_parse (thd=0x7f6a18000e10, parser_state=0x7f6a988b04a0, update_userstat=false) at /home/venki/work/ps/57/sql/sql_parse.cc:5927 #30 0x00005559d8462609 in dispatch_command (thd=0x7f6a18000e10, com_data=0x7f6a988b0dc0, command=COM_QUERY) at /home/venki/work/ps/57/sql/sql_parse.cc:1539 #31 0x00005559d8461399 in do_command (thd=0x7f6a18000e10) at /home/venki/work/ps/57/sql/sql_parse.cc:1060 #32 0x00005559d85a8432 in handle_connection (arg=0x5559dab05060) at /home/venki/work/ps/57/sql/conn_handler/connection_handler_per_thread.cc:325 #33 0x00005559d88a6f6c in pfs_spawn_thread (arg=0x5559da9c3740) at /home/venki/work/ps/57/storage/perfschema/pfs.cc:2198 #34 0x00007f6aa0256609 in start_thread (arg=<optimized out>) at pthread_create.c:477 #35 0x00007f6aa017b103 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95

 

 

Steps to Reproduce:

  1. Apply the 

  1. Build the server and run the `rpl_chm_crash` MTR test

Environment

None

Attachments

1
  • 09 Feb 2021, 12:23 PM

Smart Checklist

Activity

Show:

Venkatesh Prasad February 9, 2021 at 12:49 PM

It happens only with log_slow_verbosity=innodb or log_slow_verbosity=full

Venkatesh Prasad February 9, 2021 at 12:45 PM

It looks like this bug happens only when both master_info_repository=table and  log_slow_verbosity=full.

Easily reproducible by running

./mtr rpl_0 --mysqld=--master_info_repository=table --mysqld=--log_slow_verbosity=full

Details

Assignee

Reporter

Time tracking

1h logged

Affects versions

Priority

Smart Checklist

Created February 9, 2021 at 12:24 PM
Updated March 6, 2024 at 10:42 AM