[MDEV-16986] Unitialized mutex, SIGSEGV and assorted assertion failures in Aria code - Jira

Details

Type: Bug
Status: Closed (View Workflow)
Priority: Critical
Resolution: Fixed
Affects Version/s: 10.4(EOL)
Fix Version/s: 10.4.0
Component/s: Storage Engine - Aria
Labels:
None

Description

Below are variations failures that I'm getting by basically re-running the same RQG test (with variations or even without it). They are provided in the order of ascending complexity of RQG command line, but feel free to run them in any order.
In general, the less concurrency the test case uses (the value of threads option and possibly reporters), the longer it runs before a failure; but it's not a guaranteed rule.

The goal of this report is to get rid of all of the quoted failures, so any provided test passes (or fails with an unrelated problem, which is also quite likely).

All reported stack traces are for 10.4 d6d63f4844 debug build (cmake . -DCMAKE_BUILD_TYPE=Debug && make -j6).

For any of all tests, use this RQG branch:

git clone https://github.com/elenst/rqg --branch mdev16986 rqg-mdev16986

cd rqg-mdev16986

And then run the provided command line. Do not forget to change the basedir in the command line!.
The tests use /dev/shm/vardir for the vardir. If you want it different, change it as well.

Assertion `trn->undo_lsn == ((LSN)0)'

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=2  --mysqld=--default-storage-engine=Aria --grammar=conf/engines/many_indexes.yy

mysqld: /data/src/10.4/storage/maria/ma_loghandler.c:6416: translog_write_record: Assertion `trn->undo_lsn == ((LSN)0)' failed.

mysqld: /data/src/10.4/storage/maria/ma_loghandler.c:6416: translog_write_record: Assertion `trn->undo_lsn == ((LSN)0)' failed.

180815 14:01:52 [ERROR] mysqld got signal 6 ;

#3  0x00007f0404c39ee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6

#4  0x000055c282fd1fa8 in translog_write_record (lsn=0x7f03ed1e0a78, type=LOGREC_COMMIT, trn=0x7f03986bc2a0, tbl_info=0x0, rec_len=0, part_no=2, parts_data=0x7f03ed1e0a80, store_share_id=0x0, hook_arg=0x0) at /data/src/10.4/storage/maria/ma_loghandler.c:6416

#5  0x000055c282ff15ec in ma_commit (trn=0x7f03986bc2a0) at /data/src/10.4/storage/maria/ma_commit.c:62

#6  0x000055c282fb8c88 in ha_maria::external_lock (this=0x7f038c040538, thd=0x7f038c000b00, lock_type=2) at /data/src/10.4/storage/maria/ha_maria.cc:2793

#7  0x000055c282db0d70 in handler::ha_external_lock (this=0x7f038c040538, thd=0x7f038c000b00, lock_type=2) at /data/src/10.4/sql/handler.cc:6122

#8  0x000055c282ecf66d in unlock_external (thd=0x7f038c000b00, table=0x7f038c014f98, count=1) at /data/src/10.4/sql/lock.cc:729

#9  0x000055c282eced0d in mysql_unlock_read_tables (thd=0x7f038c000b00, sql_lock=0x7f038c014f68) at /data/src/10.4/sql/lock.cc:489

#10 0x000055c282b1136b in JOIN::join_free (this=0x7f038c014fc0) at /data/src/10.4/sql/sql_select.cc:12709

#11 0x000055c282b12b0e in return_zero_rows (join=0x7f038c014fc0, result=0x7f038c014fa0, tables=..., fields=..., send_row=false, select_options=2147748608, info=0x55c2836304e0 "no matching row in const table", having=0x0, all_fields=...) at /data/src/10.4/sql/sql_select.cc:13291

#12 0x000055c282af9f84 in JOIN::exec_inner (this=0x7f038c014fc0) at /data/src/10.4/sql/sql_select.cc:4011

#13 0x000055c282af9702 in JOIN::exec (this=0x7f038c014fc0) at /data/src/10.4/sql/sql_select.cc:3870

#14 0x000055c282afa991 in mysql_select (thd=0x7f038c000b00, tables=0x7f038c0140d8, wild_num=0, fields=..., conds=0x0, og_num=0, order=0x0, group=0x0, having=0x0, proc_param=0x0, select_options=2147748608, result=0x7f038c014fa0, unit=0x7f038c0049a8, select_lex=0x7f038c013b38) at /data/src/10.4/sql/sql_select.cc:4275

#15 0x000055c282aec410 in handle_select (thd=0x7f038c000b00, lex=0x7f038c0048e0, result=0x7f038c014fa0, setup_tables_done_option=0) at /data/src/10.4/sql/sql_select.cc:382

#16 0x000055c282ab6e24 in execute_sqlcom_select (thd=0x7f038c000b00, all_tables=0x7f038c0140d8) at /data/src/10.4/sql/sql_parse.cc:6546

#17 0x000055c282aad550 in mysql_execute_command (thd=0x7f038c000b00) at /data/src/10.4/sql/sql_parse.cc:3768

#18 0x000055c282abab45 in mysql_parse (thd=0x7f038c000b00, rawbuf=0x7f038c013a78 "SELECT `pk` FROM `C` /* QNO 70403 CON_ID 14 */", length=46, parser_state=0x7f03ed1e2640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064

#19 0x000055c282aa7ff2 in dispatch_command (command=COM_QUERY, thd=0x7f038c000b00, packet=0x7f038c00b341 "SELECT `pk` FROM `C` /* QNO 70403 CON_ID 14 */ ", packet_length=47, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847

#20 0x000055c282aa6a16 in do_command (thd=0x7f038c000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#21 0x000055c282c0d6fb in do_handle_one_connection (connect=0x55c286440060) at /data/src/10.4/sql/sql_connect.cc:1402

#22 0x000055c282c0d47f in handle_one_connection (arg=0x55c286440060) at /data/src/10.4/sql/sql_connect.cc:1308

#23 0x00007f0406910494 in start_thread (arg=0x7f03ed1e3700) at pthread_create.c:333

#24 0x00007f0404cf693f in clone () from /lib/x86_64-linux-gnu/libc.so.6

safe_mutex: Trying to lock uninitialized mutex at /data/src/10.4/storage/maria/trnman.c, line 369

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=3  --mysqld=--default-storage-engine=Aria --grammar=conf/engines/many_indexes.yy

safe_mutex: Trying to lock uninitialized mutex at /data/src/10.4/storage/maria/trnman.c, line 369

180815 13:51:05 [ERROR] mysqld got signal 6 ;

#3  0x00007f1869dcfee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6

#4  0x0000562d3612fbc6 in ha_maria::external_lock (this=0x7f17f808d1f8, thd=0x7f17f8000b00, lock_type=2) at /data/src/10.4/storage/maria/ha_maria.cc:2780

#5  0x0000562d35f27d70 in handler::ha_external_lock (this=0x7f17f808d1f8, thd=0x7f17f8000b00, lock_type=2) at /data/src/10.4/sql/handler.cc:6122

#6  0x0000562d3604666d in unlock_external (thd=0x7f17f8000b00, table=0x7f17f80171a8, count=1) at /data/src/10.4/sql/lock.cc:729

#7  0x0000562d36045d0d in mysql_unlock_read_tables (thd=0x7f17f8000b00, sql_lock=0x7f17f8017178) at /data/src/10.4/sql/lock.cc:489

#8  0x0000562d35c8836b in JOIN::join_free (this=0x7f17f80171d0) at /data/src/10.4/sql/sql_select.cc:12709

#9  0x0000562d35c9863b in do_select (join=0x7f17f80171d0, procedure=0x0) at /data/src/10.4/sql/sql_select.cc:18837

#10 0x0000562d35c71291 in JOIN::exec_inner (this=0x7f17f80171d0) at /data/src/10.4/sql/sql_select.cc:4076

#11 0x0000562d35c70702 in JOIN::exec (this=0x7f17f80171d0) at /data/src/10.4/sql/sql_select.cc:3870

#12 0x0000562d35c71991 in mysql_select (thd=0x7f17f8000b00, tables=0x7f17f80162e8, wild_num=0, fields=..., conds=0x0, og_num=0, order=0x0, group=0x0, having=0x0, proc_param=0x0, select_options=2147748608, result=0x7f17f80171b0, unit=0x7f17f80049a8, select_lex=0x7f17f8015d18) at /data/src/10.4/sql/sql_select.cc:4275

#13 0x0000562d35c63410 in handle_select (thd=0x7f17f8000b00, lex=0x7f17f80048e0, result=0x7f17f80171b0, setup_tables_done_option=0) at /data/src/10.4/sql/sql_select.cc:382

#14 0x0000562d35c2de24 in execute_sqlcom_select (thd=0x7f17f8000b00, all_tables=0x7f17f80162e8) at /data/src/10.4/sql/sql_parse.cc:6546

#15 0x0000562d35c24550 in mysql_execute_command (thd=0x7f17f8000b00) at /data/src/10.4/sql/sql_parse.cc:3768

#16 0x0000562d35c31b45 in mysql_parse (thd=0x7f17f8000b00, rawbuf=0x7f17f8015c38 "SELECT `col_varchar_key` FROM `C` /* QNO 38180 CON_ID 13 */", length=59, parser_state=0x7f1868058640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064

#17 0x0000562d35c1eff2 in dispatch_command (command=COM_QUERY, thd=0x7f17f8000b00, packet=0x7f17f80ee2f1 "", packet_length=60, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847

#18 0x0000562d35c1da16 in do_command (thd=0x7f17f8000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#19 0x0000562d35d846fb in do_handle_one_connection (connect=0x562d39e7fcd0) at /data/src/10.4/sql/sql_connect.cc:1402

#20 0x0000562d35d8447f in handle_one_connection (arg=0x562d39e7fcd0) at /data/src/10.4/sql/sql_connect.cc:1308

#21 0x00007f186baa6494 in start_thread (arg=0x7f1868059700) at pthread_create.c:333

#22 0x00007f1869e8c93f in clone () from /lib/x86_64-linux-gnu/libc.so.6

mysqld got signal 11

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6  --mysqld=--default-storage-engine=Aria --grammar=conf/engines/many_indexes.yy

#3  <signal handler called>

#4  0x0000563c21437419 in trnman_end_trn (trn=0x7f8bc80587c0, commit=0 '\000') at /data/src/10.4/storage/maria/trnman.c:421

#5  0x0000563c2146b5b1 in ma_commit (trn=0x7f8bc80587c0) at /data/src/10.4/storage/maria/ma_commit.c:39

#6  0x0000563c21433064 in ha_maria::implicit_commit (thd=0x7f8bc8000b00, new_trn=false) at /data/src/10.4/storage/maria/ha_maria.cc:2912

#7  0x0000563c20f3006d in mysql_execute_command (thd=0x7f8bc8000b00) at /data/src/10.4/sql/sql_parse.cc:6362

#8  0x0000563c20f34b45 in mysql_parse (thd=0x7f8bc8000b00, rawbuf=0x7f8bc8013a78 "DELETE FROM `CC` WHERE `col_time_nokey` LIKE CONCAT( CONVERT( 'ctaywizbguebrmcbqzhssfiagkfbiyfmgausftisqnmbssokwvtkicatpbuq' USING UTF8 ), '%' ) ORDER BY `pk` LIMIT 1 /* QNO 766 CON_ID 14 */", length=190, parser_state=0x7f8c28814640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064

#9  0x0000563c20f21ff2 in dispatch_command (command=COM_QUERY, thd=0x7f8bc8000b00, packet=0x7f8bc800b341 "DELETE FROM `CC` WHERE `col_time_nokey` LIKE CONCAT( CONVERT( 'ctaywizbguebrmcbqzhssfiagkfbiyfmgausftisqnmbssokwvtkicatpbuq' USING UTF8 ), '%' ) ORDER BY `pk` LIMIT 1 /* QNO 766 CON_ID 14 */ ", packet_length=191, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847

#10 0x0000563c20f20a16 in do_command (thd=0x7f8bc8000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#11 0x0000563c210876fb in do_handle_one_connection (connect=0x563c23f71060) at /data/src/10.4/sql/sql_connect.cc:1402

#12 0x0000563c2108747f in handle_one_connection (arg=0x563c23f71060) at /data/src/10.4/sql/sql_connect.cc:1308

#13 0x00007f8c3ff6b494 in start_thread (arg=0x7f8c28815700) at pthread_create.c:333

#14 0x00007f8c3e35193f in clone () from /lib/x86_64-linux-gnu/libc.so.6

Assertion `trn->rec_lsn == ((LSN)0)' failed

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6  --redefine=conf/mariadb/bulk_insert.yy  --mysqld=--default-storage-engine=Aria --grammar=conf/engines/many_indexes.yy

