[MDEV-13030] [Draft] Assertion `!table || !table->in_use || table->in_use == _current_thd()' failed in THD* handler::ha_thd() const Created: 2017-06-07  Updated: 2018-03-24

Status: Open
Project: MariaDB Server
Component/s: None
Affects Version/s: 10.3
Fix Version/s: None

Type: Bug Priority: Major
Reporter: Elena Stepanova Assignee: Elena Stepanova
Resolution: Unresolved Votes: 0
Labels: None

Attachments: File sequence.yy    
Issue Links:
Relates
relates to MDEV-13016 Testing SEQUENCE object phase 2 Closed

 Description   

perl /data/src/rqg/runall-new.pl --no-mask --seed=1496799956 --threads=8 --duration=600 --queries=100M --reporters=QueryTimeout,Backtrace,ErrorLog,Deadlock --validators=TransformerNoComparator --transformers=ExecuteAsDeleteReturning,DisableOptimizations,EnableOptimizations,OrderBy --redefine=conf/mariadb/general-workarounds.yy --redefine=conf/mariadb/sequence.yy --mysqld=--log_output=FILE --mysqld=--slow_query_log --mysqld=--long_query_time=0.000001 --mysqld=--log_bin_trust_function_creators=1 --mysqld=--query_cache_size=64M --grammar=conf/replication/replication-ddl_sql.yy --gendata=conf/replication/replication-ddl_data.zz --rpl_mode=row --mysqld=--slave-skip-errors=1049,1305,1539,1505 --mtr-build-thread=300 --basedir1=/data/bld/10.3 --vardir1=/data/logs/seq-1/current1_1

10.3 86b94170352

mysqld: /data/src/10.3/sql/handler.cc:2465: THD* handler::ha_thd() const: Assertion `!table || !table->in_use || table->in_use == _current_thd()' failed.
170607  4:52:01 [ERROR] mysqld got signal 6 ;
 
# 2017-06-07T04:52:11 [14089] #7  0x00007fa5958b1ee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6
# 2017-06-07T04:52:11 [14089] #8  0x00005602fa6a14de in handler::ha_thd (this=0x7fa5001147e8) at /data/src/10.3/sql/handler.cc:2465
# 2017-06-07T04:52:11 [14089] #9  0x00005602fa9aab18 in ha_innobase::table_flags (this=0x7fa5001147e8) at /data/src/10.3/storage/innobase/handler/ha_innodb.cc:5373
# 2017-06-07T04:52:11 [14089] #10 0x00005602fadd4134 in ha_sequence::table_flags (this=0x7fa5000288b8) at /data/src/10.3/sql/ha_sequence.cc:262
# 2017-06-07T04:52:11 [14089] #11 0x00005602fa6a9fd9 in handler::ha_external_lock (this=0x7fa5000288b8, thd=0x7fa4ec000b00, lock_type=0) at /data/src/10.3/sql/handler.cc:5899
# 2017-06-07T04:52:11 [14089] #12 0x00005602fa7b0726 in lock_external (thd=0x7fa4ec000b00, tables=0x7fa4ec13adf8, count=1) at /data/src/10.3/sql/lock.cc:395
# 2017-06-07T04:52:11 [14089] #13 0x00005602fa7b042f in mysql_lock_tables (thd=0x7fa4ec000b00, sql_lock=0x7fa4ec13add0, flags=8) at /data/src/10.3/sql/lock.cc:341
# 2017-06-07T04:52:11 [14089] #14 0x00005602fa7b02eb in mysql_lock_tables (thd=0x7fa4ec000b00, tables=0x7fa4ec09e4c8, count=1, flags=8) at /data/src/10.3/sql/lock.cc:303
# 2017-06-07T04:52:11 [14089] #15 0x00005602fa5c8617 in SEQUENCE::read_initial_values (this=0x7fa4ec09e468, table_arg=0x7fa4ec0c1290) at /data/src/10.3/sql/sql_sequence.cc:433
# 2017-06-07T04:52:11 [14089] #16 0x00005602fadd39e9 in ha_sequence::open (this=0x7fa4ec0c1e98, name=0x7fa4ec06e168 "./test/n", mode=2, flags=18) at /data/src/10.3/sql/ha_sequence.cc:110
# 2017-06-07T04:52:11 [14089] #17 0x00005602fa6a1754 in handler::ha_open (this=0x7fa4ec0c1e98, table_arg=0x7fa4ec0c1290, name=0x7fa4ec06e168 "./test/n", mode=2, test_if_locked=18) at /data/src/10.3/sql/handler.cc
:2516
# 2017-06-07T04:52:11 [14089] #18 0x00005602fa4f05d5 in open_table_from_share (thd=0x7fa4ec000b00, share=0x7fa4ec06dc58, alias=0x7fa4ec13a7b8 "n", db_stat=33, prgflag=8, ha_open_flags=18, outparam=0x7fa4ec0c1290,
 is_create_table=false) at /data/src/10.3/sql/table.cc:3310
