| Bug #74343 | InnoDB: Failing assertion: inode (sig6 in fsp0fsp.cc line 1887) | error code 47 | ||
|---|---|---|---|
| Submitted: | 12 Oct 2014 20:24 | Modified: | 14 Feb 2015 7:21 |
| Reporter: | Roel Van de Paar | Email Updates: | |
| Status: | Verified | Impact on me: | |
| Category: | MySQL Server: DML | Severity: | S6 (Debug Builds) |
| Version: | 5.6.20, 5.6.23,5.7 | OS: | Any |
| Assigned to: | CPU Architecture: | Any | |
| Tags: | debug | ||
[12 Oct 2014 20:24]
Roel Van de Paar
[12 Oct 2014 20:24]
Roel Van de Paar
2014-10-13 17:06:43 31947 [Note] /sda/mysql-5.6.20-linux-x86_64-debug/bin/mysqld: ready for connections. Version: '5.6.20-debug' socket: '/dev/shm/1413180386/subreducer/1/socket.sock' port: 42183 MySQL Community Server (GPL) 2014-10-13 17:06:43 31947 [Note] Event Scheduler: scheduler thread started with id 1 2014-10-13 17:06:44 7f09ae8be700 InnoDB: Warning: cannot find a free slot for an undo log. Do you have too InnoDB: many active transactions running concurrently? 2014-10-13 17:06:44 31947 [Warning] InnoDB: Unable to delete statistics for table test.t1: Too many concurrent transactions. They can be deleted later using DELETE FROM mysql.innodb_index_stats WHERE database_name = 'test' AND table_name = 't1'; DELETE FROM mysql.innodb_table_stats WHERE database_name = 'test' AND table_name = 't1'; 2014-10-13 17:06:44 7f09ae8be700 InnoDB: Warning: cannot find a free slot for an undo log. Do you have too InnoDB: many active transactions running concurrently? 2014-10-13 17:06:44 7f09ae8be700InnoDB: unknown error code 47 while dropping table:`test`.`t1`. 2014-10-13 17:06:44 7f09ae8be700 InnoDB: Warning: cannot find a free slot for an undo log. Do you have too InnoDB: many active transactions running concurrently? 2014-10-13 17:06:44 31947 [Warning] InnoDB: Unable to delete statistics for table test.t1: Too many concurrent transactions. They can be deleted later using DELETE FROM mysql.innodb_index_stats WHERE database_name = 'test' AND table_name = 't1'; DELETE FROM mysql.innodb_table_stats WHERE database_name = 'test' AND table_name = 't1'; 2014-10-13 17:06:44 7f09ae8be700 InnoDB: Warning: cannot find a free slot for an undo log. Do you have too InnoDB: many active transactions running concurrently? 2014-10-13 17:06:44 7f09ae8be700InnoDB: unknown error code 47 while dropping table:`test`.`t1`. 2014-10-13 17:06:44 7f09ae8be700 InnoDB: Assertion failure in thread 139679559837440 in file fsp0fsp.cc line 1887 InnoDB: Failing assertion: inode
[12 Oct 2014 20:24]
Roel Van de Paar
Sorry, no few-lines-of-SQL testcase. Simplification past ~127 lines is taking days (and it already has taken 2-3 days of partial machine time). Yet, there is a 127 line testcase which, when ran through a hacked version of reducer.sh (as included with RQG) fails consistently 10/10, but only on the inital run. In any case, it should be plenty to debug and/or make a shorter MTR testcase. Note that whilst reducer starts 10 subreducers (i.e. 10x mysqld), replay is always SINGLE threaded. So, the issue is single thread reproducible. I have a feeling the mysqld code is trying to surpass one or more OS variables/settings, is potentially unable too, and fails without catching the true issue. Note also the error 47. Reason I say this is that once original 10x mysqld verify stage is complete in reducer (where the issue reproduces 10/10), the subsequent stages (which is now run single threaded as reducer believes that the issue is non-sporadic because it reproduced 10/10 during verify stage) do not reproduce the issue easily/at all, even when only 2 random lines are marked for elimination from the SQL. [roel@localhost 814189]$ ./reducer1075ms.sh 2014-10-13 17:08:39 [Init] Workdir: /dev/shm/1413180519 2014-10-13 17:08:39 [Init] Temporary storage directory (TMP environment variable) set to /dev/shm/1413180519/tmp 2014-10-13 17:08:39 [Init] Input file: /sda/814189/1075/pquery_thread-0.sql_out_out_out_out 2014-10-13 17:08:39 [Init] Server (When MULTI mode is not active): /sda/mysql-5.6.20-linux-x86_64-debug/bin/mysqld (as roel) 2014-10-13 17:08:39 [Init] Client (When MULTI mode is not active): /sda/mysql-5.6.20-linux-x86_64-debug/bin/mysql -uroot -S/dev/shm/1413180519/socket.sock 2014-10-13 17:08:39 [Init] Querytimeout: 90 seconds (ensure this is at least 1.5x what was set in RQG using the --querytimeout option) 2014-10-13 17:08:39 [Init] Passing the following additional options to mysqld: --log-output=none --sql_mode=ONLY_FULL_GROUP_BY --core 2014-10-13 17:08:39 [Init] Setting up standard working subdirectories 2014-10-13 17:08:46 [Init] Loading timezone data into mysql database 2014-10-13 17:08:46 [Info] If you see a GLIBC crash above, change reducer to use a non-Valgrind-instrumented build of mysql_tzinfo_to_sql (Ref. BUG#13498842) 2014-10-13 17:08:54 [Init] Run mode: MODE3: mysqld error log 2014-10-13 17:08:54 [Init] Looking for this string: 'unknown error code 47' in mysqld error log output (@ /dev/shm/1413180519/error.log.out when MULTI mode is not active) 2014-10-13 17:08:54 [Info] Leading [] = No bug/issue found yet | [*] = Bug/issue at least seen once 2014-10-13 17:08:54 [Init] Number of lines in input file: 127 2014-10-13 17:08:54 [] [Stage V] Verifying the bug/issue really exists (duration depends on initial input file size) 2014-10-13 17:08:54 [] [Stage V] [MULTI] Starting 10 verification subreducer threads to verify if the issue is sporadic (/dev/shm/1413180519/subreducer/) 2014-10-13 17:08:57 [] [Stage V] [MULTI] Forking subreducer threads [PIDs]: #1 [6251] #2 [6373] #3 [6502] #4 [6634] #5 [6766] #6 [6895] #7 [7029] #8 [7172] #9 [7319] #10 [7462] 2014-10-13 17:08:57 [] [Stage V] [MULTI] Waiting for all forked verification subreducer threads to finish/terminate 2014-10-13 17:09:00 [] [Stage V] [MULTI] Finished/Terminated verification subreducer threads: #1 #2 #3 #4 #5 #6 #7 #8 #9 #10 2014-10-13 17:09:00 [] [Stage V] [MULTI] All verification subreducer threads have finished/terminated 2014-10-13 17:09:00 [*] [Stage V] [MULTI] Threads which reproduced the issue: #1 #2 #3 #4 #5 #6 #7 #8 #9 #10 2014-10-13 17:09:00 [*] [Stage V] [MULTI] All threads reproduced the issue: this issue is not sporadic You can find 10 vardirs/cores etc. as subdirs in /dev/shm/1413180519/subreducer/ !
[12 Oct 2014 20:36]
Roel Van de Paar
$ ./bin/perror 47 OS error code 47: Level 3 reset
[12 Oct 2014 20:38]
Roel Van de Paar
reducer1075ms.sh
Attachment: reducer1075ms.sh (application/octet-stream, text), 143.09 KiB.
[12 Oct 2014 20:40]
Roel Van de Paar
The SQL trace
Attachment: pquery_thread-0.sql_out_out_out_out (application/octet-stream, text), 3.02 KiB.
[12 Oct 2014 20:41]
Roel Van de Paar
Before starting reducer script, modify these; MYBASE="/sda/mysql-5.6.20-linux-x86_64-debug" INPUTFILE="/sda/814189/1075/pquery_thread-0.sql_out_out_out_out"
[14 Oct 2014 0:27]
Roel Van de Paar
Another testcase
Attachment: bug_74343.tar.gz (application/gzip, text), 32.75 KiB.
[14 Oct 2014 0:29]
Roel Van de Paar
In the last attachment, you can find another testcase, similarly reduced to about 50 lines (i.e. it is shorter) by my colleague, but please note this second reducer.sh script is not modified to stop with clear message/have the variables on top etc. So, maybe you can use first reducer script submitted above with the second testcase in the tar file. Not sure if this will work or not. In any case, the first testcase be sufficient, if not, you can use this secondary one to play with and/or you could use this second SQL trace with the first reducer script (change sql inputfile option) to have a shorter-still testcase.
[15 Oct 2014 0:47]
Roel Van de Paar
Related to bug 74363?
[3 Nov 2014 4:04]
Roel Van de Paar
Umesh, any updates here?
[14 Nov 2014 3:36]
Ramesh Sivaraman
*** testcase (Reproducible with debug build) DROP DATABASE test;CREATE DATABASE test;USE test; CREATE TABLE t(a CHAR (1)) ENGINE=InnoDB; set global innodb_undo_logs=-1; set global innodb_trx_rseg_n_slots_debug=1; drop table if exists t,tp,t1_will_crash; INSERT INTO t VALUES(1); INSERT INTO t VALUES(1); *** GDB info #0 0x00007f1f4b3b3771 in pthread_kill () from /lib64/libpthread.so.0 #1 0x0000000000a9035e in my_write_core (sig=6) at /ssd/ramesh/mysql-server/mysql-5.6/mysys/stacktrace.c:422 #2 0x0000000000723688 in handle_fatal_signal (sig=6) at /ssd/ramesh/mysql-server/mysql-5.6/sql/signal_handler.cc:230 #3 <signal handler called> #4 0x00007f1f4a1bf5c9 in raise () from /lib64/libc.so.6 #5 0x00007f1f4a1c0cd8 in abort () from /lib64/libc.so.6 #6 0x0000000000d91704 in fseg_inode_get (header=0x7f1ecac0c054 "", space=6, zip_size=0, mtr=0x7f1ea7ff75f0) at /ssd/ramesh/mysql-server/mysql-5.6/storage/innobase/fsp/fsp0fsp.cc:1887 #7 0x0000000000d92355 in fseg_n_reserved_pages (header=0x7f1ecac0c054 "", used=0x7f1ea7ff7590, mtr=0x7f1ea7ff75f0) at /ssd/ramesh/mysql-server/mysql-5.6/storage/innobase/fsp/fsp0fsp.cc:2216 #8 0x0000000000ce5e60 in btr_get_size (index=0x7f1eaec6cff8, flag=2, mtr=0x7f1ea7ff75f0) at /ssd/ramesh/mysql-server/mysql-5.6/storage/innobase/btr/btr0btr.cc:1219 #9 0x0000000000d70429 in dict_stats_analyze_index (index=0x7f1eaec6cff8) at /ssd/ramesh/mysql-server/mysql-5.6/storage/innobase/dict/dict0stats.cc:1910 #10 0x0000000000d70ebd in dict_stats_update_persistent (table=0x7f1eaec81378) at /ssd/ramesh/mysql-server/mysql-5.6/storage/innobase/dict/dict0stats.cc:2209 #11 0x0000000000d72a63 in dict_stats_update (table=0x7f1eaec81378, stats_upd_option=DICT_STATS_RECALC_PERSISTENT) at /ssd/ramesh/mysql-server/mysql-5.6/storage/innobase/dict/dict0stats.cc:3127 #12 0x0000000000d769cb in dict_stats_process_entry_from_recalc_pool () at /ssd/ramesh/mysql-server/mysql-5.6/storage/innobase/dict/dict0stats_bg.cc:313 #13 0x0000000000d76aaa in dict_stats_thread (arg=0x0) at /ssd/ramesh/mysql-server/mysql-5.6/storage/innobase/dict/dict0stats_bg.cc:355 #14 0x00007f1f4b3aedf3 in start_thread () from /lib64/libpthread.so.0 #15 0x00007f1f4a28001d in clone () from /lib64/libc.so.6
[22 Nov 2014 10:16]
MySQL Verification Team
Thank you Roel, Ramesh for the report and test case. Observed this behavior with 5.6.23 debug build. Thanks, Umesh
[22 Nov 2014 10:17]
MySQL Verification Team
// 5.6.23 debug build
scripts/mysql_install_db --basedir=/data/ushastry/server/mysql-advanced-5.6.23 --datadir=/tmp/bug --user=mysql
bin/mysqld-debug --basedir=/data/ushastry/server/mysql-advanced-5.6.23 --datadir=/tmp/bug --core --socket=/tmp/mysql.sock --port=3306 --log-error=/tmp/bug/log.err --user=mysql --maximum-bulk_insert_buffer_size=1M --maximum-join_buffer_size=1M --maximum-max_heap_table_size=1M --maximum-max_join_size=1M --maximum-myisam_max_sort_file_size=1M --maximum-myisam_mmap_size=1M --maximum-myisam_sort_buffer_size=1M --maximum-optimizer_trace_max_mem_size=1M --maximum-preload_buffer_size=1M --maximum-query_alloc_block_size=1M --maximum-query_prealloc_size=1M --maximum-range_alloc_block_size=1M --maximum-read_buffer_size=1M --maximum-read_rnd_buffer_size=1M --maximum-sort_buffer_size=1M --maximum-tmp_table_size=1M --maximum-transaction_alloc_block_size=1M --maximum-transaction_prealloc_size=1M --log-output=none --sql_mode=ONLY_FULL_GROUP_BY --log_bin 2>&1 &
[root@cluster-repo mysql-advanced-5.6.23]# more docs/INFO_SRC
revision-id: michael.izioumtchenko@oracle.com-20141106152508-nntohvuco3v1rjjx
date: 2014-11-06 16:25:08 +0100
build-date: 2014-11-06 18:00:43 +0100
revno: 6243
branch-nick: daily-5.6
MySQL source 5.6.23
(gdb) bt
#0 __pthread_kill (threadid=<value optimized out>, signo=<value optimized out>) at ../nptl/sysdeps/unix/sysv/linux/pthread_kill.c:63
#1 0x0000000000affdab in my_write_core (sig=6) at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/mysys/stacktrace.c:422
#2 0x000000000077ebbc in handle_fatal_signal (sig=6) at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/signal_handler.cc:230
#3 <signal handler called>
#4 0x0000003deac32625 in raise (sig=6) at ../nptl/sysdeps/unix/sysv/linux/raise.c:64
#5 0x0000003deac33e05 in abort () at abort.c:92
#6 0x0000000000de144d in fseg_inode_get (header=0x7f60f61c8054 "", space=17, zip_size=0, mtr=0x7f60efe22530)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/storage/innobase/fsp/fsp0fsp.cc:1887
#7 0x0000000000de20f1 in fseg_n_reserved_pages (header=0x7f60f61c8054 "", used=0x7f60efe224e0, mtr=0x7f60efe22530)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/storage/innobase/fsp/fsp0fsp.cc:2216
#8 0x0000000000d33c29 in btr_get_size (index=0x7f60cc01ded8, flag=2, mtr=0x7f60efe22530)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/storage/innobase/btr/btr0btr.cc:1219
#9 0x0000000000dbfa7b in dict_stats_analyze_index (index=0x7f60cc01ded8) at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/storage/innobase/dict/dict0stats.cc:1910
#10 0x0000000000dc04dd in dict_stats_update_persistent (table=0x7f60cc01cd28) at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/storage/innobase/dict/dict0stats.cc:2209
#11 0x0000000000dc20b1 in dict_stats_update (table=0x7f60cc01cd28, stats_upd_option=DICT_STATS_RECALC_PERSISTENT)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/storage/innobase/dict/dict0stats.cc:3127
#12 0x0000000000dc2396 in dict_stats_update (table=0x7f60cc01cd28, stats_upd_option=DICT_STATS_FETCH_ONLY_IF_NOT_IN_MEMORY)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/storage/innobase/dict/dict0stats.cc:3248
#13 0x0000000000b92a40 in dict_stats_init (table=0x7f60cc01cd28) at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/storage/innobase/include/dict0stats.ic:174
#14 0x0000000000b980be in ha_innobase::open (this=0x7f60cc01a0a0, name=0x7f60cc00f968 "./test/t", mode=2, test_if_locked=2)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/storage/innobase/handler/ha_innodb.cc:4892
#15 0x000000000068f1d3 in handler::ha_open (this=0x7f60cc01a0a0, table_arg=0x7f60cc01c180, name=0x7f60cc00f968 "./test/t", mode=2, test_if_locked=2)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/handler.cc:2505
#16 0x00000000008f0cfa in open_table_from_share (thd=0x35389d0, share=0x7f60cc00f640, alias=0x7f60cc0050a8 "t", db_stat=39, prgflag=44, ha_open_flags=0, outparam=0x7f60cc01c180,
is_create_table=false) at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/table.cc:2344
#17 0x00000000007c0a7b in open_table (thd=0x35389d0, table_list=0x7f60cc0050b0, ot_ctx=0x7f60efe23b90)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/sql_base.cc:3159
#18 0x00000000007c3128 in open_and_process_table (thd=0x35389d0, lex=0x353ab40, tables=0x7f60cc0050b0, counter=0x353abf0, flags=0, prelocking_strategy=0x7f60efe23cc0,
has_prelocking_list=false, ot_ctx=0x7f60efe23b90) at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/sql_base.cc:4648
#19 0x00000000007c3e36 in open_tables (thd=0x35389d0, start=0x7f60efe23c80, counter=0x353abf0, flags=0, prelocking_strategy=0x7f60efe23cc0)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/sql_base.cc:5088
#20 0x00000000007c4ff1 in open_normal_and_derived_tables (thd=0x35389d0, tables=0x7f60cc0050b0, flags=0)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/sql_base.cc:5775
#21 0x000000000080c349 in mysql_insert (thd=0x35389d0, table_list=0x7f60cc0050b0, fields=..., values_list=..., update_fields=..., update_values=..., duplic=DUP_ERROR, ignore=false)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/sql_insert.cc:737
#22 0x000000000082fd39 in mysql_execute_command (thd=0x35389d0) at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/sql_parse.cc:3443
#23 0x0000000000837fa9 in mysql_parse (thd=0x35389d0, rawbuf=0x7f60cc004fd0 "INSERT INTO t VALUES(1)", length=23, parser_state=0x7f60efe25680)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/sql_parse.cc:6357
#24 0x000000000082a92b in dispatch_command (command=COM_QUERY, thd=0x35389d0, packet=0x3615071 "INSERT INTO t VALUES(1)", packet_length=23)
at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/sql_parse.cc:1332
#25 0x0000000000829990 in do_command (thd=0x35389d0) at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/sql_parse.cc:1034
#26 0x00000000007f0d8f in do_handle_one_connection (thd_arg=0x35389d0) at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/sql_connect.cc:982
#27 0x00000000007f0860 in handle_one_connection (arg=0x35389d0) at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/sql/sql_connect.cc:898
#28 0x0000000000e5f509 in pfs_spawn_thread (arg=0x35a80f0) at /export/home/pb2/build/sb_0-13622626-1415294505.52/mysqlcom-pro-5.6.23/storage/perfschema/pfs.cc:1860
#29 0x0000003deb0079d1 in start_thread (arg=0x7f60efe26700) at pthread_create.c:301
#30 0x0000003deace89dd in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:115
[25 Jan 2015 21:00]
Roel Van de Paar
5.7 Also affected DROP DATABASE test;CREATE DATABASE test;USE test; CREATE TABLE t1(i INT,d1 DECIMAL(0,0),d2 DECIMAL(0,0)); CREATE TABLE t2(id int,constraint FOREIGN KEY (id)REFERENCES FOO(id) ON DELETE CASCADE) ENGINE=innodb; CREATE TABLE t2(c1 BLOB); EXPLAIN SELECT * FROM t1,t2; CREATE TABLE t4(c1 CHAR); set global innodb_trx_rseg_n_slots_debug=1; DROP TABLE t1; SELECT * FROM t1; drop table _foo,_bar,t1; insert INTO t1 values(0,0,0); DROP TABLE t1; insert INTO t1(txt)values (),(); DROP TABLE t1; SELECT hex(c1),hex(c2) FROM t1; (gdb) bt #0 0x00007ff9d9716771 in pthread_kill () from /lib64/libpthread.so.0 #1 0x0000000000e15d58 in my_write_core (sig=6) at /bzr/mysql-5.7-percona-patches_dbg/mysys/stacktrace.c:247 #2 0x0000000000822044 in handle_fatal_signal (sig=6) at /bzr/mysql-5.7-percona-patches_dbg/sql/signal_handler.cc:219 #3 <signal handler called> #4 0x00007ff9d831a5c9 in raise () from /lib64/libc.so.6 #5 0x00007ff9d831bcd8 in abort () from /lib64/libc.so.6 #6 0x00000000010d4ccf in ut_dbg_assertion_failed (expr=0x151d29e "inode", file=0x151c780 "/bzr/mysql-5.7-percona-patches_dbg/storage/innobase/fsp/fsp0fsp.cc",line=2023) at /bzr/mysql-5.7-percona-patches_dbg/storage/innobase/ut/ut0dbg.cc:68 #7 0x00000000011b9b51 in fseg_inode_get (header=0x7ff92c038054 "", space=39, page_size=..., mtr=0x7ff9d9d0a390) at /bzr/mysql-5.7-percona-patches_dbg/storage/innobase/fsp/fsp0fsp.cc:2023 #8 0x00000000011ba80f in fseg_n_reserved_pages (header=0x7ff92c038054 "", used=0x7ff9d9d0a320, mtr=0x7ff9d9d0a390) at /bzr/mysql-5.7-percona-patches_dbg/storage/innobase/fsp/fsp0fsp.cc:2364 #9 0x00000000010e98d4 in btr_get_size (index=0x7ff91dcaec98, flag=2, mtr=0x7ff9d9d0a390) at /bzr/mysql-5.7-percona-patches_dbg/storage/innobase/btr/btr0btr.cc:566 #10 0x0000000001195110 in dict_stats_analyze_index (index=0x7ff91dcaec98) at /bzr/mysql-5.7-percona-patches_dbg/storage/innobase/dict/dict0stats.cc:1904 #11 0x0000000001195ad0 in dict_stats_update_persistent (table=0x7ff91dc94118) at /bzr/mysql-5.7-percona-patches_dbg/storage/innobase/dict/dict0stats.cc:2205 #12 0x0000000001197a13 in dict_stats_update (table=0x7ff91dc94118, stats_upd_option=DICT_STATS_RECALC_PERSISTENT) at /bzr/mysql-5.7-percona-patches_dbg/storage/innobase/dict/dict0stats.cc:3119 #13 0x0000000001197dac in dict_stats_update (table=0x7ff91dc94118, stats_upd_option=DICT_STATS_FETCH_ONLY_IF_NOT_IN_MEMORY) at /bzr/mysql-5.7-percona-patches_dbg/storage/innobase/dict/dict0stats.cc:3237 #14 0x0000000000f084ae in dict_stats_init (table=0x7ff91dc94118) at /bzr/mysql-5.7-percona-patches_dbg/storage/innobase/include/dict0stats.ic:173 #15 0x0000000000f0e859 in ha_innobase::open (this=0x7ff91dcb0820, name=0x7ff91dcabf90 "./test/t1", mode=2, test_if_locked=2) at /bzr/mysql-5.7-percona-patches_dbg/storage/innobase/handler/ha_innodb.cc:5098 #16 0x0000000000880baf in handler::ha_open (this=0x7ff91dcb0820, table_arg=0x7ff91dc6bc10, name=0x7ff91dcabf90 "./test/t1", mode=2, test_if_locked=2) at /bzr/mysql-5.7-percona-patches_dbg/sql/handler.cc:2471 #17 0x0000000000c179e0 in open_table_from_share (thd=0x7ff91dc1c000, share=0x7ff91dcabc20, alias=0x7ff91dc285e8 "t1", db_stat=39, prgflag=44, ha_open_flags=0, outparam=0x7ff91dc6bc10, is_create_table=false) at /bzr/mysql-5.7-percona-patches_dbg/sql/table.cc:2378 #18 0x0000000000acafb7 in open_table (thd=0x7ff91dc1c000, table_list=0x7ff91dc285f0, ot_ctx=0x7ff9d9d0ca40) at /bzr/mysql-5.7-percona-patches_dbg/sql/sql_base.cc:3417 #19 0x0000000000acd770 in open_and_process_table (thd=0x7ff91dc1c000, lex=0x7ff91dc1e370, tables=0x7ff91dc285f0, counter=0x7ff91dc1e420, flags=0, prelocking_strategy=0x7ff9d9d0cb40, has_prelocking_list=false, ot_ctx=0x7ff9d9d0ca40) at /bzr/mysql-5.7-percona-patches_dbg/sql/sql_base.cc:4903 #20 0x0000000000ace4fe in open_tables (thd=0x7ff91dc1c000, start=0x7ff9d9d0cb00, counter=0x7ff91dc1e420, flags=0, prelocking_strategy=0x7ff9d9d0cb40) at /bzr/mysql-5.7-percona-patches_dbg/sql/sql_base.cc:5357 #21 0x0000000000acf745 in open_normal_and_derived_tables (thd=0x7ff91dc1c000, tables=0x7ff91dc285f0, flags=0) at /bzr/mysql-5.7-percona-patches_dbg/sql/sql_base.cc:6085 #22 0x0000000000b4ecca in execute_sqlcom_select (thd=0x7ff91dc1c000, all_tables=0x7ff91dc285f0) at /bzr/mysql-5.7-percona-patches_dbg/sql/sql_parse.cc:5004 #23 0x0000000000b47775 in mysql_execute_command (thd=0x7ff91dc1c000) at /bzr/mysql-5.7-percona-patches_dbg/sql/sql_parse.cc:2488 #24 0x0000000000b4fcc1 in mysql_parse (thd=0x7ff91dc1c000, parser_state=0x7ff9d9d0de60) at /bzr/mysql-5.7-percona-patches_dbg/sql/sql_parse.cc:5427 #25 0x0000000000b44814 in dispatch_command (command=COM_QUERY, thd=0x7ff91dc1c000, packet=0x7ff91dc33011 "SELECT hex(c1),hex(c2) FROM t1", packet_length=30) at/bzr/mysql-5.7-percona-patches_dbg/sql/sql_parse.cc:1250 #26 0x0000000000b4354d in do_command (thd=0x7ff91dc1c000) at /bzr/mysql-5.7-percona-patches_dbg/sql/sql_parse.cc:834 #27 0x0000000000c4d49e in handle_connection (arg=0x7ff9d782cee0) at /bzr/mysql-5.7-percona-patches_dbg/sql/conn_handler/connection_handler_per_thread.cc:298 #28 0x0000000000e39538 in pfs_spawn_thread (arg=0x7ff9bc7caa50) at /bzr/mysql-5.7-percona-patches_dbg/storage/perfschema/pfs.cc:2137 #29 0x00007ff9d9711df3 in start_thread () from /lib64/libpthread.so.0 #30 0x00007ff9d83db1ad in clone () from /lib64/libc.so.6
[14 Feb 2015 7:21]
Roel Van de Paar
The testcase from bug 74876 can trigger this bug also
