[MDEV-18058] [Draft] InnoDB: Assertion failure in file /home/travis/src/storage/innobase/trx/trx0i_s.cc line 1278 Created: 2018-12-21  Updated: 2023-11-27  Resolved: 2023-11-27

Status: Closed
Project: MariaDB Server
Component/s: Storage Engine - InnoDB
Affects Version/s: 10.2, 10.4
Fix Version/s: N/A

Type: Bug Priority: Major
Reporter: Elena Stepanova Assignee: Unassigned
Resolution: Cannot Reproduce Votes: 0
Labels: None

Issue Links:
Relates
relates to MDEV-17663 [Draft] InnoDB: Assertion failure in ... Closed

 Description   

https://travis-ci.org/elenst/travis-tests/jobs/470125235
2329 3 1

10.2 610e4034d7ba34c6b4cba1e1b5faf45eba835498

 
2018-12-19 22:05:49 0x7f73d54d6700  InnoDB: Assertion failure in file /home/travis/src/storage/innobase/trx/trx0i_s.cc line 1278
 
InnoDB: We intentionally generate a memory trap.
 
 
 
#6  0x000055aa7a3d1c21 in ut_dbg_assertion_failed (expr=0x0, file=0x55aa7a996948 "/home/travis/src/storage/innobase/trx/trx0i_s.cc", line=1278) at /home/travis/src/storage/innobase/ut/ut0dbg.cc:60
 
#7  0x000055aa7a395e59 in fetch_data_into_cache_low (cache=0x55aa7b333900 <trx_i_s_cache_static>, read_write=false, trx_list=0x55aa7c62dc08) at /home/travis/src/storage/innobase/trx/trx0i_s.cc:1278
 
#8  0x000055aa7a396039 in fetch_data_into_cache (cache=0x55aa7b333900 <trx_i_s_cache_static>) at /home/travis/src/storage/innobase/trx/trx0i_s.cc:1329
 
#9  0x000055aa7a3960f0 in trx_i_s_possibly_fetch_data_into_cache (cache=0x55aa7b333900 <trx_i_s_cache_static>) at /home/travis/src/storage/innobase/trx/trx0i_s.cc:1354
 
#10 0x000055aa7a20d155 in trx_i_s_common_fill_table (thd=0x7f73e85851b0, tables=0x7f73e833bf18) at /home/travis/src/storage/innobase/handler/i_s.cc:1222
 
#11 0x000055aa79de4090 in get_schema_tables_result (join=0x7f73e89eb1a8, executed_place=PROCESSED_BY_JOIN_EXEC) at /home/travis/src/sql/sql_show.cc:8348
 
#12 0x000055aa79d80e4f in JOIN::exec_inner (this=0x7f73e89eb1a8) at /home/travis/src/sql/sql_select.cc:3585
 
#13 0x000055aa79d8050a in JOIN::exec (this=0x7f73e89eb1a8) at /home/travis/src/sql/sql_select.cc:3416
 
#14 0x000055aa79d816cc in mysql_select (thd=0x7f73e85851b0, tables=0x7f73e833bf18, wild_num=0, fields=..., conds=0x7f73e8a7d150, og_num=0, order=0x0, group=0x0, having=0x7f73e8a5e208, proc_param=0x0, select_options=2953054976, result=0x7f73e8b03df8, unit=0x7f73e858c5c0, select_lex=0x7f73e858ccf8) at /home/travis/src/sql/sql_select.cc:3816
 
#15 0x000055aa79d080fd in mysql_derived_fill (thd=0x7f73e85851b0, lex=0x7f73e8588cc8, derived=0x7f73e858ac88) at /home/travis/src/sql/sql_derived.cc:1126
 
#16 0x000055aa79d0600e in mysql_handle_single_derived (lex=0x7f73e8588cc8, derived=0x7f73e858ac88, phases=96) at /home/travis/src/sql/sql_derived.cc:197
 
#17 0x000055aa79d96d6f in st_join_table::preread_init (this=0x7f73e88fb1d8) at /home/travis/src/sql/sql_select.cc:12012
 
#18 0x000055aa79da6ea7 in sub_select (join=0x7f73e8b02188, join_tab=0x7f73e88fb1d8, end_of_records=false) at /home/travis/src/sql/sql_select.cc:18730
 
#19 0x000055aa79da65e0 in do_select (join=0x7f73e8b02188, procedure=0x0) at /home/travis/src/sql/sql_select.cc:18306
 
#20 0x000055aa79d8105b in JOIN::exec_inner (this=0x7f73e8b02188) at /home/travis/src/sql/sql_select.cc:3621
 
#21 0x000055aa79d8050a in JOIN::exec (this=0x7f73e8b02188) at /home/travis/src/sql/sql_select.cc:3416
 