mysqld: /data/src/10.4/storage/maria/ma_commit.c:37: ma_commit: Assertion `trn->rec_lsn == ((LSN)0)' failed.

180815 13:46:15 [ERROR] mysqld got signal 6 ;

#7  0x00007f3af1a8cee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6

#8  0x00005563b7398589 in ma_commit (trn=0x7f3a7c0811a0) at /data/src/10.4/storage/maria/ma_commit.c:37

#9  0x00005563b735fc88 in ha_maria::external_lock (this=0x7f3a7804ff38, thd=0x7f3a88000b00, lock_type=2) at /data/src/10.4/storage/maria/ha_maria.cc:2793

#10 0x00005563b7157d70 in handler::ha_external_lock (this=0x7f3a7804ff38, thd=0x7f3a88000b00, lock_type=2) at /data/src/10.4/sql/handler.cc:6122

#11 0x00005563b727666d in unlock_external (thd=0x7f3a88000b00, table=0x7f3a88016450, count=1) at /data/src/10.4/sql/lock.cc:729

#12 0x00005563b7275a75 in mysql_unlock_tables (thd=0x7f3a88000b00, sql_lock=0x7f3a88016420, free_lock=false) at /data/src/10.4/sql/lock.cc:434

#13 0x00005563b72759cd in mysql_unlock_tables (thd=0x7f3a88000b00, sql_lock=0x7f3a88016420) at /data/src/10.4/sql/lock.cc:420

#14 0x00005563b6dbd703 in close_thread_tables (thd=0x7f3a88000b00) at /data/src/10.4/sql/sql_base.cc:846

#15 0x00005563b6e5d07c in mysql_execute_command (thd=0x7f3a88000b00) at /data/src/10.4/sql/sql_parse.cc:6367

#16 0x00005563b6e61b45 in mysql_parse (thd=0x7f3a88000b00, rawbuf=0x7f3a88015c38 "LOAD DATA INFILE 'load_E' REPLACE INTO TABLE E /* QNO 3858 CON_ID 13 */", length=71, parser_state=0x7f3af0116640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064

#17 0x00005563b6e4eff2 in dispatch_command (command=COM_QUERY, thd=0x7f3a88000b00, packet=0x7f3a880ee2f1 " LOAD DATA INFILE 'load_E' REPLACE INTO TABLE E /* QNO 3858 CON_ID 13 */ ", packet_length=73, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847

#18 0x00005563b6e4da16 in do_command (thd=0x7f3a88000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#19 0x00005563b6fb46fb in do_handle_one_connection (connect=0x5563b9c5ccd0) at /data/src/10.4/sql/sql_connect.cc:1402

#20 0x00005563b6fb447f in handle_one_connection (arg=0x5563b9c5ccd0) at /data/src/10.4/sql/sql_connect.cc:1308

#21 0x00007f3af3763494 in start_thread (arg=0x7f3af0117700) at pthread_create.c:333

#22 0x00007f3af1b4993f in clone () from /lib/x86_64-linux-gnu/libc.so.6

Assertion `trn->rec_lsn == ((LSN)0)' failed

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6   --redefine=conf/mariadb/sp.yy --redefine=conf/mariadb/bulk_insert.yy  --mysqld=--default-storage-engine=Aria --grammar=conf/engines/many_indexes.yy

mysqld: /data/src/10.4/storage/maria/ma_commit.c:37: ma_commit: Assertion `trn->rec_lsn == ((LSN)0)' failed.

180815 13:43:39 [ERROR] mysqld got signal 6 ;

#7  0x00007fc30d8f7ee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6

#8  0x000055ca5dbf1589 in ma_commit (trn=0x7fc294067c10) at /data/src/10.4/storage/maria/ma_commit.c:37

#9  0x000055ca5dbb8c88 in ha_maria::external_lock (this=0x7fc294093da8, thd=0x7fc290000b00, lock_type=2) at /data/src/10.4/storage/maria/ha_maria.cc:2793

#10 0x000055ca5d9b0d70 in handler::ha_external_lock (this=0x7fc294093da8, thd=0x7fc290000b00, lock_type=2) at /data/src/10.4/sql/handler.cc:6122

#11 0x000055ca5dacf66d in unlock_external (thd=0x7fc290000b00, table=0x7fc290015d70, count=1) at /data/src/10.4/sql/lock.cc:729

#12 0x000055ca5dacea75 in mysql_unlock_tables (thd=0x7fc290000b00, sql_lock=0x7fc290015d40, free_lock=false) at /data/src/10.4/sql/lock.cc:434

#13 0x000055ca5dace9cd in mysql_unlock_tables (thd=0x7fc290000b00, sql_lock=0x7fc290015d40) at /data/src/10.4/sql/lock.cc:420

#14 0x000055ca5d616703 in close_thread_tables (thd=0x7fc290000b00) at /data/src/10.4/sql/sql_base.cc:846

#15 0x000055ca5d6b607c in mysql_execute_command (thd=0x7fc290000b00) at /data/src/10.4/sql/sql_parse.cc:6367

#16 0x000055ca5d6bab45 in mysql_parse (thd=0x7fc290000b00, rawbuf=0x7fc290013a78 "INSERT INTO `D` ( `col_datetime_nokey`, `col_varchar_nokey`, `col_time_key` ) VALUES ( REPEAT( _UTF8 0x7, 59 ), CONVERT( 'fgoylsxvsxyppyiyyljycoeexecrmoycakxmbjxjdajnlbixclboqzwwzaaadpa' USING ASCII )"..., length=251, parser_state=0x7fc2e979c640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064

#17 0x000055ca5d6a7ff2 in dispatch_command (command=COM_QUERY, thd=0x7fc290000b00, packet=0x7fc29000b341 "INSERT INTO `D` ( `col_datetime_nokey`, `col_varchar_nokey`, `col_time_key` ) VALUES ( REPEAT( _UTF8 0x7, 59 ), CONVERT( 'fgoylsxvsxyppyiyyljycoeexecrmoycakxmbjxjdajnlbixclboqzwwzaaadpa' USING ASCII )"..., packet_length=252, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847

#18 0x000055ca5d6a6a16 in do_command (thd=0x7fc290000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#19 0x000055ca5d80d6fb in do_handle_one_connection (connect=0x55ca617fdcd0) at /data/src/10.4/sql/sql_connect.cc:1402

#20 0x000055ca5d80d47f in handle_one_connection (arg=0x55ca617fdcd0) at /data/src/10.4/sql/sql_connect.cc:1308

#21 0x00007fc30f5ce494 in start_thread (arg=0x7fc2e979d700) at pthread_create.c:333

#22 0x00007fc30d9b493f in clone () from /lib/x86_64-linux-gnu/libc.so.6

Assertion `trn->rec_lsn == ((LSN)0)' failed.

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6  --redefine=conf/mariadb/alter_table.yy --redefine=conf/mariadb/sp.yy --redefine=conf/mariadb/bulk_insert.yy  --mysqld=--default-storage-engine=Aria --grammar=conf/engines/many_indexes.yy