# 2017-06-07T04:52:11 [14089] #19 0x00005602fa3722a7 in open_table (thd=0x7fa4ec000b00, table_list=0x7fa4ec13a7c0, ot_ctx=0x7fa56443da30) at /data/src/10.3/sql/sql_base.cc:1877
# 2017-06-07T04:52:11 [14089] #20 0x00005602fa374d8a in open_and_process_table (thd=0x7fa4ec000b00, lex=0x7fa56443dd10, tables=0x7fa4ec13a7c0, counter=0x7fa56443dafc, flags=1346, prelocking_strategy=0x7fa56443db0
0, has_prelocking_list=false, ot_ctx=0x7fa56443da30) at /data/src/10.3/sql/sql_base.cc:3414
# 2017-06-07T04:52:11 [14089] #21 0x00005602fa375ee0 in open_tables (thd=0x7fa4ec000b00, options=..., start=0x7fa56443dae0, counter=0x7fa56443dafc, flags=1346, prelocking_strategy=0x7fa56443db00) at /data/src/10.
3/sql/sql_base.cc:3934
# 2017-06-07T04:52:11 [14089] #22 0x00005602fa36ec9e in open_tables (thd=0x7fa4ec000b00, tables=0x7fa56443dae0, counter=0x7fa56443dafc, flags=1346, prelocking_strategy=0x7fa56443db00) at /data/src/10.3/sql/sql_ba
se.h:236
# 2017-06-07T04:52:11 [14089] #23 0x00005602fa3778f4 in open_normal_and_derived_tables (thd=0x7fa4ec000b00, tables=0x7fa4ec13a7c0, flags=1346, dt_phases=34) at /data/src/10.3/sql/sql_base.cc:4752
# 2017-06-07T04:52:11 [14089] #24 0x00005602fa377a8b in open_tables_only_view_structure (thd=0x7fa4ec000b00, table_list=0x7fa4ec13a7c0, can_deadlock=true) at /data/src/10.3/sql/sql_base.cc:4809
# 2017-06-07T04:52:11 [14089] #25 0x00005602fa487122 in fill_schema_table_by_open (thd=0x7fa4ec000b00, is_show_fields_or_keys=false, table=0x7fa4ec0dadc8, schema_table=0x5602fb823040 <schema_tables+1920>, orig_db
_name=0x7fa4ec0d02b8, orig_table_name=0x7fa4ec0d1bd8, open_tables_state_backup=0x7fa56443f400, can_deadlock=true) at /data/src/10.3/sql/sql_show.cc:4358
# 2017-06-07T04:52:11 [14089] #26 0x00005602fa48893b in get_all_tables (thd=0x7fa4ec000b00, tables=0x7fa4ec014578, cond=0x0) at /data/src/10.3/sql/sql_show.cc:4997
# 2017-06-07T04:52:11 [14089] #27 0x00005602fa498ab5 in get_schema_tables_result (join=0x7fa4ec016aa8, executed_place=PROCESSED_BY_JOIN_EXEC) at /data/src/10.3/sql/sql_show.cc:8368
# 2017-06-07T04:52:11 [14089] #28 0x00005602fa4366ef in JOIN::exec_inner (this=0x7fa4ec016aa8) at /data/src/10.3/sql/sql_select.cc:3442
# 2017-06-07T04:52:11 [14089] #29 0x00005602fa435dd8 in JOIN::exec (this=0x7fa4ec016aa8) at /data/src/10.3/sql/sql_select.cc:3280
# 2017-06-07T04:52:11 [14089] #30 0x00005602fa436f73 in mysql_select (thd=0x7fa4ec000b00, tables=0x7fa4ec014578, wild_num=0, fields=..., conds=0x7fa4ec014de0, og_num=2, order=0x7fa4ec014fc8, group=0x0, having=0x0
, proc_param=0x0, select_options=553783134720, result=0x7fa4ec016a00, unit=0x7fa4ec004698, select_lex=0x7fa4ec004dd8) at /data/src/10.3/sql/sql_select.cc:3673
# 2017-06-07T04:52:11 [14089] #31 0x00005602fa42b914 in handle_select (thd=0x7fa4ec000b00, lex=0x7fa4ec0045d0, result=0x7fa4ec016a00, setup_tables_done_option=1073741824) at /data/src/10.3/sql/sql_select.cc:373
# 2017-06-07T04:52:11 [14089] #32 0x00005602fa3f1195 in mysql_execute_command (thd=0x7fa4ec000b00) at /data/src/10.3/sql/sql_parse.cc:4646
# 2017-06-07T04:52:11 [14089] #33 0x00005602fa3fb860 in mysql_parse (thd=0x7fa4ec000b00, rawbuf=0x7fa4ec013598 "INSERT INTO test.t1_is_tables_14662 SELECT TABLE_SCHEMA,TABLE_NAME,TABLE_TYPE,TABLE_ROWS,TABLE_COLLA
TION,TABLE_COMMENT FROM information_schema.tables WHERE TABLE_SCHEMA LIKE 'test%' ORDER BY 1,2  /* QNO 3403 CON_ID 24 */", length=220, parser_state=0x7fa564441250, is_com_multi=false, is_next_command=false) at /d
ata/src/10.3/sql/sql_parse.cc:7927
# 2017-06-07T04:52:11 [14089] #34 0x00005602fa3e9518 in dispatch_command (command=COM_QUERY, thd=0x7fa4ec000b00, packet=0x7fa597851081 " INSERT INTO test.t1_is_tables_14662 SELECT TABLE_SCHEMA,TABLE_NAME,TABLE_TY
PE,TABLE_ROWS,TABLE_COLLATION,TABLE_COMMENT FROM information_schema.tables WHERE TABLE_SCHEMA LIKE 'test%' ORDER BY 1,2  /* QNO 3403 CON_ID 24 */ ", packet_length=222, is_com_multi=false, is_next_command=false) a
t /data/src/10.3/sql/sql_parse.cc:1817
# 2017-06-07T04:52:11 [14089] #35 0x00005602fa3e7ec1 in do_command (thd=0x7fa4ec000b00) at /data/src/10.3/sql/sql_parse.cc:1380
# 2017-06-07T04:52:11 [14089] #36 0x00005602fa5353f4 in do_handle_one_connection (connect=0x5602fe994610) at /data/src/10.3/sql/sql_connect.cc:1354
# 2017-06-07T04:52:11 [14089] #37 0x00005602fa535181 in handle_one_connection (arg=0x5602fe994610) at /data/src/10.3/sql/sql_connect.cc:1260
# 2017-06-07T04:52:11 [14089] #38 0x00007fa5975eb494 in start_thread (arg=0x7fa564442700) at pthread_create.c:333
# 2017-06-07T04:52:11 [14089] #39 0x00007fa59596e93f in clone () from /lib/x86_64-linux-gnu/libc.so.6