#22 0x000055aa79d816cc in mysql_select (thd=0x7f73e85851b0, tables=0x7f73e858ac88, wild_num=1, fields=..., conds=0x0, og_num=0, order=0x0, group=0x0, having=0x0, proc_param=0x0, select_options=551903562496, result=0x7f73e8b02168, unit=0x7f73e8588d90, select_lex=0x7f73e85894c8) at /home/travis/src/sql/sql_select.cc:3816
 
#23 0x000055aa79d7598a in handle_select (thd=0x7f73e85851b0, lex=0x7f73e8588cc8, result=0x7f73e8b02168, setup_tables_done_option=0) at /home/travis/src/sql/sql_select.cc:376
 
#24 0x000055aa79d40e14 in execute_sqlcom_select (thd=0x7f73e85851b0, all_tables=0x7f73e858ac88) at /home/travis/src/sql/sql_parse.cc:6480
 
#25 0x000055aa79d36a90 in mysql_execute_command (thd=0x7f73e85851b0) at /home/travis/src/sql/sql_parse.cc:3486
 
#26 0x000055aa79d44c9f in mysql_parse (thd=0x7f73e85851b0, rawbuf=0x7f73e858a9c8 "SELECT * FROM transforms.view_23586_merge /* TRANSFORM_OUTCOME_UNORDERED_MATCH */ /* QNO 7956 CON_ID 16 */", length=106, parser_state=0x7f73d54d5250, is_com_multi=false, is_next_command=false) at /home/travis/src/sql/sql_parse.cc:8014
 
#27 0x000055aa79d322f0 in dispatch_command (command=COM_QUERY, thd=0x7f73e85851b0, packet=0x7f73e85567d1 "", packet_length=107, is_com_multi=false, is_next_command=false) at /home/travis/src/sql/sql_parse.cc:1825
 
#28 0x000055aa79d30c4c in do_command (thd=0x7f73e85851b0) at /home/travis/src/sql/sql_parse.cc:1379
 
#29 0x000055aa79e8324e in do_handle_one_connection (connect=0x55aa7cb37ba0) at /home/travis/src/sql/sql_connect.cc:1335
 
#30 0x000055aa79e82fce in handle_one_connection (arg=0x55aa7cb37ba0) at /home/travis/src/sql/sql_connect.cc:1241
 
#31 0x00007f73ed8886ba in start_thread () from /lib/x86_64-linux-gnu/libpthread.so.0
 
#32 0x00007f73ecd1d41d in clone () from /lib/x86_64-linux-gnu/libc.so.6
 
 
 
Query (0x7f73e858a9c8): SELECT * FROM transforms.view_23586_merge /* TRANSFORM_OUTCOME_UNORDERED_MATCH */ /* QNO 7956 CON_ID 16 */
 
Connection ID (thread ID): 16
 
Status: NOT_KILLED

elenst-jira-refs 89b8fe9456508bc7310e88e88143ceedea77b2fe

 
perl ./runall-new.pl --basedir=/home/travis/server --vardir=/home/travis/logs/vardir --duration=350 --threads=6 --seed=1545256913 --reporters=Backtrace,ErrorLog,Deadlock --validators=TransformerNoComparator --views --redefine=conf/mariadb/alter_table.yy --redefine=conf/mariadb/sp.yy --redefine=conf/mariadb/bulk_insert.yy --redefine=conf/mariadb/modules/foreign_keys.yy --redefine=conf/mariadb/modules/admin.yy --redefine=conf/mariadb/modules/sql_mode.yy --mysqld=--log_output=FILE --mysqld=--max-statement-time=30 --mysqld=--lock-wait-timeout=10 --mysqld=--loose-innodb-lock-wait-timeout=5 --mysqld=--loose-debug_assert_on_not_freed_memory=0 --grammar=conf/runtime/information_schema.yy --transformers=ExecuteAsCTE,ExecuteAsExecuteImmediate,ExecuteAsDeleteReturning,ExecuteAsInsertSelect,ExecuteAsUnion,ExecuteAsUpdateDelete,ExecuteAsView,ExecuteAsPreparedTwice

Not reproducible right away.

 Comments   
Comment by Elena Stepanova [ 2019-01-15 ]

Same problem on 10.4: https://travis-ci.org/elenst/travis-tests/jobs/479014641

Comment by Elena Stepanova [ 2019-02-15 ]

https://travis-ci.org/elenst/travis-tests/jobs/491630398 [2728 4 4]

Comment by Elena Stepanova [ 2019-04-29 ]

Another occurrence on 10.4: https://travis-ci.org/elenst/travis-tests/jobs/525619646 [3300 20 1]

Comment by Alice Sherepa [ 2020-04-03 ]