mysqld: /data/src/10.4/storage/maria/ma_commit.c:37: ma_commit: Assertion `trn->rec_lsn == ((LSN)0)' failed.

180815 13:40:21 [ERROR] mysqld got signal 6 ;

#7  0x00007ff0fe18bee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6

#8  0x0000564f65e7a589 in ma_commit (trn=0x7ff084032710) at /data/src/10.4/storage/maria/ma_commit.c:37

#9  0x0000564f65e41c88 in ha_maria::external_lock (this=0x7ff08415cef8, thd=0x7ff084000b00, lock_type=2) at /data/src/10.4/storage/maria/ha_maria.cc:2793

#10 0x0000564f65c39d70 in handler::ha_external_lock (this=0x7ff08415cef8, thd=0x7ff084000b00, lock_type=2) at /data/src/10.4/sql/handler.cc:6122

#11 0x0000564f65d5866d in unlock_external (thd=0x7ff084000b00, table=0x7ff084017780, count=1) at /data/src/10.4/sql/lock.cc:729

#12 0x0000564f65d57a75 in mysql_unlock_tables (thd=0x7ff084000b00, sql_lock=0x7ff084017750, free_lock=false) at /data/src/10.4/sql/lock.cc:434

#13 0x0000564f65d579cd in mysql_unlock_tables (thd=0x7ff084000b00, sql_lock=0x7ff084017750) at /data/src/10.4/sql/lock.cc:420

#14 0x0000564f6589f703 in close_thread_tables (thd=0x7ff084000b00) at /data/src/10.4/sql/sql_base.cc:846

#15 0x0000564f6593f07c in mysql_execute_command (thd=0x7ff084000b00) at /data/src/10.4/sql/sql_parse.cc:6367

#16 0x0000564f65943b45 in mysql_parse (thd=0x7ff084000b00, rawbuf=0x7ff084015c38 "INSERT INTO `C` SELECT * FROM `DD` /* QNO 1447 CON_ID 13 */", length=59, parser_state=0x7ff0e896d640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064

#17 0x0000564f65930ff2 in dispatch_command (command=COM_QUERY, thd=0x7ff084000b00, packet=0x7ff0840ee2f1 "INSERT INTO `C` SELECT * FROM `DD` /* QNO 1447 CON_ID 13 */ ", packet_length=60, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847

#18 0x0000564f6592fa16 in do_command (thd=0x7ff084000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#19 0x0000564f65a966fb in do_handle_one_connection (connect=0x564f68d76cd0) at /data/src/10.4/sql/sql_connect.cc:1402

#20 0x0000564f65a9647f in handle_one_connection (arg=0x564f68d76cd0) at /data/src/10.4/sql/sql_connect.cc:1308

#21 0x00007ff0ffe62494 in start_thread (arg=0x7ff0e896e700) at pthread_create.c:333

#22 0x00007ff0fe24893f in clone () from /lib/x86_64-linux-gnu/libc.so.6

Assertion `share->in_trans == 0' failed

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6 --seed=1534256294 --reporters=Backtrace,ErrorLog,Deadlock  --views --redefine=conf/mariadb/alter_table.yy --redefine=conf/mariadb/sp.yy --redefine=conf/mariadb/bulk_insert.yy  --mysqld=--log_output=FILE  --mysqld=--default-storage-engine=Aria --grammar=conf/engines/many_indexes.yy

mysqld: /data/src/10.4/storage/maria/ma_close.c:99: maria_close: Assertion `share->in_trans == 0' failed.

180815 13:37:11 [ERROR] mysqld got signal 6 ;

#7  0x00007f566430fee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6

#8  0x000055aa159ffedd in maria_close (info=0x7f55d80a4e40) at /data/src/10.4/storage/maria/ma_close.c:99

#9  0x000055aa159762ff in ha_maria::close (this=0x7f55d80448f8) at /data/src/10.4/storage/maria/ha_maria.cc:1276

#10 0x000055aa15769a98 in handler::ha_close (this=0x7f55d80448f8) at /data/src/10.4/sql/handler.cc:2750

#11 0x000055aa155837cb in closefrm (table=0x7f55d8047ce0) at /data/src/10.4/sql/table.cc:3587

#12 0x000055aa1569aaf0 in intern_close_table (table=0x7f55d8047ce0) at /data/src/10.4/sql/table_cache.cc:222

#13 0x000055aa1569ac8f in tc_remove_table (table=0x7f55d8047ce0) at /data/src/10.4/sql/table_cache.cc:260

#14 0x000055aa1569b61c in tc_release_table (table=0x7f55d8047ce0) at /data/src/10.4/sql/table_cache.cc:473

#15 0x000055aa153d8a5d in close_thread_table (thd=0x7f55d8000b00, table_ptr=0x7f55d8000be0) at /data/src/10.4/sql/sql_base.cc:912

#16 0x000055aa153d872e in close_thread_tables (thd=0x7f55d8000b00) at /data/src/10.4/sql/sql_base.cc:854

#17 0x000055aa153ea56c in close_system_tables (thd=0x7f55d8000b00, backup=0x7f5660063a90) at /data/src/10.4/sql/sql_base.cc:8773

#18 0x000055aa158efb79 in Sp_handler::db_find_routine (this=0x55aa16c19130 <sp_handler_procedure>, thd=0x7f55d8000b00, name=0x7f5660063e20, sphp=0x7f5660064038) at /data/src/10.4/sql/sp.cc:743

#19 0x000055aa158efcb5 in Sp_handler::db_find_and_cache_routine (this=0x55aa16c19130 <sp_handler_procedure>, thd=0x7f55d8000b00, name=0x7f5660063e20, sp=0x7f5660064038) at /data/src/10.4/sql/sp.cc:767

#20 0x000055aa158f577b in Sp_handler::sp_cache_routine (this=0x55aa16c19130 <sp_handler_procedure>, thd=0x7f55d8000b00, name=0x7f5660063e20, lookup_only=false, sp=0x7f5660064038) at /data/src/10.4/sql/sp.cc:2792

#21 0x000055aa158f55a8 in Sroutine_hash_entry::sp_cache_routine (this=0x7f55d8013b88, thd=0x7f55d8000b00, lookup_only=false, sp=0x7f5660064038) at /data/src/10.4/sql/sp.cc:2745

#22 0x000055aa153dd204 in open_and_process_routine (thd=0x7f55d8000b00, prelocking_ctx=0x7f55d80048e8, rt=0x7f55d8013b88, prelocking_strategy=0x7f5660064240, has_prelocking_list=false, ot_ctx=0x7f5660064130, need_prelocking=0x7f56600640cf, routine_modifies_data=0x7f56600640d0) at /data/src/10.4/sql/sql_base.cc:3290

#23 0x000055aa153ded5c in open_tables (thd=0x7f55d8000b00, options=..., start=0x7f56600641a8, counter=0x7f56600641c4, flags=0, prelocking_strategy=0x7f5660064240) at /data/src/10.4/sql/sql_base.cc:4149

#24 0x000055aa153e091f in open_and_lock_tables (thd=0x7f55d8000b00, options=..., tables=0x0, derived=true, flags=0, prelocking_strategy=0x7f5660064240) at /data/src/10.4/sql/sql_base.cc:4951

#25 0x000055aa153a0e63 in open_and_lock_tables (thd=0x7f55d8000b00, tables=0x0, derived=true, flags=0) at /data/src/10.4/sql/sql_base.h:500

#26 0x000055aa1546d8ef in Sql_cmd_call::execute (this=0x7f55d8013b70, thd=0x7f55d8000b00) at /data/src/10.4/sql/sql_parse.cc:3144

#27 0x000055aa15477d0c in mysql_execute_command (thd=0x7f55d8000b00) at /data/src/10.4/sql/sql_parse.cc:6284

#28 0x000055aa1547cb45 in mysql_parse (thd=0x7f55d8000b00, rawbuf=0x7f55d8013a78 "CALL sp_grammar1 /* QNO 461 CON_ID 19 */", length=40, parser_state=0x7f5660065640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064

#29 0x000055aa15469ff2 in dispatch_command (command=COM_QUERY, thd=0x7f55d8000b00, packet=0x7f55d800b341 "CALL sp_grammar1 /* QNO 461 CON_ID 19 */ ", packet_length=41, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847

#30 0x000055aa15468a16 in do_command (thd=0x7f55d8000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#31 0x000055aa155cf6fb in do_handle_one_connection (connect=0x55aa19015420) at /data/src/10.4/sql/sql_connect.cc:1402

#32 0x000055aa155cf47f in handle_one_connection (arg=0x55aa19015420) at /data/src/10.4/sql/sql_connect.cc:1308

#33 0x00007f5665fe6494 in start_thread (arg=0x7f5660066700) at pthread_create.c:333

#34 0x00007f56643cc93f in clone () from /lib/x86_64-linux-gnu/libc.so.6

Assertion `share->in_trans == 0' failed

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6 --seed=1534256294 --reporters=Backtrace,ErrorLog,Deadlock  --views --redefine=conf/mariadb/alter_table.yy --redefine=conf/mariadb/sp.yy --redefine=conf/mariadb/bulk_insert.yy  --mysqld=--log_output=FILE  --mysqld=--default-storage-engine=Aria --grammar=conf/engines/many_indexes.yy --gendata=conf/engines/many_indexes.zz --skip-gendata --gendata-advanced