perl /data/src/rqg/runall-new.pl --no-mask --seed=1496800332 --threads=8 --duration=600 --queries=100M --reporters=QueryTimeout,Backtrace,ErrorLog,Deadlock --validators=TransformerNo
Comparator --transformers=ExecuteAsDeleteReturning,DisableOptimizations,EnableOptimizations,OrderBy --redefine=conf/mariadb/general-workarounds.yy --redefine=conf/mariadb/sequence.yy --mysqld=--log_output=FILE --
mysqld=--slow_query_log --mysqld=--long_query_time=0.000001 --mysqld=--log_bin_trust_function_creators=1 --mysqld=--query_cache_size=64M --grammar=conf/replication/replication-ddl_sql.yy --gendata=conf/replicatio
n/replication-ddl_data.zz --rpl_mode=mixed --mysqld=--slave-skip-errors=1049,1305,1539,1505,1317 --mtr-build-thread=300 --basedir1=/data/bld/10.3 --vardir1=/data/logs/seq-1/current1_1



 Comments   
Comment by Elena Stepanova [ 2018-02-18 ]

New occurrence: https://api.travis-ci.org/v3/job/342890120/log.txt

Comment by Elena Stepanova [ 2018-03-24 ]

Still reproducible on 10.3:

10.3 96ecf3ff230