also on 10.5

2020-04-03  9:58:18 14 [ERROR] InnoDB: Cannot save table statistics for table `transforms`.`insert_select_31735`: Lock wait timeout
 
2020-04-03  9:58:19 17 [ERROR] InnoDB: Cannot save table statistics for table `test`.`trigger31749`: Lock wait timeout
 
2020-04-03  9:58:26 14 [ERROR] InnoDB: Cannot save table statistics for table `transforms`.`insert_select_31735`: Lock wait timeout
 
2020-04-03  9:58:28 14 [Warning] InnoDB: Unable to delete statistics for table test.trigger131735: Lock wait timeout. They can be deleted later using DELETE FROM mysql.innodb_index_stats WHERE database_name = 'test' AND table_name = 'trigger131735'; DELETE FROM mysql.innodb_table_stats WHERE database_name = 'test' AND table_name = 'trigger131735';
 
2020-04-03  9:58:29 17 [ERROR] InnoDB: Cannot save table statistics for table `transforms`.`insert_select_31749`: Lock wait timeout
 
2020-04-03  9:58:30 14 [Warning] InnoDB: Unable to delete statistics for table transforms.trigger231735: Lock wait timeout. They can be deleted later using DELETE FROM mysql.innodb_index_stats WHERE database_name = 'transforms' AND table_name = 'trigger231735'; DELETE FROM mysql.innodb_table_stats WHERE database_name = 'transforms' AND table_name = 'trigger231735';
 
2020-04-03  9:58:31 0 [ERROR] InnoDB: Cannot save table statistics for table `transforms`.`trigger231741`: Lock wait timeout
 
2020-04-03  9:58:32 17 [ERROR] InnoDB: Cannot save table statistics for table `transforms`.`insert_select_31749`: Lock wait timeout
 
2020-04-03  9:59:52 16 [Warning] Sort aborted, host: localhost, user: rqg, thread: 16, query: INSERT INTO transforms.trigger231745 SELECT /* QNO 3423 CON_ID 16 */ * FROM performance_schema.`events_statements_history` AS table1 ORDER BY table1.`OBJECT_NAME` LIMIT 238
 
2020-04-03 10:00:15 12 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c#P#p0` /* Partition `p0` */, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:00:17 12 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c#P#p1` /* Partition `p1` */, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:00:21 12 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c#P#p2` /* Partition `p2` */, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:00:23 12 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c#P#p3` /* Partition `p3` */, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:00:25 12 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c#P#p4` /* Partition `p4` */, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:00:27 12 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c#P#p0` /* Partition `p0` */, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:00:36 12 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c#P#p1` /* Partition `p1` */, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:00:37 12 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c#P#p2` /* Partition `p2` */, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:00:38 12 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c#P#p3` /* Partition `p3` */, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:00:44 12 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c#P#p4` /* Partition `p4` */, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:00:45 12 [Warning] InnoDB: Unable to delete statistics for table test.#mysql50##sql-7943_c#P#p0: Lock wait timeout. They can be deleted later using DELETE FROM mysql.innodb_index_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p0'; DELETE FROM mysql.innodb_table_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p0';
 
2020-04-03 10:00:46 12 [Warning] InnoDB: Unable to delete statistics for table test.#mysql50##sql-7943_c#P#p1: Lock wait timeout. They can be deleted later using DELETE FROM mysql.innodb_index_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p1'; DELETE FROM mysql.innodb_table_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p1';
 
2020-04-03 10:00:47 12 [Warning] InnoDB: Unable to delete statistics for table test.#mysql50##sql-7943_c#P#p2: Lock wait timeout. They can be deleted later using DELETE FROM mysql.innodb_index_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p2'; DELETE FROM mysql.innodb_table_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p2';
 
2020-04-03 10:00:48 12 [Warning] InnoDB: Unable to delete statistics for table test.#mysql50##sql-7943_c#P#p3: Lock wait timeout. They can be deleted later using DELETE FROM mysql.innodb_index_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p3'; DELETE FROM mysql.innodb_table_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p3';
 
2020-04-03 10:00:51 12 [Warning] InnoDB: Unable to delete statistics for table test.#mysql50##sql-7943_c#P#p4: Lock wait timeout. They can be deleted later using DELETE FROM mysql.innodb_index_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p4'; DELETE FROM mysql.innodb_table_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p4';
 
2020-04-03 10:00:52 0 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c#P#p5` /* Partition `p5` */, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:00:53 12 [Warning] InnoDB: Unable to delete statistics for table test.#mysql50##sql-7943_c#P#p5: Lock wait timeout. They can be deleted later using DELETE FROM mysql.innodb_index_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p5'; DELETE FROM mysql.innodb_table_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p5';
 