mysqld: /data/src/10.4/storage/maria/ma_close.c:99: maria_close: Assertion `share->in_trans == 0' failed.

180815 13:31:34 [ERROR] mysqld got signal 6 ;

#7  0x00007f6d4d78eee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6

#8  0x00005635226ffedd in maria_close (info=0x7f6cd8147dc0) at /data/src/10.4/storage/maria/ma_close.c:99

#9  0x00005635226762ff in ha_maria::close (this=0x7f6cd802d818) at /data/src/10.4/storage/maria/ha_maria.cc:1276

#10 0x0000563522469a98 in handler::ha_close (this=0x7f6cd802d818) at /data/src/10.4/sql/handler.cc:2750

#11 0x00005635222837cb in closefrm (table=0x7f6cd812f1f0) at /data/src/10.4/sql/table.cc:3587

#12 0x000056352239aaf0 in intern_close_table (table=0x7f6cd812f1f0) at /data/src/10.4/sql/table_cache.cc:222

#13 0x000056352239af0a in tc_purge (mark_flushed=true) at /data/src/10.4/sql/table_cache.cc:335

#14 0x00005635220d770a in close_cached_tables (thd=0x7f6cd4000b00, tables=0x0, wait_for_refresh=true, timeout=86400) at /data/src/10.4/sql/sql_base.cc:377

#15 0x0000563522306df6 in reload_acl_and_cache (thd=0x7f6cd4000b00, options=4, tables=0x0, write_to_binlog=0x7f6d4c1cd800) at /data/src/10.4/sql/sql_reload.cc:335

#16 0x000056352217583c in mysql_execute_command (thd=0x7f6cd4000b00) at /data/src/10.4/sql/sql_parse.cc:5621

#17 0x000056352217cb45 in mysql_parse (thd=0x7f6cd4000b00, rawbuf=0x7f6cd4013a78 "FLUSH TABLES /* QNO 1459 CON_ID 15 */", length=37, parser_state=0x7f6d4c1ce640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064

#18 0x0000563522169ff2 in dispatch_command (command=COM_QUERY, thd=0x7f6cd4000b00, packet=0x7f6cd400b341 "FLUSH TABLES /* QNO 1459 CON_ID 15 */ ", packet_length=38, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847

#19 0x0000563522168a16 in do_command (thd=0x7f6cd4000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#20 0x00005635222cf6fb in do_handle_one_connection (connect=0x5635254a9cd0) at /data/src/10.4/sql/sql_connect.cc:1402

#21 0x00005635222cf47f in handle_one_connection (arg=0x5635254a9cd0) at /data/src/10.4/sql/sql_connect.cc:1308

#22 0x00007f6d4f465494 in start_thread (arg=0x7f6d4c1cf700) at pthread_create.c:333

#23 0x00007f6d4d84b93f in clone () from /lib/x86_64-linux-gnu/libc.so.6

Assertion `share->in_trans == 0' failed

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6 --seed=1534256294 --reporters=Backtrace,ErrorLog,Deadlock  --views --redefine=conf/mariadb/alter_table.yy --redefine=conf/mariadb/sp.yy --redefine=conf/mariadb/bulk_insert.yy --redefine=conf/mariadb/versioning.yy --redefine=conf/mariadb/sequences.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 --mysqld=--default-storage-engine=Aria --grammar=conf/engines/many_indexes.yy --gendata=conf/engines/many_indexes.zz --skip-gendata --gendata-advanced --vcols

mysqld: /data/src/10.4/storage/maria/ma_close.c:99: maria_close: Assertion `share->in_trans == 0' failed.

180815 13:27:58 [ERROR] mysqld got signal 6 ;

#7  0x00007f6c27a85ee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6

#8  0x0000561425f4fedd in maria_close (info=0x7f6bb83f1e00) at /data/src/10.4/storage/maria/ma_close.c:99

#9  0x0000561425ec62ff in ha_maria::close (this=0x7f6bb8109a08) at /data/src/10.4/storage/maria/ha_maria.cc:1276

#10 0x0000561425cb9a98 in handler::ha_close (this=0x7f6bb8109a08) at /data/src/10.4/sql/handler.cc:2750

#11 0x0000561425ad37cb in closefrm (table=0x7f6bb811b020) at /data/src/10.4/sql/table.cc:3587

#12 0x0000561425beaaf0 in intern_close_table (table=0x7f6bb811b020) at /data/src/10.4/sql/table_cache.cc:222

#13 0x0000561425beac8f in tc_remove_table (table=0x7f6bb811b020) at /data/src/10.4/sql/table_cache.cc:260

#14 0x0000561425beb61c in tc_release_table (table=0x7f6bb811b020) at /data/src/10.4/sql/table_cache.cc:473

#15 0x0000561425928a5d in close_thread_table (thd=0x7f6bb8000b00, table_ptr=0x7f6bb8000be0) at /data/src/10.4/sql/sql_base.cc:912

#16 0x000056142592872e in close_thread_tables (thd=0x7f6bb8000b00) at /data/src/10.4/sql/sql_base.cc:854

#17 0x000056142593a56c in close_system_tables (thd=0x7f6bb8000b00, backup=0x7f6c245b2a90) at /data/src/10.4/sql/sql_base.cc:8773

#18 0x0000561425e3fb79 in Sp_handler::db_find_routine (this=0x561427169130 <sp_handler_procedure>, thd=0x7f6bb8000b00, name=0x7f6c245b2e20, sphp=0x7f6c245b3038) at /data/src/10.4/sql/sp.cc:743

#19 0x0000561425e3fcb5 in Sp_handler::db_find_and_cache_routine (this=0x561427169130 <sp_handler_procedure>, thd=0x7f6bb8000b00, name=0x7f6c245b2e20, sp=0x7f6c245b3038) at /data/src/10.4/sql/sp.cc:767

#20 0x0000561425e4577b in Sp_handler::sp_cache_routine (this=0x561427169130 <sp_handler_procedure>, thd=0x7f6bb8000b00, name=0x7f6c245b2e20, lookup_only=false, sp=0x7f6c245b3038) at /data/src/10.4/sql/sp.cc:2792

#21 0x0000561425e455a8 in Sroutine_hash_entry::sp_cache_routine (this=0x7f6bb8015d40, thd=0x7f6bb8000b00, lookup_only=false, sp=0x7f6c245b3038) at /data/src/10.4/sql/sp.cc:2745

#22 0x000056142592d204 in open_and_process_routine (thd=0x7f6bb8000b00, prelocking_ctx=0x7f6bb80048e8, rt=0x7f6bb8015d40, prelocking_strategy=0x7f6c245b3240, has_prelocking_list=false, ot_ctx=0x7f6c245b3130, need_prelocking=0x7f6c245b30cf, routine_modifies_data=0x7f6c245b30d0) at /data/src/10.4/sql/sql_base.cc:3290

#23 0x000056142592ed5c in open_tables (thd=0x7f6bb8000b00, options=..., start=0x7f6c245b31a8, counter=0x7f6c245b31c4, flags=0, prelocking_strategy=0x7f6c245b3240) at /data/src/10.4/sql/sql_base.cc:4149

#24 0x000056142593091f in open_and_lock_tables (thd=0x7f6bb8000b00, options=..., tables=0x0, derived=true, flags=0, prelocking_strategy=0x7f6c245b3240) at /data/src/10.4/sql/sql_base.cc:4951

#25 0x00005614258f0e63 in open_and_lock_tables (thd=0x7f6bb8000b00, tables=0x0, derived=true, flags=0) at /data/src/10.4/sql/sql_base.h:500

#26 0x00005614259bd8ef in Sql_cmd_call::execute (this=0x7f6bb8015d28, thd=0x7f6bb8000b00) at /data/src/10.4/sql/sql_parse.cc:3144

#27 0x00005614259c7d0c in mysql_execute_command (thd=0x7f6bb8000b00) at /data/src/10.4/sql/sql_parse.cc:6284

#28 0x00005614259ccb45 in mysql_parse (thd=0x7f6bb8000b00, rawbuf=0x7f6bb8015c38 "CALL sp_22994 /* QNO 3740 CON_ID 14 */", length=38, parser_state=0x7f6c245b4640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064

#29 0x00005614259b9ff2 in dispatch_command (command=COM_QUERY, thd=0x7f6bb8000b00, packet=0x7f6bb824e301 "CALL sp_22994 /* QNO 3740 CON_ID 14 */ ", packet_length=39, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847

#30 0x00005614259b8a16 in do_command (thd=0x7f6bb8000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#31 0x0000561425b1f6fb in do_handle_one_connection (connect=0x561428db8cd0) at /data/src/10.4/sql/sql_connect.cc:1402

#32 0x0000561425b1f47f in handle_one_connection (arg=0x561428db8cd0) at /data/src/10.4/sql/sql_connect.cc:1308

#33 0x00007f6c2975c494 in start_thread (arg=0x7f6c245b5700) at pthread_create.c:333

#34 0x00007f6c27b4293f in clone () from /lib/x86_64-linux-gnu/libc.so.6

Assertion `share->in_trans == 0' failed

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6 --seed=1534256294 --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/versioning.yy --redefine=conf/mariadb/sequences.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 --mysqld=--default-storage-engine=Aria --grammar=conf/engines/many_indexes.yy --gendata=conf/engines/many_indexes.zz --skip-gendata --gendata-advanced --vcols --transformers=ExecuteAsIntersect,ExecuteAsExcept