#7  0x00007fc2199a5ee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6
#8  0x00005612c90d83f5 in handler::ha_thd (this=0x7fc1940f2e68) at /data/src/10.3/sql/handler.cc:2630
#9  0x00005612c93eb3b6 in ha_innobase::table_flags (this=0x7fc1940f2e68) at /data/src/10.3/storage/innobase/handler/ha_innodb.cc:5227
#10 0x00005612c985ec32 in ha_sequence::table_flags (this=0x7fc1941852b8) at /data/src/10.3/sql/ha_sequence.cc:281
#11 0x00005612c90e1c6d in handler::ha_external_lock (this=0x7fc1941852b8, thd=0x7fc1a4000ba0, lock_type=2) at /data/src/10.3/sql/handler.cc:6124
#12 0x00005612c91fb916 in unlock_external (thd=0x7fc1a4000ba0, table=0x7fc1a4018470, count=1) at /data/src/10.3/sql/lock.cc:729
#13 0x00005612c91fad29 in mysql_unlock_tables (thd=0x7fc1a4000ba0, sql_lock=0x7fc1a4018428, free_lock=false) at /data/src/10.3/sql/lock.cc:434
#14 0x00005612c91fac81 in mysql_unlock_tables (thd=0x7fc1a4000ba0, sql_lock=0x7fc1a4018428) at /data/src/10.3/sql/lock.cc:420
#15 0x00005612c8d5e996 in close_thread_tables (thd=0x7fc1a4000ba0) at /data/src/10.3/sql/sql_base.cc:843
#16 0x00005612c8feb419 in sequence_insert (thd=0x7fc1a4000ba0, lex=0x7fc1a4004910, table_list=0x7fc1a4015de0) at /data/src/10.3/sql/sql_sequence.cc:337
#17 0x00005612c8ebcc9b in mysql_create_table_no_lock (thd=0x7fc1a4000ba0, db=0x7fc1a4015df8, table_name=0x7fc1a4015e08, create_info=0x7fc210132030, alter_info=0x7fc210131f80, is_trans=0x7fc210131ed4, create_table_mode=0, table_list=0x7fc1a4015de0) at /data/src/10.3/sql/sql_table.cc:5136
#18 0x00005612c8ebe94d in mysql_create_like_table (thd=0x7fc1a4000ba0, table=0x7fc1a4015de0, src_table=0x7fc1a4016478, create_info=0x7fc210133790) at /data/src/10.3/sql/sql_table.cc:5720
#19 0x00005612c8ded726 in mysql_execute_command (thd=0x7fc1a4000ba0) at /data/src/10.3/sql/sql_parse.cc:4250
#20 0x00005612c8df972a in mysql_parse (thd=0x7fc1a4000ba0, rawbuf=0x7fc1a4015cc8 "CREATE TABLE g LIKE `AA` /* QNO 46202 CON_ID 15 */", length=50, parser_state=0x7fc2101345d0, is_com_multi=false, is_next_command=false) at /data/src/10.3/sql/sql_parse.cc:8009
#21 0x00005612c8de6dde in dispatch_command (command=COM_QUERY, thd=0x7fc1a4000ba0, packet=0x7fc1a409fce1 "CREATE TABLE g LIKE `AA` /* QNO 46202 CON_ID 15 */ ", packet_length=51, is_com_multi=false, is_next_command=false) at /data/src/10.3/sql/sql_parse.cc:1838
#22 0x00005612c8de581d in do_command (thd=0x7fc1a4000ba0) at /data/src/10.3/sql/sql_parse.cc:1383
#23 0x00005612c8f49c85 in do_handle_one_connection (connect=0x5612cbc13520) at /data/src/10.3/sql/sql_connect.cc:1402
#24 0x00005612c8f49a12 in handle_one_connection (arg=0x5612cbc13520) at /data/src/10.3/sql/sql_connect.cc:1308
#25 0x00005612c93d1029 in pfs_spawn_thread (arg=0x5612cbcd5f10) at /data/src/10.3/storage/perfschema/pfs.cc:1862
#26 0x00007fc21b67c494 in start_thread (arg=0x7fc210135700) at pthread_create.c:333
#27 0x00007fc219a6293f in clone () from /lib/x86_64-linux-gnu/libc.so.6

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