2020-04-03 10:00:54 12 [Warning] InnoDB: Unable to delete statistics for table test.#mysql50##sql-7943_c#P#p6: Lock wait timeout. They can be deleted later using DELETE FROM mysql.innodb_index_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p6'; DELETE FROM mysql.innodb_table_stats WHERE database_name = 'test' AND table_name = '#mysql50##sql-7943_c#P#p6';
 
2020-04-03 10:01:06 12 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c`, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:01:07 12 [ERROR] InnoDB: Cannot save index statistics for table `test`.`#sql-7943_c`, index `PRIMARY`, stat name "n_diff_pfx01": Lock wait timeout
 
2020-04-03 10:01:54 0x7fc6c753c300  InnoDB: Assertion failure in file /10.5/storage/innobase/trx/trx0i_s.cc line 1196
 
InnoDB: We intentionally generate a memory trap.
 
InnoDB: Submit a detailed bug report to https://jira.mariadb.org/
 
InnoDB: If you get repeated assertion failures or crashes, even
 
InnoDB: immediately after the mysqld startup, there may be
 
InnoDB: corruption in the InnoDB tablespace. Please refer to
 
InnoDB: https://mariadb.com/kb/en/library/innodb-recovery-modes/
 
InnoDB: about forcing recovery.
 
200403 10:01:54 [ERROR] mysqld got signal 6 ;
 
 
 
Server version: 10.5.3-MariaDB-debug-log
 
 
 
/10.5/sql/mysqld(handle_fatal_signal+0x9df)[0x561b9517b50d]
 
??:0(__restore_rt)[0x7fc71232d730]
 
/lib/x86_64-linux-gnu/libc.so.6(gsignal+0x10b)[0x7fc7118917bb]
 
linux/raise.c:51(__GI_raise)[0x7fc71187c535]
 
/10.5/sql/mysqld(+0x31ea169)[0x561b961b2169]
 
/10.5/sql/mysqld(+0x315d73a)[0x561b9612573a]
 
ut/ut0dbg.cc:60(_GLOBAL__sub_D_00099_0_ut0dbg.cc)[0x561b96125ae8]
 
trx/trx0i_s.cc:1196(fetch_data_into_cache_low(trx_i_s_cache_t*, trx_t const*))[0x561b96125c85]
 
trx/trx0i_s.cc:1233(fetch_data_into_cache(trx_i_s_cache_t*))[0x561b95d641ee]
 
handler/i_s.cc:990(trx_i_s_common_fill_table(THD*, TABLE_LIST*, Item*))[0x561b94bb8c00]
 
sql/sql_show.cc:8647(get_schema_tables_result(JOIN*, enum_schema_table_state))[0x561b94a91ecd]
 
sql/sql_select.cc:4419(JOIN::exec_inner())[0x561b94a8fdb8]
 
sql/sql_select.cc:4245(JOIN::exec())[0x561b94a93ccd]
 
sql/sql_select.cc:4670(mysql_select(THD*, TABLE_LIST*, List<Item>&, Item*, unsigned int, st_order*, st_order*, Item*, st_order*, unsigned long long, select_result*, st_select_lex_unit*, st_select_lex*))[0x561b94a66010]
 
sql/sql_select.cc:417(handle_select(THD*, LEX*, select_result*, unsigned long))[0x561b949d835d]
 
sql/sql_parse.cc:6168(execute_sqlcom_select(THD*, TABLE_LIST*))[0x561b949c677f]
 
sql/sql_parse.cc:3901(mysql_execute_command(THD*))[0x561b949e33ab]
 
sql/sql_parse.cc:7953(mysql_parse(THD*, char*, unsigned int, Parser_state*, bool, bool))[0x561b949b9199]
 
sql/sql_parse.cc:1842(dispatch_command(enum_server_command, THD*, char*, unsigned int, bool, bool))[0x561b949b5bce]
 
sql/sql_parse.cc:1358(do_command(THD*))[0x561b94dd3a99]
 
sql/sql_connect.cc:1422(do_handle_one_connection(CONNECT*, bool))[0x561b94dd3334]
 
sql/sql_connect.cc:1321(handle_one_connection)[0x561b95a7177a]
 
nptl/pthread_create.c:487(start_thread)[0x7fc712322fa3]
 
/lib/x86_64-linux-gnu/libc.so.6(clone+0x3f)[0x7fc7119534cf]
 
 
 
Query (0x62b0000e72a8): SELECT * FROM INFORMATION_SCHEMA.`INNODB_TRX` AS table1 HAVING NOT (table1.`trx_id` = NULL IS NULL AND table1.`trx_tables_in_use` < 'tt') ORDER BY table1.`trx_operation_state` LIMIT 36

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