mysqld: /data/src/10.4/storage/maria/ma_close.c:99: maria_close: Assertion `share->in_trans == 0' failed.

180815 13:09:30 [ERROR] mysqld got signal 6 ;

#7  0x00007f2cf5901ee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6

#8  0x0000561c1ac6bedd in maria_close (info=0x7f2c8c3f1e00) at /data/src/10.4/storage/maria/ma_close.c:99

#9  0x0000561c1abe22ff in ha_maria::close (this=0x7f2c8c58e538) at /data/src/10.4/storage/maria/ha_maria.cc:1276

#10 0x0000561c1a9d5a98 in handler::ha_close (this=0x7f2c8c58e538) at /data/src/10.4/sql/handler.cc:2750

#11 0x0000561c1a7ef7cb in closefrm (table=0x7f2c8c389100) at /data/src/10.4/sql/table.cc:3587

#12 0x0000561c1a906af0 in intern_close_table (table=0x7f2c8c389100) at /data/src/10.4/sql/table_cache.cc:222

#13 0x0000561c1a906f0a in tc_purge (mark_flushed=true) at /data/src/10.4/sql/table_cache.cc:335

#14 0x0000561c1a64370a in close_cached_tables (thd=0x7f2c70000b00, tables=0x0, wait_for_refresh=true, timeout=10) at /data/src/10.4/sql/sql_base.cc:377

#15 0x0000561c1a872df6 in reload_acl_and_cache (thd=0x7f2c70000b00, options=4, tables=0x0, write_to_binlog=0x7f2cd179b800) at /data/src/10.4/sql/sql_reload.cc:335

#16 0x0000561c1a6e183c in mysql_execute_command (thd=0x7f2c70000b00) at /data/src/10.4/sql/sql_parse.cc:5621

#17 0x0000561c1a6e8b45 in mysql_parse (thd=0x7f2c70000b00, rawbuf=0x7f2c70013a78 "FLUSH TABLES /* QNO 3261 CON_ID 18 */", length=37, parser_state=0x7f2cd179c640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064

#18 0x0000561c1a6d5ff2 in dispatch_command (command=COM_QUERY, thd=0x7f2c70000b00, packet=0x7f2c7000b341 "FLUSH TABLES /* QNO 3261 CON_ID 18 */ ", packet_length=38, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847

#19 0x0000561c1a6d4a16 in do_command (thd=0x7f2c70000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#20 0x0000561c1a83b6fb in do_handle_one_connection (connect=0x561c1e304060) at /data/src/10.4/sql/sql_connect.cc:1402

#21 0x0000561c1a83b47f in handle_one_connection (arg=0x561c1e304060) at /data/src/10.4/sql/sql_connect.cc:1308

#22 0x00007f2cf75d8494 in start_thread (arg=0x7f2cd179d700) at pthread_create.c:333

#23 0x00007f2cf59be93f in clone () from /lib/x86_64-linux-gnu/libc.so.6

Trying to lock uninitialized mutex at /data/src/10.4/storage/maria/trnman.c, line 369

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6 --seed=1534256294 --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/versioning.yy --redefine=conf/mariadb/sequences.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 --mysqld=--default-storage-engine=Aria --grammar=conf/engines/many_indexes.yy --gendata=conf/engines/many_indexes.zz --skip-gendata --gendata-advanced --vcols --transformers=ExecuteAsIntersect,ExecuteAsExcept,ExecuteAsCTE,ExecuteAsExecuteImmediate,ExecuteAsDeleteReturning,ExecuteAsInsertSelect,ExecuteAsUnion,ExecuteAsUpdateDelete,ExecuteAsView,ExecuteAsPreparedTwice

safe_mutex: Trying to lock uninitialized mutex at /data/src/10.4/storage/maria/trnman.c, line 369

180815 13:03:26 [ERROR] mysqld got signal 6 ;

Thread 1 (Thread 0x7f2c40804700 (LWP 21310)):

#0  0x00007f2c43cdbfcf in raise () from /lib/x86_64-linux-gnu/libc.so.6

#1  0x00007f2c43cdd3fa in abort () from /lib/x86_64-linux-gnu/libc.so.6

#2  0x00007f2c43cd4e37 in __assert_fail_base () from /lib/x86_64-linux-gnu/libc.so.6

#3  0x00007f2c43cd4ee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6

#4  0x0000563b04251bc6 in ha_maria::external_lock (this=0x7f2bcc095e68, thd=0x7f2bd0000b00, lock_type=2) at /data/src/10.4/storage/maria/ha_maria.cc:2780

#5  0x0000563b04049d70 in handler::ha_external_lock (this=0x7f2bcc095e68, thd=0x7f2bd0000b00, lock_type=2) at /data/src/10.4/sql/handler.cc:6122

#6  0x0000563b0416866d in unlock_external (thd=0x7f2bd0000b00, table=0x7f2bd009f1a8, count=1) at /data/src/10.4/sql/lock.cc:729

#7  0x0000563b04167a75 in mysql_unlock_tables (thd=0x7f2bd0000b00, sql_lock=0x7f2bd009f160, free_lock=false) at /data/src/10.4/sql/lock.cc:434

#8  0x0000563b041679cd in mysql_unlock_tables (thd=0x7f2bd0000b00, sql_lock=0x7f2bd009f160) at /data/src/10.4/sql/lock.cc:420

#9  0x0000563b03caf703 in close_thread_tables (thd=0x7f2bd0000b00) at /data/src/10.4/sql/sql_base.cc:846

#10 0x0000563b03d4f07c in mysql_execute_command (thd=0x7f2bd0000b00) at /data/src/10.4/sql/sql_parse.cc:6367

#11 0x0000563b03d53b45 in mysql_parse (thd=0x7f2bd0000b00, rawbuf=0x7f2bd0015c38 "( SELECT `col_datetime` FROM `view_t4` /* QNO 698 CON_ID 14 */  ) EXCEPT ( SELECT `col_datetime` FROM `view_t4` /* QNO 698 CON_ID 14 */  ) /* TRANSFORM_OUTCOME_EMPTY_RESULT */ /* QNO 702 CON_ID 14 */", length=199, parser_state=0x7f2c40803640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064

#12 0x0000563b03d40ff2 in dispatch_command (command=COM_QUERY, thd=0x7f2bd0000b00, packet=0x7f2bd024e301 "", packet_length=200, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847

#13 0x0000563b03d3fa16 in do_command (thd=0x7f2bd0000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#14 0x0000563b03ea66fb in do_handle_one_connection (connect=0x563b06fcdcd0) at /data/src/10.4/sql/sql_connect.cc:1402

#15 0x0000563b03ea647f in handle_one_connection (arg=0x563b06fcdcd0) at /data/src/10.4/sql/sql_connect.cc:1308

#16 0x00007f2c459ab494 in start_thread (arg=0x7f2c40804700) at pthread_create.c:333

#17 0x00007f2c43d9193f in clone () from /lib/x86_64-linux-gnu/libc.so.6

Attachments

Activity

Ascending order - Click to sort in descending order

Elena Stepanova added a comment - 2018-08-15 17:17

For the record, here is another failure that I got by running this (on the same server and RQG branches):

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6 --seed=1534256857 --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/versioning.yy --redefine=conf/mariadb/sequences.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 --mysqld=--default-storage-engine=Aria --grammar=conf/engines/engine_stress.yy --gendata=conf/engines/engine_stress.zz --ps-protocol --transformers=ExecuteAsIntersect,ExecuteAsExcept,ExecuteAsCTE,ExecuteAsExecuteImmediate,ExecuteAsDeleteReturning,ExecuteAsInsertSelect,ExecuteAsUnion,ExecuteAsUpdateDelete,ExecuteAsView

Thread 1 (Thread 0x7f3cc9630700 (LWP 10114)):

#0  __pthread_kill (threadid=<optimized out>, signo=11) at ../sysdeps/unix/sysv/linux/pthread_kill.c:57

#1  0x000055c9b386dcd2 in my_write_core (sig=11) at /data/src/10.4/mysys/stacktrace.c:481

#2  0x000055c9b30b792e in handle_fatal_signal (sig=11) at /data/src/10.4/sql/signal_handler.cc:305

#3  <signal handler called>

#4  0x000055c9b32ca646 in maria_create_trn_for_mysql (info=0x7f3c707bd560) at /data/src/10.4/storage/maria/ha_maria.cc:925

#5  0x000055c9b32b9157 in _ma_setup_live_state (info=0x7f3c707bd560) at /data/src/10.4/storage/maria/ma_state.c:65

#6  0x000055c9b32d018c in ha_maria::implicit_commit (thd=0x7f3c68000b00, new_trn=true) at /data/src/10.4/storage/maria/ha_maria.cc:2951

#7  0x000055c9b30ba9c2 in ha_commit_trans (thd=0x7f3c68000b00, all=true) at /data/src/10.4/sql/handler.cc:1360

#8  0x000055c9b2f3886d in trans_commit_implicit (thd=0x7f3c68000b00) at /data/src/10.4/sql/transaction.cc:376

#9  0x000055c9b2d8c0c6 in select_create::send_eof (this=0x7f3c68013c80) at /data/src/10.4/sql/sql_insert.cc:4599

#10 0x000055c9b2e3866c in do_select (join=0x7f3c68013d70, procedure=0x0) at /data/src/10.4/sql/sql_select.cc:18845

#11 0x000055c9b2e11291 in JOIN::exec_inner (this=0x7f3c68013d70) at /data/src/10.4/sql/sql_select.cc:4076

#12 0x000055c9b2e10702 in JOIN::exec (this=0x7f3c68013d70) at /data/src/10.4/sql/sql_select.cc:3870

#13 0x000055c9b2e11991 in mysql_select (thd=0x7f3c68000b00, tables=0x7f3c6801d418, wild_num=0, fields=..., conds=0x0, og_num=0, order=0x0, group=0x0, having=0x0, proc_param=0x0, select_options=2416708096, result=0x7f3c68013c80, unit=0x7f3c6801ac80, select_lex=0x7f3c6801cdd0) at /data/src/10.4/sql/sql_select.cc:4275

#14 0x000055c9b2e03410 in handle_select (thd=0x7f3c68000b00, lex=0x7f3c6801abb8, result=0x7f3c68013c80, setup_tables_done_option=0) at /data/src/10.4/sql/sql_select.cc:382

#15 0x000055c9b2dc5835 in mysql_execute_command (thd=0x7f3c68000b00) at /data/src/10.4/sql/sql_parse.cc:4240

#16 0x000055c9b2def988 in Prepared_statement::execute (this=0x7f3c68023b00, expanded_query=0x7f3cc962f3c0, open_cursor=false) at /data/src/10.4/sql/sql_prepare.cc:4765

#17 0x000055c9b2dedd5e in Prepared_statement::execute_loop (this=0x7f3c68023b00, expanded_query=0x7f3cc962f3c0, open_cursor=false, packet=0x7f3c6800b34a "", packet_end=0x7f3c6800b34a "") at /data/src/10.4/sql/sql_prepare.cc:4193

#18 0x000055c9b2deb581 in mysql_stmt_execute_common (thd=0x7f3c68000b00, stmt_id=199, packet=0x7f3c6800b34a "", packet_end=0x7f3c6800b34a "", cursor_flags=0, bulk_op=false, read_types=false) at /data/src/10.4/sql/sql_prepare.cc:3193

#19 0x000055c9b2deb11a in mysqld_stmt_execute (thd=0x7f3c68000b00, packet_arg=0x7f3c6800b341 <incomplete sequence \307>, packet_length=9) at /data/src/10.4/sql/sql_prepare.cc:3091

#20 0x000055c9b2dbec41 in dispatch_command (command=COM_STMT_EXECUTE, thd=0x7f3c68000b00, packet=0x7f3c6800b341 <incomplete sequence \307>, packet_length=9, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1789

#21 0x000055c9b2dbda16 in do_command (thd=0x7f3c68000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#22 0x000055c9b2f246fb in do_handle_one_connection (connect=0x55c9b65ab060) at /data/src/10.4/sql/sql_connect.cc:1402

#23 0x000055c9b2f2447f in handle_one_connection (arg=0x55c9b65ab060) at /data/src/10.4/sql/sql_connect.cc:1308

#24 0x00007f3ce0de8494 in start_thread (arg=0x7f3cc9630700) at pthread_create.c:333

#25 0x00007f3cdf1ce93f in clone () from /lib/x86_64-linux-gnu/libc.so.6

However, when i try to re-run it, I get one of the assertions above instead, namely

mysqld: /data/src/10.4/storage/maria/ma_commit.c:37: ma_commit: Assertion `trn->rec_lsn == ((LSN)0)' failed.

180815 20:15:53 [ERROR] mysqld got signal 6 ;

so I assume it's all a part of the same problem.

Elena Stepanova added a comment - 2018-08-15 17:17 For the record, here is another failure that I got by running this (on the same server and RQG branches): perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6 --seed=1534256857 --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/versioning.yy --redefine=conf/mariadb/sequences.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 --mysqld=--default-storage-engine=Aria --grammar=conf/engines/engine_stress.yy --gendata=conf/engines/engine_stress.zz --ps-protocol --transformers=ExecuteAsIntersect,ExecuteAsExcept,ExecuteAsCTE,ExecuteAsExecuteImmediate,ExecuteAsDeleteReturning,ExecuteAsInsertSelect,ExecuteAsUnion,ExecuteAsUpdateDelete,ExecuteAsView Thread 1 (Thread 0x7f3cc9630700 (LWP 10114)): #0 __pthread_kill (threadid=<optimized out>, signo=11) at ../sysdeps/unix/sysv/linux/pthread_kill.c:57 #1 0x000055c9b386dcd2 in my_write_core (sig=11) at /data/src/10.4/mysys/stacktrace.c:481 #2 0x000055c9b30b792e in handle_fatal_signal (sig=11) at /data/src/10.4/sql/signal_handler.cc:305 #3 <signal handler called> #4 0x000055c9b32ca646 in maria_create_trn_for_mysql (info=0x7f3c707bd560) at /data/src/10.4/storage/maria/ha_maria.cc:925 #5 0x000055c9b32b9157 in _ma_setup_live_state (info=0x7f3c707bd560) at /data/src/10.4/storage/maria/ma_state.c:65 #6 0x000055c9b32d018c in ha_maria::implicit_commit (thd=0x7f3c68000b00, new_trn=true) at /data/src/10.4/storage/maria/ha_maria.cc:2951 #7 0x000055c9b30ba9c2 in ha_commit_trans (thd=0x7f3c68000b00, all=true) at /data/src/10.4/sql/handler.cc:1360 #8 0x000055c9b2f3886d in trans_commit_implicit (thd=0x7f3c68000b00) at /data/src/10.4/sql/transaction.cc:376 #9 0x000055c9b2d8c0c6 in select_create::send_eof (this=0x7f3c68013c80) at /data/src/10.4/sql/sql_insert.cc:4599 #10 0x000055c9b2e3866c in do_select (join=0x7f3c68013d70, procedure=0x0) at /data/src/10.4/sql/sql_select.cc:18845 #11 0x000055c9b2e11291 in JOIN::exec_inner (this=0x7f3c68013d70) at /data/src/10.4/sql/sql_select.cc:4076 #12 0x000055c9b2e10702 in JOIN::exec (this=0x7f3c68013d70) at /data/src/10.4/sql/sql_select.cc:3870 #13 0x000055c9b2e11991 in mysql_select (thd=0x7f3c68000b00, tables=0x7f3c6801d418, wild_num=0, fields=..., conds=0x0, og_num=0, order=0x0, group=0x0, having=0x0, proc_param=0x0, select_options=2416708096, result=0x7f3c68013c80, unit=0x7f3c6801ac80, select_lex=0x7f3c6801cdd0) at /data/src/10.4/sql/sql_select.cc:4275 #14 0x000055c9b2e03410 in handle_select (thd=0x7f3c68000b00, lex=0x7f3c6801abb8, result=0x7f3c68013c80, setup_tables_done_option=0) at /data/src/10.4/sql/sql_select.cc:382 #15 0x000055c9b2dc5835 in mysql_execute_command (thd=0x7f3c68000b00) at /data/src/10.4/sql/sql_parse.cc:4240 #16 0x000055c9b2def988 in Prepared_statement::execute (this=0x7f3c68023b00, expanded_query=0x7f3cc962f3c0, open_cursor=false) at /data/src/10.4/sql/sql_prepare.cc:4765 #17 0x000055c9b2dedd5e in Prepared_statement::execute_loop (this=0x7f3c68023b00, expanded_query=0x7f3cc962f3c0, open_cursor=false, packet=0x7f3c6800b34a "", packet_end=0x7f3c6800b34a "") at /data/src/10.4/sql/sql_prepare.cc:4193 #18 0x000055c9b2deb581 in mysql_stmt_execute_common (thd=0x7f3c68000b00, stmt_id=199, packet=0x7f3c6800b34a "", packet_end=0x7f3c6800b34a "", cursor_flags=0, bulk_op=false, read_types=false) at /data/src/10.4/sql/sql_prepare.cc:3193 #19 0x000055c9b2deb11a in mysqld_stmt_execute (thd=0x7f3c68000b00, packet_arg=0x7f3c6800b341 <incomplete sequence \307>, packet_length=9) at /data/src/10.4/sql/sql_prepare.cc:3091 #20 0x000055c9b2dbec41 in dispatch_command (command=COM_STMT_EXECUTE, thd=0x7f3c68000b00, packet=0x7f3c6800b341 <incomplete sequence \307>, packet_length=9, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1789 #21 0x000055c9b2dbda16 in do_command (thd=0x7f3c68000b00) at /data/src/10.4/sql/sql_parse.cc:1392 #22 0x000055c9b2f246fb in do_handle_one_connection (connect=0x55c9b65ab060) at /data/src/10.4/sql/sql_connect.cc:1402 #23 0x000055c9b2f2447f in handle_one_connection (arg=0x55c9b65ab060) at /data/src/10.4/sql/sql_connect.cc:1308 #24 0x00007f3ce0de8494 in start_thread (arg=0x7f3cc9630700) at pthread_create.c:333 #25 0x00007f3cdf1ce93f in clone () from /lib/x86_64-linux-gnu/libc.so.6 However, when i try to re-run it, I get one of the assertions above instead, namely mysqld: /data/src/10.4/storage/maria/ma_commit.c:37: ma_commit: Assertion `trn->rec_lsn == ((LSN)0)' failed. 180815 20:15:53 [ERROR] mysqld got signal 6 ; so I assume it's all a part of the same problem.

Elena Stepanova added a comment - 2018-08-15 17:31

For the record, here is yet another failure that I'm getting:

perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6 --seed=1534257008 --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/versioning.yy --redefine=conf/mariadb/sequences.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 --mysqld=--default-storage-engine=Aria --grammar=conf/engines/engine_stress.yy --gendata=conf/engines/engine_stress.zz --mysqld=--log_bin_trust_function_creators=1 --mysqld=--default-storage-engine=Aria --grammar=conf/engines/engine_stress.yy --gendata=conf/engines/engine_stress.zz --mysqld=--log-bin --transformers=ExecuteAsIntersect,ExecuteAsExcept,ExecuteAsCTE,ExecuteAsExecuteImmediate,ExecuteAsDeleteReturning,ExecuteAsInsertSelect,ExecuteAsUnion,ExecuteAsUpdateDelete,ExecuteAsView,ExecuteAsPreparedTwice --redefine=conf/mariadb/general-workarounds.yy

mysqld: /data/src/10.4/storage/maria/ha_maria.cc:2780: virtual int ha_maria::external_lock(THD*, int): Assertion `trnman_has_locked_tables(trn) > 0' failed.

180815 20:20:01 [ERROR] mysqld got signal 6 ;

mysqld: /data/src/10.4/storage/maria/trnman.c:374: trnman_new_trn: Assertion `res <= 0' failed.

#3  0x00007fe34e981ee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6

#4  0x000055d0945e022a in trnman_new_trn (wt=0x7fe2e00040d8) at /data/src/10.4/storage/maria/trnman.c:374

#5  0x000055d0945d6685 in maria_create_trn_for_mysql (info=0x7fe2c40d5c40) at /data/src/10.4/storage/maria/ha_maria.cc:930

#6  0x000055d0945c5157 in _ma_setup_live_state (info=0x7fe2c40d5c40) at /data/src/10.4/storage/maria/ma_state.c:65

#7  0x000055d0945c6623 in _ma_block_start_trans (param=0x7fe2c40d5c40) at /data/src/10.4/storage/maria/ma_state.c:680

#8  0x000055d094b7d782 in thr_multi_lock (data=0x7fe2e001bcb8, count=4, owner=0x7fe2e00025f8, lock_wait_timeout=10) at /data/src/10.4/mysys/thr_lock.c:1318

#9  0x000055d0944f162b in mysql_lock_tables (thd=0x7fe2e0000b00, sql_lock=0x7fe2e001bc78, flags=0) at /data/src/10.4/sql/lock.cc:355

#10 0x000055d0944f142c in mysql_lock_tables (thd=0x7fe2e0000b00, tables=0x7fe2e001bc58, count=3, flags=0) at /data/src/10.4/sql/lock.cc:304

#11 0x000055d094042310 in lock_tables (thd=0x7fe2e0000b00, tables=0x7fe2e00160e0, count=4, flags=0) at /data/src/10.4/sql/sql_base.cc:5216

#12 0x000055d094041997 in open_and_lock_tables (thd=0x7fe2e0000b00, options=..., tables=0x7fe2e00160e0, derived=true, flags=0, prelocking_strategy=0x7fe34c0672a0) at /data/src/10.4/sql/sql_base.cc:4960

#13 0x000055d094001e63 in open_and_lock_tables (thd=0x7fe2e0000b00, tables=0x7fe2e00160e0, derived=true, flags=0) at /data/src/10.4/sql/sql_base.h:500

#14 0x000055d0941d2a55 in mysql_create_view (thd=0x7fe2e0000b00, views=0x7fe2e00160e0, mode=VIEW_CREATE_OR_REPLACE) at /data/src/10.4/sql/sql_view.cc:449

#15 0x000055d0940d8310 in mysql_execute_command (thd=0x7fe2e0000b00) at /data/src/10.4/sql/sql_parse.cc:6105

#16 0x000055d0940ddb45 in mysql_parse (thd=0x7fe2e0000b00, rawbuf=0x7fe2e0015d38 "CREATE OR REPLACE ALGORITHM=MERGE VIEW transforms.view_13133_merge AS SELECT X.`pk` FROM `table2_int_autoinc` AS X LEFT JOIN `view_table1_int_autoinc` AS Y USING ( `col_char_12_key` ) WHERE X.`col_int"..., length=347, parser_state=0x7fe34c068640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064

#17 0x000055d0940caff2 in dispatch_command (command=COM_QUERY, thd=0x7fe2e0000b00, packet=0x7fe2e000b441 "CREATE OR REPLACE ALGORITHM=MERGE VIEW transforms.view_13133_merge AS SELECT X.`pk` FROM `table2_int_autoinc` AS X LEFT JOIN `view_table1_int_autoinc` AS Y USING ( `col_char_12_key` ) WHERE X.`col_int"..., packet_length=348, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847

#18 0x000055d0940c9a16 in do_command (thd=0x7fe2e0000b00) at /data/src/10.4/sql/sql_parse.cc:1392

#19 0x000055d0942306fb in do_handle_one_connection (connect=0x55d0989c3310) at /data/src/10.4/sql/sql_connect.cc:1402

#20 0x000055d09423047f in handle_one_connection (arg=0x55d0989c3310) at /data/src/10.4/sql/sql_connect.cc:1308

#21 0x00007fe350658494 in start_thread (arg=0x7fe34c069700) at pthread_create.c:333

#22 0x00007fe34ea3e93f in clone () from /lib/x86_64-linux-gnu/libc.so.6

but again, by re-running the same test I am getting one of previously reported failures.

Elena Stepanova added a comment - 2018-08-15 17:31 For the record, here is yet another failure that I'm getting: perl ./runall-new.pl --basedir=/data/bld/10.4 --vardir=/dev/shm/vardir --duration=350 --threads=6 --seed=1534257008 --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/versioning.yy --redefine=conf/mariadb/sequences.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 --mysqld=--default-storage-engine=Aria --grammar=conf/engines/engine_stress.yy --gendata=conf/engines/engine_stress.zz --mysqld=--log_bin_trust_function_creators=1 --mysqld=--default-storage-engine=Aria --grammar=conf/engines/engine_stress.yy --gendata=conf/engines/engine_stress.zz --mysqld=--log-bin --transformers=ExecuteAsIntersect,ExecuteAsExcept,ExecuteAsCTE,ExecuteAsExecuteImmediate,ExecuteAsDeleteReturning,ExecuteAsInsertSelect,ExecuteAsUnion,ExecuteAsUpdateDelete,ExecuteAsView,ExecuteAsPreparedTwice --redefine=conf/mariadb/general-workarounds.yy mysqld: /data/src/10.4/storage/maria/ha_maria.cc:2780: virtual int ha_maria::external_lock(THD*, int): Assertion `trnman_has_locked_tables(trn) > 0' failed. 180815 20:20:01 [ERROR] mysqld got signal 6 ; mysqld: /data/src/10.4/storage/maria/trnman.c:374: trnman_new_trn: Assertion `res <= 0' failed. #3 0x00007fe34e981ee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6 #4 0x000055d0945e022a in trnman_new_trn (wt=0x7fe2e00040d8) at /data/src/10.4/storage/maria/trnman.c:374 #5 0x000055d0945d6685 in maria_create_trn_for_mysql (info=0x7fe2c40d5c40) at /data/src/10.4/storage/maria/ha_maria.cc:930 #6 0x000055d0945c5157 in _ma_setup_live_state (info=0x7fe2c40d5c40) at /data/src/10.4/storage/maria/ma_state.c:65 #7 0x000055d0945c6623 in _ma_block_start_trans (param=0x7fe2c40d5c40) at /data/src/10.4/storage/maria/ma_state.c:680 #8 0x000055d094b7d782 in thr_multi_lock (data=0x7fe2e001bcb8, count=4, owner=0x7fe2e00025f8, lock_wait_timeout=10) at /data/src/10.4/mysys/thr_lock.c:1318 #9 0x000055d0944f162b in mysql_lock_tables (thd=0x7fe2e0000b00, sql_lock=0x7fe2e001bc78, flags=0) at /data/src/10.4/sql/lock.cc:355 #10 0x000055d0944f142c in mysql_lock_tables (thd=0x7fe2e0000b00, tables=0x7fe2e001bc58, count=3, flags=0) at /data/src/10.4/sql/lock.cc:304 #11 0x000055d094042310 in lock_tables (thd=0x7fe2e0000b00, tables=0x7fe2e00160e0, count=4, flags=0) at /data/src/10.4/sql/sql_base.cc:5216 #12 0x000055d094041997 in open_and_lock_tables (thd=0x7fe2e0000b00, options=..., tables=0x7fe2e00160e0, derived=true, flags=0, prelocking_strategy=0x7fe34c0672a0) at /data/src/10.4/sql/sql_base.cc:4960 #13 0x000055d094001e63 in open_and_lock_tables (thd=0x7fe2e0000b00, tables=0x7fe2e00160e0, derived=true, flags=0) at /data/src/10.4/sql/sql_base.h:500 #14 0x000055d0941d2a55 in mysql_create_view (thd=0x7fe2e0000b00, views=0x7fe2e00160e0, mode=VIEW_CREATE_OR_REPLACE) at /data/src/10.4/sql/sql_view.cc:449 #15 0x000055d0940d8310 in mysql_execute_command (thd=0x7fe2e0000b00) at /data/src/10.4/sql/sql_parse.cc:6105 #16 0x000055d0940ddb45 in mysql_parse (thd=0x7fe2e0000b00, rawbuf=0x7fe2e0015d38 "CREATE OR REPLACE ALGORITHM=MERGE VIEW transforms.view_13133_merge AS SELECT X.`pk` FROM `table2_int_autoinc` AS X LEFT JOIN `view_table1_int_autoinc` AS Y USING ( `col_char_12_key` ) WHERE X.`col_int"..., length=347, parser_state=0x7fe34c068640, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8064 #17 0x000055d0940caff2 in dispatch_command (command=COM_QUERY, thd=0x7fe2e0000b00, packet=0x7fe2e000b441 "CREATE OR REPLACE ALGORITHM=MERGE VIEW transforms.view_13133_merge AS SELECT X.`pk` FROM `table2_int_autoinc` AS X LEFT JOIN `view_table1_int_autoinc` AS Y USING ( `col_char_12_key` ) WHERE X.`col_int"..., packet_length=348, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1847 #18 0x000055d0940c9a16 in do_command (thd=0x7fe2e0000b00) at /data/src/10.4/sql/sql_parse.cc:1392 #19 0x000055d0942306fb in do_handle_one_connection (connect=0x55d0989c3310) at /data/src/10.4/sql/sql_connect.cc:1402 #20 0x000055d09423047f in handle_one_connection (arg=0x55d0989c3310) at /data/src/10.4/sql/sql_connect.cc:1308 #21 0x00007fe350658494 in start_thread (arg=0x7fe34c069700) at pthread_create.c:333 #22 0x00007fe34ea3e93f in clone () from /lib/x86_64-linux-gnu/libc.so.6 but again, by re-running the same test I am getting one of previously reported failures.

Elena Stepanova added a comment - 2018-08-18 10:34

The following is still reproducible on 10.4 after revision 3faed09d6d7cae5, the first patch associated with this bug report.

10.4 bf1c53e9be8
mysqld: /data/src/10.4/storage/maria/ma_close.c:99: maria_close: Assertion `share->in_trans == 0' failed.
180818 13:34:28 [ERROR] mysqld got signal 6 ;

#7 0x00007f238ee8aee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6
#8 0x0000560f120256dd in maria_close (info=0x7f2378038830) at /data/src/10.4/storage/maria/ma_close.c:99
#9 0x0000560f11f9b95f in ha_maria::close (this=0x7f237802cce8) at /data/src/10.4/storage/maria/ha_maria.cc:1279
#10 0x0000560f11d8f4d6 in handler::ha_close (this=0x7f237802cce8) at /data/src/10.4/sql/handler.cc:2750
#11 0x0000560f11ba8b91 in closefrm (table=0x7f237802c0b0) at /data/src/10.4/sql/table.cc:3587
#12 0x0000560f11cc04d7 in intern_close_table (table=0x7f237802c0b0) at /data/src/10.4/sql/table_cache.cc:223
#13 0x0000560f11cc08f1 in tc_purge (mark_flushed=true) at /data/src/10.4/sql/table_cache.cc:336
#14 0x0000560f119fc59c in close_cached_tables (thd=0x7f236c000b00, tables=0x0, wait_for_refresh=true, timeout=2) at /data/src/10.4/sql/sql_base.cc:377
#15 0x0000560f11c2c316 in reload_acl_and_cache (thd=0x7f236c000b00, options=4, tables=0x0, write_to_binlog=0x7f2388fe67b0) at /data/src/10.4/sql/sql_reload.cc:335
#16 0x0000560f11a9a700 in mysql_execute_command (thd=0x7f236c000b00) at /data/src/10.4/sql/sql_parse.cc:5624
#17 0x0000560f11aa1aae in mysql_parse (thd=0x7f236c000b00, rawbuf=0x7f236c013ac8 "FLUSH TABLES", length=12, parser_state=0x7f2388fe75f0, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8078
#18 0x0000560f11a8eeb6 in dispatch_command (command=COM_QUERY, thd=0x7f236c000b00, packet=0x7f236c00b441 "FLUSH TABLES", packet_length=12, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1850
#19 0x0000560f11a8d8da in do_command (thd=0x7f236c000b00) at /data/src/10.4/sql/sql_parse.cc:1395
#20 0x0000560f11bf4b91 in do_handle_one_connection (connect=0x560f151104d0) at /data/src/10.4/sql/sql_connect.cc:1402
#21 0x0000560f11bf4915 in handle_one_connection (arg=0x560f151104d0) at /data/src/10.4/sql/sql_connect.cc:1308
#22 0x0000560f120906b7 in pfs_spawn_thread (arg=0x560f151a5da0) at /data/src/10.4/storage/perfschema/pfs.cc:1862
#23 0x00007f2390b61494 in start_thread (arg=0x7f2388fe8700) at pthread_create.c:333
#24 0x00007f238ef4793f in clone () from /lib/x86_64-linux-gnu/libc.so.6

Test case
CREATE TABLE t1 (i INT) ENGINE=Aria;
LOCK TABLE t1 WRITE;

--connect (con1,localhost,root,,test)
SET lock_wait_timeout= 2;
--send
FLUSH TABLES;

--connection default
--error ER_SP_DOES_NOT_EXIST
CALL non_existing_sp;

--connection con1
--error ER_LOCK_WAIT_TIMEOUT
--reap

# Cleanup
--disconnect con1
--connection default
DROP TABLE t1;

Elena Stepanova added a comment - 2018-08-18 10:34 The following is still reproducible on 10.4 after revision 3faed09d6d7cae5, the first patch associated with this bug report. 10.4 bf1c53e9be8 mysqld: /data/src/10.4/storage/maria/ma_close.c:99: maria_close: Assertion `share->in_trans == 0' failed. 180818 13:34:28 [ERROR] mysqld got signal 6 ; #7 0x00007f238ee8aee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6 #8 0x0000560f120256dd in maria_close (info=0x7f2378038830) at /data/src/10.4/storage/maria/ma_close.c:99 #9 0x0000560f11f9b95f in ha_maria::close (this=0x7f237802cce8) at /data/src/10.4/storage/maria/ha_maria.cc:1279 #10 0x0000560f11d8f4d6 in handler::ha_close (this=0x7f237802cce8) at /data/src/10.4/sql/handler.cc:2750 #11 0x0000560f11ba8b91 in closefrm (table=0x7f237802c0b0) at /data/src/10.4/sql/table.cc:3587 #12 0x0000560f11cc04d7 in intern_close_table (table=0x7f237802c0b0) at /data/src/10.4/sql/table_cache.cc:223 #13 0x0000560f11cc08f1 in tc_purge (mark_flushed=true) at /data/src/10.4/sql/table_cache.cc:336 #14 0x0000560f119fc59c in close_cached_tables (thd=0x7f236c000b00, tables=0x0, wait_for_refresh=true, timeout=2) at /data/src/10.4/sql/sql_base.cc:377 #15 0x0000560f11c2c316 in reload_acl_and_cache (thd=0x7f236c000b00, options=4, tables=0x0, write_to_binlog=0x7f2388fe67b0) at /data/src/10.4/sql/sql_reload.cc:335 #16 0x0000560f11a9a700 in mysql_execute_command (thd=0x7f236c000b00) at /data/src/10.4/sql/sql_parse.cc:5624 #17 0x0000560f11aa1aae in mysql_parse (thd=0x7f236c000b00, rawbuf=0x7f236c013ac8 "FLUSH TABLES", length=12, parser_state=0x7f2388fe75f0, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:8078 #18 0x0000560f11a8eeb6 in dispatch_command (command=COM_QUERY, thd=0x7f236c000b00, packet=0x7f236c00b441 "FLUSH TABLES", packet_length=12, is_com_multi=false, is_next_command=false) at /data/src/10.4/sql/sql_parse.cc:1850 #19 0x0000560f11a8d8da in do_command (thd=0x7f236c000b00) at /data/src/10.4/sql/sql_parse.cc:1395 #20 0x0000560f11bf4b91 in do_handle_one_connection (connect=0x560f151104d0) at /data/src/10.4/sql/sql_connect.cc:1402 #21 0x0000560f11bf4915 in handle_one_connection (arg=0x560f151104d0) at /data/src/10.4/sql/sql_connect.cc:1308 #22 0x0000560f120906b7 in pfs_spawn_thread (arg=0x560f151a5da0) at /data/src/10.4/storage/perfschema/pfs.cc:1862 #23 0x00007f2390b61494 in start_thread (arg=0x7f2388fe8700) at pthread_create.c:333 #24 0x00007f238ef4793f in clone () from /lib/x86_64-linux-gnu/libc.so.6 Test case CREATE TABLE t1 (i INT ) ENGINE=Aria; LOCK TABLE t1 WRITE; --connect (con1,localhost,root,,test) SET lock_wait_timeout= 2; --send FLUSH TABLES; --connection default --error ER_SP_DOES_NOT_EXIST CALL non_existing_sp; --connection con1 --error ER_LOCK_WAIT_TIMEOUT --reap # Cleanup --disconnect con1 --connection default DROP TABLE t1;

Michael Widenius added a comment - 2018-08-18 11:51

Most of the issues are fixed in my latest push into 10.4
The problem was a pointer that accessed old data.

I will next try to fix the last bug reported on this JIRA

Michael Widenius added a comment - 2018-08-18 11:51 Most of the issues are fixed in my latest push into 10.4 The problem was a pointer that accessed old data. I will next try to fix the last bug reported on this JIRA

Michael Widenius added a comment - 2018-08-20 14:53

Regarding the issue with share->in_trans:

The problem was that when a mysql.proc table was opened for reading it
was added to the current Aria transaction context but never properly
deleted from it. Normally this isn't a problem, except if the
mysql.proc table is closed before the transaction ended, which happened
in this test case.

Fixed by removing mysql.proc from the transaction context before
closing the table

Michael Widenius added a comment - 2018-08-20 14:53 Regarding the issue with share->in_trans: The problem was that when a mysql.proc table was opened for reading it was added to the current Aria transaction context but never properly deleted from it. Normally this isn't a problem, except if the mysql.proc table is closed before the transaction ended, which happened in this test case. Fixed by removing mysql.proc from the transaction context before closing the table

Michael Widenius added a comment - 2018-08-21 06:46

Pushed

Michael Widenius added a comment - 2018-08-21 06:46 Pushed

People

Assignee:: Michael Widenius

Reporter:: Elena Stepanova

Votes:: 0 Vote for this issue

Watchers:: 2 Start watching this issue

Dates

Created:: 2018-08-15 11:07

Updated:: 2018-08-21 06:46

Resolved:: 2018-08-21 06:46

Git Integration

Error rendering 'com.xiplink.jira.git.jira_git_plugin:git-issue-webpanel'. Please contact your Jira administrators.

MariaDB Server

Details

Description

Assertion `trn->undo_lsn == ((LSN)0)'

safe_mutex: Trying to lock uninitialized mutex at /data/src/10.4/storage/maria/trnman.c, line 369

mysqld got signal 11

Assertion `trn->rec_lsn == ((LSN)0)' failed

Assertion `trn->rec_lsn == ((LSN)0)' failed

Assertion `trn->rec_lsn == ((LSN)0)' failed.

Assertion `share->in_trans == 0' failed

Assertion `share->in_trans == 0' failed

Assertion `share->in_trans == 0' failed

Assertion `share->in_trans == 0' failed

Trying to lock uninitialized mutex at /data/src/10.4/storage/maria/trnman.c, line 369

Attachments

Activity

People

Dates

Git Integration