sbester1 added a comment - 2013-03-21 17:31 Testcase was insert/delete/update/select on 20 tables containing long varchar columns, indexes, in 5 threads. Nothing really special to note.

Elena Stepanova added a comment - 2013-03-21 21:12 Adding to the collection of sporadically reproducible Aria issues. The closest I could find by a quick search seems to be MDEV-654 , but I'm not sure the stress test suggested there still works, it's been a while. I'll re-run it later, also with valgrind, to see if it triggers the same error. Or maybe Monty will fix it by the stack trace alone, it happens. In any case it will have to wait a while.

Elena Stepanova added a comment - 2015-08-21 20:22 - edited The following stress test causes either a server crash in make_lock_and_pin, or a deadlock. Stack traces are below. test.zz $tables = { rows => [0, 1, 10, 20, 50, 100], partitions => [ undef ], engines => [ 'Aria' ], pk => [ undef, 'int auto_increment' ] };   $fields = { types => [ 'int', 'char', 'enum', 'set', 'blob', 'float', 'decimal' ], indexes => [ undef, 'key' ], null => [undef, 'not null'], default => [undef, 'default null' ], sign => [undef, 'unsigned' ], charsets => ['utf8', 'latin1' ] };   $data = { numbers => [ 'digit', 'null', undef ], strings => [ 'letter', 'english', 'null' ], blobs => [ 'english', 'data' ] } test.yy query: INSERT INTO _table ( _field ) VALUES ( NULL ) | DELETE FROM _table LIMIT 1 | UPDATE _table SET _field = NULL ; Test command line perl ./runall-new.pl --threads=16 --duration=300 --queries=100M --grammar=test.yy --gendata=test.zz --mysqld=--aria-checkpoint-interval=5 --basedir1=<your basedir> --vardir1=<your vardir> I recommend using lp:~elenst/randgen/mariadb-patches , it has some bugfixes that makes test runs more efficient. If the problem does not happen right away, you can use runall-trials.pl script like Multiple run command line perl ./runall-trials.pl --trials=15 --threads=16 --duration=300 --queries=100M --grammar=test.yy --gendata=test.zz --mysqld=--aria-checkpoint-interval=5 --basedir1=<your basedir> --vardir1=<your vardir> It will do the same, but 15 times (or until it crashes or hangs). The crash looks like one would expect, tests fail with ./runall-new.pl will exit with exit status STATUS_SERVER_CRASHED . If the deadlock happens, the test never ends, it keeps hanging long long after test duration (5 min in the command line above). Stack trace on server crash, 5.5 commit fa51f70dc68fe2f3afe943e2c81fcbdb34f16cad #3 <signal handler called> #4 0x00000000009af7ef in make_lock_and_pin (pagecache=0x1d52360 <maria_pagecache_var>, block=0x7f3bc642aa40, lock=PAGECACHE_LOCK_READ, pin=PAGECACHE_PIN, any=0 '\000') at 5.5/storage/maria/ma_pagecache.c:2587 #5 0x00000000009b3cc1 in flush_cached_blocks (pagecache=0x1d52360 <maria_pagecache_var>, file=0x7f3bc5d48260, cache=0x7f3bd77fb128, end=0x7f3bd77fb520, type=FLUSH_KEEP_LAZY, first_errno=0x7f3bd77fae54) at 5.5/storage/maria/ma_pagecache.c:4378 #6 0x00000000009b4805 in flush_pagecache_blocks_int (pagecache=0x1d52360 <maria_pagecache_var>, file=0x7f3bc5d48260, type=FLUSH_KEEP_LAZY, filter=0x9b669c <filter_flush_file_evenly>, filter_arg=0x7f3bd77fee50) at 5.5/storage/maria/ma_pagecache.c:4689 #7 0x00000000009b4bf9 in flush_pagecache_blocks_with_filter (pagecache=0x1d52360 <maria_pagecache_var>, file=0x7f3bc5d48260, type=FLUSH_KEEP_LAZY, filter=0x9b669c <filter_flush_file_evenly>, filter_arg=0x7f3bd77fee50) at 5.5/storage/maria/ma_pagecache.c:4805 #8 0x00000000009b692f in ma_checkpoint_background (arg=0x5) at 5.5/storage/maria/ma_checkpoint.c:666 #9 0x00007f3bd8c90e9a in start_thread () from /lib/x86_64-linux-gnu/libpthread.so.0 #10 0x00007f3bd83bdcbd in clone () from /lib/x86_64-linux-gnu/libc.so.6 All threads' stack trace is attached as crash_stack_trace.txt. Stack trace of some threads on deadlock, 5.5 commit fa51f70dc68fe2f3afe943e2c81fcbdb34f16cad Thread 20 (Thread 0x7fbbdbbff700 (LWP 4538)): #0 pthread_cond_wait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:162 #1 0x0000000000cf2f14 in safe_cond_wait (cond=0x1d810a8, mp=0x1d81000, file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", line=7674) at 5.5/mysys/thr_mutex.c:493 #2 0x0000000000b95d8d in inline_mysql_cond_wait (that=0x1d810a8, mutex=0x1d81000, src_file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", src_line=7674) at 5.5/include/mysql/psi/mysql_thread.h:984 #3 0x0000000000baa44a in translog_flush_wait_for_end (lsn=4749359931) at 5.5/storage/maria/ma_loghandler.c:7673 #4 0x0000000000baaf54 in translog_flush (lsn=4749359931) at 5.5/storage/maria/ma_loghandler.c:7959 #5 0x0000000000bff417 in flush_log_for_bitmap (page=0x7fbbdc890060 "m\213\002", page_no=0, data_ptr=0x7fbbe7cbe060 "\376\376\t\003\f\002\020\230") at 5.5/storage/maria/ma_bitmap.c:2901 #6 0x0000000000bae163 in pagecache_fwrite (pagecache=0x1d89a40, filedesc=0x7fbbdbeb2218, buffer=0x7fbbdc890060 "m\213\002", pageno=0, type=PAGECACHE_PLAIN_PAGE, flags=36) at 5.5/storage/maria/ma_pagecache.c:652 #7 0x0000000000bb8029 in flush_cached_blocks (pagecache=0x1d89a40, file=0x7fbbe7cbeb10, cache=0x7fbbdbbfab50, end=0x7fbbdbbfab58, type=FLUSH_KEEP, first_errno=0x7fbbdbbfab2c) at 5.5/storage/maria/ma_pagecache.c:4400 #8 0x0000000000bb88aa in flush_pagecache_blocks_int (pagecache=0x1d89a40, file=0x7fbbe7cbeb10, type=FLUSH_KEEP, filter=0xbfa805 <filter_flush_bitmap_pages>, filter_arg=0x7fbbe7cbec50) at 5.5/storage/maria/ma_pagecache.c:4689 #9 0x0000000000bb8c48 in flush_pagecache_blocks_with_filter (pagecache=0x1d89a40, file=0x7fbbe7cbeb10, type=FLUSH_KEEP, filter=0xbfa805 <filter_flush_bitmap_pages>, filter_arg=0x7fbbe7cbec50) at 5.5/storage/maria/ma_pagecache.c:4805 #10 0x0000000000bfaa31 in _ma_bitmap_flush_all (share=0x7fbbe7cbe060) at 5.5/storage/maria/ma_bitmap.c:532 #11 0x0000000000bbb581 in collect_tables (str=0x7fbbdbbfed80, checkpoint_start_log_horizon=4725149125) at 5.5/storage/maria/ma_checkpoint.c:1081 #12 0x0000000000bb9e58 in really_execute_checkpoint () at 5.5/storage/maria/ma_checkpoint.c:198 #13 0x0000000000bb9c6f in ma_checkpoint_execute (level=CHECKPOINT_MEDIUM, no_wait=1 '\001') at 5.5/storage/maria/ma_checkpoint.c:132 #14 0x0000000000bba814 in ma_checkpoint_background (arg=0x5) at 5.5/storage/maria/ma_checkpoint.c:619 #15 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #16 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #17 0x0000000000000000 in ?? ()   Thread 17 (Thread 0x7fbc04d56700 (LWP 4552)): #0 pthread_cond_wait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:162 #1 0x0000000000cf2f14 in safe_cond_wait (cond=0x1780410, mp=0x1780460, file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", line=2018) at 5.5/mysys/thr_mutex.c:493 #2 0x0000000000b95d8d in inline_mysql_cond_wait (that=0x1780410, mutex=0x1780460, src_file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", src_line=2018) at 5.5/include/mysql/psi/mysql_thread.h:984 #3 0x0000000000b9b446 in translog_wait_for_writers (buffer=0x16803d0) at 5.5/storage/maria/ma_loghandler.c:2018 #4 0x0000000000b9cff8 in translog_buffer_flush (buffer=0x16803d0) at 5.5/storage/maria/ma_loghandler.c:2600 #5 0x0000000000baacf2 in translog_flush_buffers (lsn=0x7fbc04d54b78, sent_to_disk=0x7fbc04d54ba8, flush_horizon=0x7fbc04d54ba0) at 5.5/storage/maria/ma_loghandler.c:7868 #6 0x0000000000bab085 in translog_flush (lsn=4748082049) at 5.5/storage/maria/ma_loghandler.c:7987 #7 0x0000000000bc49cc in ma_commit (trn=0x7fbbda00e960) at 5.5/storage/maria/ma_commit.c:65 #8 0x0000000000b8fba8 in ha_maria::implicit_commit (thd=0x7fbbe9916060, new_trn=false) at 5.5/storage/maria/ha_maria.cc:2877 #9 0x000000000063c45d in mysql_execute_command (thd=0x7fbbe9916060) at 5.5/sql/sql_parse.cc:4578 #10 0x000000000063f485 in mysql_parse (thd=0x7fbbe9916060, rawbuf=0x7fbbda024078 "INSERT INTO `table1_aria_int_autoinc` ( `col_decimal_unsigned_key` ) VALUES ( NULL )", length=84, parser_state=0x7fbc04d55670) at 5.5/sql/sql_parse.cc:5911 #11 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9916060, packet=0x7fbbe993c061 "INSERT INTO `table1_aria_int_autoinc` ( `col_decimal_unsigned_key` ) VALUES ( NULL )", packet_length=84) at 5.5/sql/sql_parse.cc:1079 #12 0x0000000000632249 in do_command (thd=0x7fbbe9916060) at 5.5/sql/sql_parse.cc:793 #13 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9916060) at 5.5/sql/sql_connect.cc:1269 #14 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9916060) at 5.5/sql/sql_connect.cc:1185 #15 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #16 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #17 0x0000000000000000 in ?? ()   Thread 16 (Thread 0x7fbc04d0d700 (LWP 4554)): #0 pthread_cond_wait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:162 #1 0x0000000000cf2f14 in safe_cond_wait (cond=0x1d810a8, mp=0x1d81000, file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", line=7674) at 5.5/mysys/thr_mutex.c:493 #2 0x0000000000b95d8d in inline_mysql_cond_wait (that=0x1d810a8, mutex=0x1d81000, src_file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", src_line=7674) at 5.5/include/mysql/psi/mysql_thread.h:984 #3 0x0000000000baa44a in translog_flush_wait_for_end (lsn=4748243983) at 5.5/storage/maria/ma_loghandler.c:7673 #4 0x0000000000baaf54 in translog_flush (lsn=4748243983) at 5.5/storage/maria/ma_loghandler.c:7959 #5 0x0000000000bc49cc in ma_commit (trn=0x7fbbe643c360) at 5.5/storage/maria/ma_commit.c:65 #6 0x0000000000b8fba8 in ha_maria::implicit_commit (thd=0x7fbbe9941060, new_trn=false) at 5.5/storage/maria/ha_maria.cc:2877 #7 0x000000000063c45d in mysql_execute_command (thd=0x7fbbe9941060) at 5.5/sql/sql_parse.cc:4578 #8 0x000000000063f485 in mysql_parse (thd=0x7fbbe9941060, rawbuf=0x7fbbd6824078 "INSERT INTO `table10_aria_int_autoinc` ( `col_decimal_key_default_null` ) VALUES ( NULL )", length=89, parser_state=0x7fbc04d0c670) at 5.5/sql/sql_parse.cc:5911 #9 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9941060, packet=0x7fbbe994e061 "INSERT INTO `table10_aria_int_autoinc` ( `col_decimal_key_default_null` ) VALUES ( NULL )", packet_length=89) at 5.5/sql/sql_parse.cc:1079 #10 0x0000000000632249 in do_command (thd=0x7fbbe9941060) at 5.5/sql/sql_parse.cc:793 #11 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9941060) at 5.5/sql/sql_connect.cc:1269 #12 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9941060) at 5.5/sql/sql_connect.cc:1185 #13 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #14 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #15 0x0000000000000000 in ?? ()   Thread 15 (Thread 0x7fbc04cc4700 (LWP 4556)): #0 pthread_cond_timedwait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:216 #1 0x0000000000cf31e4 in safe_cond_timedwait (cond=0x7fbc02020288, mp=0x7fbbda11f758, abstime=0x7fbc04cc2700, file=0xef8590 "5.5/mysys/thr_lock.c", line=569) at 5.5/mysys/thr_mutex.c:547 #2 0x0000000000cefc7e in inline_mysql_cond_timedwait (that=0x7fbc02020288, mutex=0x7fbbda11f758, abstime=0x7fbc04cc2700, src_file=0xef8590 "5.5/mysys/thr_lock.c", src_line=569) at 5.5/include/mysql/psi/mysql_thread.h:1017 #3 0x0000000000cf0281 in wait_for_lock (wait=0x7fbbda11f820, data=0x7fbbd69566f8, in_wait_list=0 '\000', lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:569 #4 0x0000000000cf0a9e in thr_lock (data=0x7fbbd69566f8, owner=0x7fbbe99546f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:893 #5 0x0000000000cf1349 in thr_multi_lock (data=0x7fbbf8b66b40, count=1, owner=0x7fbbe99546f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:1169 #6 0x00000000008bff5e in mysql_lock_tables (thd=0x7fbbe9953060, sql_lock=0x7fbbf8b66b20, flags=0) at 5.5/sql/lock.cc:321 #7 0x00000000008bfdba in mysql_lock_tables (thd=0x7fbbe9953060, tables=0x7fbbe997ba00, count=1, flags=0) at 5.5/sql/lock.cc:276 #8 0x00000000005dd6bf in lock_tables (thd=0x7fbbe9953060, tables=0x7fbbe997b220, count=1, flags=0) at 5.5/sql/sql_base.cc:5947 #9 0x00000000006e8567 in mysql_update (thd=0x7fbbe9953060, table_list=0x7fbbe997b220, fields=..., values=..., conds=0x0, order_num=0, order=0x0, limit=18446744073709551615, handle_duplicates=DUP_ERROR, ignore=false, found_return=0x7fbc04cc32d8, updated_return=0x7fbc04cc32d0) at 5.5/sql/sql_update.cc:296 #10 0x0000000000637278 in mysql_execute_command (thd=0x7fbbe9953060) at 5.5/sql/sql_parse.cc:2849 #11 0x000000000063f485 in mysql_parse (thd=0x7fbbe9953060, rawbuf=0x7fbbe997b078 "UPDATE `table100_aria_int_autoinc` SET `col_decimal_key` = NULL", length=63, parser_state=0x7fbc04cc3670) at 5.5/sql/sql_parse.cc:5911 #12 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9953060, packet=0x7fbbe9958061 "UPDATE `table100_aria_int_autoinc` SET `col_decimal_key` = NULL", packet_length=63) at 5.5/sql/sql_parse.cc:1079 #13 0x0000000000632249 in do_command (thd=0x7fbbe9953060) at 5.5/sql/sql_parse.cc:793 #14 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9953060) at 5.5/sql/sql_connect.cc:1269 #15 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9953060) at 5.5/sql/sql_connect.cc:1185 #16 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #17 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #18 0x0000000000000000 in ?? ()   Thread 14 (Thread 0x7fbc04c7b700 (LWP 4558)): #0 pthread_cond_timedwait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:216 #1 0x0000000000cf31e4 in safe_cond_timedwait (cond=0x7fbbe7c3c188, mp=0x7fbbda11f758, abstime=0x7fbc04c79790, file=0xef8590 "5.5/mysys/thr_lock.c", line=569) at 5.5/mysys/thr_mutex.c:547 #2 0x0000000000cefc7e in inline_mysql_cond_timedwait (that=0x7fbbe7c3c188, mutex=0x7fbbda11f758, abstime=0x7fbc04c79790, src_file=0xef8590 "5.5/mysys/thr_lock.c", src_line=569) at 5.5/include/mysql/psi/mysql_thread.h:1017 #3 0x0000000000cf0281 in wait_for_lock (wait=0x7fbbda11f820, data=0x7fbbd987d6f8, in_wait_list=0 '\000', lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:569 #4 0x0000000000cf0a9e in thr_lock (data=0x7fbbd987d6f8, owner=0x7fbbe9a6c6f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:893 #5 0x0000000000cf1349 in thr_multi_lock (data=0x7fbbe7c45400, count=1, owner=0x7fbbe9a6c6f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:1169 #6 0x00000000008bff5e in mysql_lock_tables (thd=0x7fbbe9a6b060, sql_lock=0x7fbbe7c453e0, flags=0) at 5.5/sql/lock.cc:321 #7 0x00000000008bfdba in mysql_lock_tables (thd=0x7fbbe9a6b060, tables=0x7fbbe7c52a98, count=1, flags=0) at 5.5/sql/lock.cc:276 #8 0x00000000005dd6bf in lock_tables (thd=0x7fbbe9a6b060, tables=0x7fbbe7c52260, count=1, flags=0) at 5.5/sql/sql_base.cc:5947 #9 0x00000000005dce7f in open_and_lock_tables (thd=0x7fbbe9a6b060, tables=0x7fbbe7c52260, derived=true, flags=0, prelocking_strategy=0x7fbc04c79a90) at 5.5/sql/sql_base.cc:5719 #10 0x00000000005d0299 in open_and_lock_tables (thd=0x7fbbe9a6b060, tables=0x7fbbe7c52260, derived=true, flags=0) at 5.5/sql/sql_base.h:524 #11 0x00000000006187c5 in mysql_insert (thd=0x7fbbe9a6b060, table_list=0x7fbbe7c52260, fields=..., values_list=..., update_fields=..., update_values=..., duplic=DUP_ERROR, ignore=false) at 5.5/sql/sql_insert.cc:761 #12 0x00000000006376dd in mysql_execute_command (thd=0x7fbbe9a6b060) at 5.5/sql/sql_parse.cc:2974 #13 0x000000000063f485 in mysql_parse (thd=0x7fbbe9a6b060, rawbuf=0x7fbbe7c52078 "INSERT INTO `table100_aria_int_autoinc` ( `col_set_latin1_key_default_null` ) VALUES ( NULL )", length=93, parser_state=0x7fbc04c7a670) at 5.5/sql/sql_parse.cc:5911 #14 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9a6b060, packet=0x7fbbe9a70061 "INSERT INTO `table100_aria_int_autoinc` ( `col_set_latin1_key_default_null` ) VALUES ( NULL )", packet_length=93) at 5.5/sql/sql_parse.cc:1079 #15 0x0000000000632249 in do_command (thd=0x7fbbe9a6b060) at 5.5/sql/sql_parse.cc:793 #16 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9a6b060) at 5.5/sql/sql_connect.cc:1269 #17 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9a6b060) at 5.5/sql/sql_connect.cc:1185 #18 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #19 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #20 0x0000000000000000 in ?? ()   Thread 13 (Thread 0x7fbc02bb2700 (LWP 4560)): #0 pthread_cond_wait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:162 #1 0x0000000000cf2f14 in safe_cond_wait (cond=0x1680290, mp=0x16802e0, file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", line=2018) at 5.5/mysys/thr_mutex.c:493 #2 0x0000000000b95d8d in inline_mysql_cond_wait (that=0x1680290, mutex=0x16802e0, src_file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", src_line=2018) at 5.5/include/mysql/psi/mysql_thread.h:984 #3 0x0000000000b9b446 in translog_wait_for_writers (buffer=0x1580250) at 5.5/storage/maria/ma_loghandler.c:2018 #4 0x0000000000b9cff8 in translog_buffer_flush (buffer=0x1580250) at 5.5/storage/maria/ma_loghandler.c:2600 #5 0x0000000000ba20d7 in translog_chaser_page_next (horizon=0x7fbc02baf920, cursor=0x7fbc02baf900) at 5.5/storage/maria/ma_loghandler.c:4609 #6 0x0000000000ba2147 in translog_write_variable_record_chunk2_page (parts=0x7fbc02bafad0, horizon=0x7fbc02baf920, cursor=0x7fbc02baf900) at 5.5/storage/maria/ma_loghandler.c:4638 #7 0x0000000000ba338a in translog_write_variable_record_1group (lsn=0x7fbc02baffb8, type=LOGREC_REDO_INSERT_ROW_BLOBS, tbl_info=0x7fbbda1ae060, short_trid=23032, parts=0x7fbc02bafad0, buffer_to_flush=0x0, header_length=8, trn=0x7fbbd690a360, hook_arg=0x0) at 5.5/storage/maria/ma_loghandler.c:5081 #8 0x0000000000ba5b5c in translog_write_variable_record (lsn=0x7fbc02baffb8, type=LOGREC_REDO_INSERT_ROW_BLOBS, tbl_info=0x7fbbda1ae060, short_trid=23032, parts=0x7fbc02bafad0, trn=0x7fbbd690a360, hook_arg=0x0) at 5.5/storage/maria/ma_loghandler.c:6055 #9 0x0000000000ba68c5 in translog_write_record (lsn=0x7fbc02baffb8, type=LOGREC_REDO_INSERT_ROW_BLOBS, trn=0x7fbbd690a360, tbl_info=0x7fbbda1ae060, rec_len=65457, part_no=4, parts_data=0x7fbc02bafd00, store_share_id=0x7fbc02bafb90 "-", hook_arg=0x0) at 5.5/storage/maria/ma_loghandler.c:6353 #10 0x0000000000bee7dc in write_block_record (info=0x7fbbda1ae060, old_record=0x7fbbda0828b0 "e\320\001\n^", <incomplete sequence \375>, record=0x7fbbda082778 "m\320\001\n^", <incomplete sequence \375>, row=0x7fbbda1ae178, bitmap_blocks=0x7fbbda1ae0b8, head_block_is_read=1 '\001', row_pos=0x7fbc02bb0250, undo_lsn=1, old_record_checksum=0) at 5.5/storage/maria/ma_blockrec.c:3275 #11 0x0000000000befd19 in _ma_update_block_record2 (info=0x7fbbda1ae060, record_pos=241154, oldrec=0x7fbbda0828b0 "e\320\001\n^", <incomplete sequence \375>, record=0x7fbbda082778 "m\320\001\n^", <incomplete sequence \375>, undo_lsn=1) at 5.5/storage/maria/ma_blockrec.c:3819 #12 0x0000000000bf0416 in _ma_update_block_record (info=0x7fbbda1ae060, record_pos=241154, orig_rec=0x7fbbda0828b0 "e\320\001\n^", <incomplete sequence \375>, new_rec=0x7fbbda082778 "m\320\001\n^", <incomplete sequence \375>) at 5.5/storage/maria/ma_blockrec.c:3983 #13 0x0000000000c001ca in maria_update (info=0x7fbbda1ae060, oldrec=0x7fbbda0828b0 "e\320\001\n^", <incomplete sequence \375>, newrec=0x7fbbda082778 "m\320\001\n^", <incomplete sequence \375>) at 5.5/storage/maria/ma_update.c:161 #14 0x0000000000b8e3c0 in ha_maria::update_row (this=0x7fbbd800c878, old_data=0x7fbbda0828b0 "e\320\001\n^", <incomplete sequence \375>, new_data=0x7fbbda082778 "m\320\001\n^", <incomplete sequence \375>) at 5.5/storage/maria/ha_maria.cc:2285 #15 0x00000000007f3db1 in handler::ha_update_row (this=0x7fbbd800c878, old_data=0x7fbbda0828b0 "e\320\001\n^", <incomplete sequence \375>, new_data=0x7fbbda082778 "m\320\001\n^", <incomplete sequence \375>) at 5.5/sql/handler.cc:5232 #16 0x00000000006e9b8d in mysql_update (thd=0x7fbbe9a75060, table_list=0x7fbbe6452230, fields=..., values=..., conds=0x0, order_num=0, order=0x0, limit=18446744073709551539, handle_duplicates=DUP_ERROR, ignore=false, found_return=0x7fbc02bb12d8, updated_return=0x7fbc02bb12d0) at 5.5/sql/sql_update.cc:764 #17 0x0000000000637278 in mysql_execute_command (thd=0x7fbbe9a75060) at 5.5/sql/sql_parse.cc:2849 #18 0x000000000063f485 in mysql_parse (thd=0x7fbbe9a75060, rawbuf=0x7fbbe6452078 "UPDATE `table100_aria_int_autoinc` SET `col_int_default_null` = NULL", length=68, parser_state=0x7fbc02bb1670) at 5.5/sql/sql_parse.cc:5911 #19 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9a75060, packet=0x7fbbe9a7a061 "UPDATE `table100_aria_int_autoinc` SET `col_int_default_null` = NULL", packet_length=68) at 5.5/sql/sql_parse.cc:1079 #20 0x0000000000632249 in do_command (thd=0x7fbbe9a75060) at 5.5/sql/sql_parse.cc:793 #21 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9a75060) at 5.5/sql/sql_connect.cc:1269 #22 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9a75060) at 5.5/sql/sql_connect.cc:1185 #23 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #24 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #25 0x0000000000000000 in ?? ()   Thread 12 (Thread 0x7fbc02b69700 (LWP 4562)): #0 pthread_cond_timedwait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:216 #1 0x0000000000cf31e4 in safe_cond_timedwait (cond=0x7fbbe603c188, mp=0x7fbbda26b758, abstime=0x7fbc02b67700, file=0xef8590 "5.5/mysys/thr_lock.c", line=569) at 5.5/mysys/thr_mutex.c:547 #2 0x0000000000cefc7e in inline_mysql_cond_timedwait (that=0x7fbbe603c188, mutex=0x7fbbda26b758, abstime=0x7fbc02b67700, src_file=0xef8590 "5.5/mysys/thr_lock.c", src_line=569) at 5.5/include/mysql/psi/mysql_thread.h:1017 #3 0x0000000000cf0281 in wait_for_lock (wait=0x7fbbda26b820, data=0x7fbbd9ccf6f8, in_wait_list=0 '\000', lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:569 #4 0x0000000000cf0a9e in thr_lock (data=0x7fbbd9ccf6f8, owner=0x7fbbe9a806f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:893 #5 0x0000000000cf1349 in thr_multi_lock (data=0x7fbbe6044aa0, count=1, owner=0x7fbbe9a806f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:1169 #6 0x00000000008bff5e in mysql_lock_tables (thd=0x7fbbe9a7f060, sql_lock=0x7fbbe6044a80, flags=0) at 5.5/sql/lock.cc:321 #7 0x00000000008bfdba in mysql_lock_tables (thd=0x7fbbe9a7f060, tables=0x7fbbe6052a28, count=1, flags=0) at 5.5/sql/lock.cc:276 #8 0x00000000005dd6bf in lock_tables (thd=0x7fbbe9a7f060, tables=0x7fbbe6052230, count=1, flags=0) at 5.5/sql/sql_base.cc:5947 #9 0x00000000006e8567 in mysql_update (thd=0x7fbbe9a7f060, table_list=0x7fbbe6052230, fields=..., values=..., conds=0x0, order_num=0, order=0x0, limit=18446744073709551615, handle_duplicates=DUP_ERROR, ignore=false, found_return=0x7fbc02b682d8, updated_return=0x7fbc02b682d0) at 5.5/sql/sql_update.cc:296 #10 0x0000000000637278 in mysql_execute_command (thd=0x7fbbe9a7f060) at 5.5/sql/sql_parse.cc:2849 #11 0x000000000063f485 in mysql_parse (thd=0x7fbbe9a7f060, rawbuf=0x7fbbe6052078 "UPDATE `table50_aria_int_autoinc` SET `col_blob_not_null_key` = NULL", length=68, parser_state=0x7fbc02b68670) at 5.5/sql/sql_parse.cc:5911 #12 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9a7f060, packet=0x7fbbe9a59061 "UPDATE `table50_aria_int_autoinc` SET `col_blob_not_null_key` = NULL", packet_length=68) at 5.5/sql/sql_parse.cc:1079 #13 0x0000000000632249 in do_command (thd=0x7fbbe9a7f060) at 5.5/sql/sql_parse.cc:793 #14 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9a7f060) at 5.5/sql/sql_connect.cc:1269 #15 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9a7f060) at 5.5/sql/sql_connect.cc:1185 #16 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #17 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #18 0x0000000000000000 in ?? ()   Thread 11 (Thread 0x7fbc02b20700 (LWP 4564)): #0 pthread_cond_wait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:162 #1 0x0000000000cf2f14 in safe_cond_wait (cond=0x1880590, mp=0x18805e0, file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", line=2018) at 5.5/mysys/thr_mutex.c:493 #2 0x0000000000b95d8d in inline_mysql_cond_wait (that=0x1880590, mutex=0x18805e0, src_file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", src_line=2018) at 5.5/include/mysql/psi/mysql_thread.h:984 #3 0x0000000000b9b446 in translog_wait_for_writers (buffer=0x1780550) at 5.5/storage/maria/ma_loghandler.c:2018 #4 0x0000000000b9cff8 in translog_buffer_flush (buffer=0x1780550) at 5.5/storage/maria/ma_loghandler.c:2600 #5 0x0000000000ba20d7 in translog_chaser_page_next (horizon=0x7fbc02b1d920, cursor=0x7fbc02b1d900) at 5.5/storage/maria/ma_loghandler.c:4609 #6 0x0000000000ba2147 in translog_write_variable_record_chunk2_page (parts=0x7fbc02b1dad0, horizon=0x7fbc02b1d920, cursor=0x7fbc02b1d900) at 5.5/storage/maria/ma_loghandler.c:4638 #7 0x0000000000ba338a in translog_write_variable_record_1group (lsn=0x7fbc02b1dfb8, type=LOGREC_REDO_INSERT_ROW_BLOBS, tbl_info=0x7fbbe5c9e060, short_trid=35496, parts=0x7fbc02b1dad0, buffer_to_flush=0x0, header_length=9, trn=0x7fbbd98314e0, hook_arg=0x0) at 5.5/storage/maria/ma_loghandler.c:5081 #8 0x0000000000ba5b5c in translog_write_variable_record (lsn=0x7fbc02b1dfb8, type=LOGREC_REDO_INSERT_ROW_BLOBS, tbl_info=0x7fbbe5c9e060, short_trid=35496, parts=0x7fbc02b1dad0, trn=0x7fbbd98314e0, hook_arg=0x0) at 5.5/storage/maria/ma_loghandler.c:6055 #9 0x0000000000ba68c5 in translog_write_record (lsn=0x7fbc02b1dfb8, type=LOGREC_REDO_INSERT_ROW_BLOBS, trn=0x7fbbd98314e0, tbl_info=0x7fbbe5c9e060, rec_len=81579, part_no=5, parts_data=0x7fbc02b1dd00, store_share_id=0x7fbc02b1db90 "H", hook_arg=0x0) at 5.5/storage/maria/ma_loghandler.c:6353 #10 0x0000000000bee7dc in write_block_record (info=0x7fbbe5c9e060, old_record=0x7fbbe5c5d8b0 "\241\361\267R\251", <incomplete sequence \372>, record=0x7fbbe5c5d778 "\261\361\267R\251", <incomplete sequence \372>, row=0x7fbbe5c9e178, bitmap_blocks=0x7fbbe5c9e0b8, head_block_is_read=1 '\001', row_pos=0x7fbc02b1e250, undo_lsn=1, old_record_checksum=0) at 5.5/storage/maria/ma_blockrec.c:3275 #11 0x0000000000befd19 in _ma_update_block_record2 (info=0x7fbbe5c9e060, record_pos=54536, oldrec=0x7fbbe5c5d8b0 "\241\361\267R\251", <incomplete sequence \372>, record=0x7fbbe5c5d778 "\261\361\267R\251", <incomplete sequence \372>, undo_lsn=1) at 5.5/storage/maria/ma_blockrec.c:3819 #12 0x0000000000bf0416 in _ma_update_block_record (info=0x7fbbe5c9e060, record_pos=54536, orig_rec=0x7fbbe5c5d8b0 "\241\361\267R\251", <incomplete sequence \372>, new_rec=0x7fbbe5c5d778 "\261\361\267R\251", <incomplete sequence \372>) at 5.5/storage/maria/ma_blockrec.c:3983 #13 0x0000000000c001ca in maria_update (info=0x7fbbe5c9e060, oldrec=0x7fbbe5c5d8b0 "\241\361\267R\251", <incomplete sequence \372>, newrec=0x7fbbe5c5d778 "\261\361\267R\251", <incomplete sequence \372>) at 5.5/storage/maria/ma_update.c:161 #14 0x0000000000b8e3c0 in ha_maria::update_row (this=0x7fbbe5cf0878, old_data=0x7fbbe5c5d8b0 "\241\361\267R\251", <incomplete sequence \372>, new_data=0x7fbbe5c5d778 "\261\361\267R\251", <incomplete sequence \372>) at 5.5/storage/maria/ha_maria.cc:2285 #15 0x00000000007f3db1 in handler::ha_update_row (this=0x7fbbe5cf0878, old_data=0x7fbbe5c5d8b0 "\241\361\267R\251", <incomplete sequence \372>, new_data=0x7fbbe5c5d778 "\261\361\267R\251", <incomplete sequence \372>) at 5.5/sql/handler.cc:5232 #16 0x00000000006e9b8d in mysql_update (thd=0x7fbbe9a5e060, table_list=0x7fbbe5c52220, fields=..., values=..., conds=0x0, order_num=0, order=0x0, limit=18446744073709551601, handle_duplicates=DUP_ERROR, ignore=false, found_return=0x7fbc02b1f2d8, updated_return=0x7fbc02b1f2d0) at 5.5/sql/sql_update.cc:764 #17 0x0000000000637278 in mysql_execute_command (thd=0x7fbbe9a5e060) at 5.5/sql/sql_parse.cc:2849 #18 0x000000000063f485 in mysql_parse (thd=0x7fbbe9a5e060, rawbuf=0x7fbbe5c52078 "UPDATE `table50_aria_int_autoinc` SET `col_int_key` = NULL", length=58, parser_state=0x7fbc02b1f670) at 5.5/sql/sql_parse.cc:5911 #19 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9a5e060, packet=0x7fbbe9a63061 "UPDATE `table50_aria_int_autoinc` SET `col_int_key` = NULL", packet_length=58) at 5.5/sql/sql_parse.cc:1079 #20 0x0000000000632249 in do_command (thd=0x7fbbe9a5e060) at 5.5/sql/sql_parse.cc:793 #21 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9a5e060) at 5.5/sql/sql_connect.cc:1269 #22 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9a5e060) at 5.5/sql/sql_connect.cc:1185 #23 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #24 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #25 0x0000000000000000 in ?? ()   Thread 10 (Thread 0x7fbc02ad7700 (LWP 4566)): #0 pthread_cond_wait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:162 #1 0x0000000000cf2f14 in safe_cond_wait (cond=0x1d80e18, mp=0x1d80d60, file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", line=2559) at 5.5/mysys/thr_mutex.c:493 #2 0x0000000000b95d8d in inline_mysql_cond_wait (that=0x1d80e18, mutex=0x1d80d60, src_file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", src_line=2559) at 5.5/include/mysql/psi/mysql_thread.h:984 #3 0x0000000000b9ce15 in translog_prev_buffer_flush_wait (buffer=0x1c80cd0) at 5.5/storage/maria/ma_loghandler.c:2559 #4 0x0000000000b9d0c8 in translog_buffer_flush (buffer=0x1c80cd0) at 5.5/storage/maria/ma_loghandler.c:2613 #5 0x0000000000ba20d7 in translog_chaser_page_next (horizon=0x7fbc02ad4920, cursor=0x7fbc02ad4900) at 5.5/storage/maria/ma_loghandler.c:4609 #6 0x0000000000ba2147 in translog_write_variable_record_chunk2_page (parts=0x7fbc02ad4ad0, horizon=0x7fbc02ad4920, cursor=0x7fbc02ad4900) at 5.5/storage/maria/ma_loghandler.c:4638 #7 0x0000000000ba338a in translog_write_variable_record_1group (lsn=0x7fbc02ad4fb8, type=LOGREC_REDO_INSERT_ROW_BLOBS, tbl_info=0x7fbbda21a060, short_trid=45106, parts=0x7fbc02ad4ad0, buffer_to_flush=0x0, header_length=9, trn=0x7fbbd680eae0, hook_arg=0x0) at 5.5/storage/maria/ma_loghandler.c:5081 #8 0x0000000000ba5b5c in translog_write_variable_record (lsn=0x7fbc02ad4fb8, type=LOGREC_REDO_INSERT_ROW_BLOBS, tbl_info=0x7fbbda21a060, short_trid=45106, parts=0x7fbc02ad4ad0, trn=0x7fbbd680eae0, hook_arg=0x0) at 5.5/storage/maria/ma_loghandler.c:6055 #9 0x0000000000ba68c5 in translog_write_record (lsn=0x7fbc02ad4fb8, type=LOGREC_REDO_INSERT_ROW_BLOBS, trn=0x7fbbd680eae0, tbl_info=0x7fbbda21a060, rec_len=196359, part_no=6, parts_data=0x7fbc02ad4d00, store_share_id=0x7fbc02ad4b90 ";", hook_arg=0x0) at 5.5/storage/maria/ma_loghandler.c:6353 #10 0x0000000000bee7dc in write_block_record (info=0x7fbbda21a060, old_record=0x7fbbda080ab0 "IО&\242", <incomplete sequence \360>, record=0x7fbbda080978 "IԞ&\242", <incomplete sequence \360>, row=0x7fbbda21a178, bitmap_blocks=0x7fbbda21a0b8, head_block_is_read=1 '\001', row_pos=0x7fbc02ad5250, undo_lsn=1, old_record_checksum=0) at 5.5/storage/maria/ma_blockrec.c:3275 #11 0x0000000000befd19 in _ma_update_block_record2 (info=0x7fbbda21a060, record_pos=115459, oldrec=0x7fbbda080ab0 "IО&\242", <incomplete sequence \360>, record=0x7fbbda080978 "IԞ&\242", <incomplete sequence \360>, undo_lsn=1) at 5.5/storage/maria/ma_blockrec.c:3819 #12 0x0000000000bf0416 in _ma_update_block_record (info=0x7fbbda21a060, record_pos=115459, orig_rec=0x7fbbda080ab0 "IО&\242", <incomplete sequence \360>, new_rec=0x7fbbda080978 "IԞ&\242", <incomplete sequence \360>) at 5.5/storage/maria/ma_blockrec.c:3983 #13 0x0000000000c001ca in maria_update (info=0x7fbbda21a060, oldrec=0x7fbbda080ab0 "IО&\242", <incomplete sequence \360>, newrec=0x7fbbda080978 "IԞ&\242", <incomplete sequence \360>) at 5.5/storage/maria/ma_update.c:161 #14 0x0000000000b8e3c0 in ha_maria::update_row (this=0x7fbbd800b878, old_data=0x7fbbda080ab0 "IО&\242", <incomplete sequence \360>, new_data=0x7fbbda080978 "IԞ&\242", <incomplete sequence \360>) at 5.5/storage/maria/ha_maria.cc:2285 #15 0x00000000007f3db1 in handler::ha_update_row (this=0x7fbbd800b878, old_data=0x7fbbda080ab0 "IО&\242", <incomplete sequence \360>, new_data=0x7fbbda080978 "IԞ&\242", <incomplete sequence \360>) at 5.5/sql/handler.cc:5232 #16 0x00000000006e9b8d in mysql_update (thd=0x7fbbe97f5060, table_list=0x7fbbe44521c8, fields=..., values=..., conds=0x0, order_num=0, order=0x0, limit=18446744073709551588, handle_duplicates=DUP_ERROR, ignore=false, found_return=0x7fbc02ad62d8, updated_return=0x7fbc02ad62d0) at 5.5/sql/sql_update.cc:764 #17 0x0000000000637278 in mysql_execute_command (thd=0x7fbbe97f5060) at 5.5/sql/sql_parse.cc:2849 #18 0x000000000063f485 in mysql_parse (thd=0x7fbbe97f5060, rawbuf=0x7fbbe4452078 "UPDATE `table100_aria` SET `col_enum_latin1` = NULL", length=51, parser_state=0x7fbc02ad6670) at 5.5/sql/sql_parse.cc:5911 #19 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe97f5060, packet=0x7fbbe97fa061 "UPDATE `table100_aria` SET `col_enum_latin1` = NULL", packet_length=51) at 5.5/sql/sql_parse.cc:1079 #20 0x0000000000632249 in do_command (thd=0x7fbbe97f5060) at 5.5/sql/sql_parse.cc:793 #21 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe97f5060) at 5.5/sql/sql_connect.cc:1269 #22 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe97f5060) at 5.5/sql/sql_connect.cc:1185 #23 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #24 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #25 0x0000000000000000 in ?? ()   Thread 9 (Thread 0x7fbc02a8e700 (LWP 4568)): #0 pthread_cond_timedwait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:216 #1 0x0000000000cf31e4 in safe_cond_timedwait (cond=0x7fbbe403c188, mp=0x7fbbdacf6758, abstime=0x7fbc02a8c790, file=0xef8590 "5.5/mysys/thr_lock.c", line=569) at 5.5/mysys/thr_mutex.c:547 #2 0x0000000000cefc7e in inline_mysql_cond_timedwait (that=0x7fbbe403c188, mutex=0x7fbbdacf6758, abstime=0x7fbc02a8c790, src_file=0xef8590 "5.5/mysys/thr_lock.c", src_line=569) at 5.5/include/mysql/psi/mysql_thread.h:1017 #3 0x0000000000cf0281 in wait_for_lock (wait=0x7fbbdacf6820, data=0x7fbbdacbd6f8, in_wait_list=0 '\000', lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:569 #4 0x0000000000cf0a9e in thr_lock (data=0x7fbbdacbd6f8, owner=0x7fbbeebf26f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:893 #5 0x0000000000cf1349 in thr_multi_lock (data=0x7fbbe4044820, count=1, owner=0x7fbbeebf26f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:1169 #6 0x00000000008bff5e in mysql_lock_tables (thd=0x7fbbeebf1060, sql_lock=0x7fbbe4044800, flags=0) at 5.5/sql/lock.cc:321 #7 0x00000000008bfdba in mysql_lock_tables (thd=0x7fbbeebf1060, tables=0x7fbbe4052a50, count=1, flags=0) at 5.5/sql/lock.cc:276 #8 0x00000000005dd6bf in lock_tables (thd=0x7fbbeebf1060, tables=0x7fbbe4052208, count=1, flags=0) at 5.5/sql/sql_base.cc:5947 #9 0x00000000005dce7f in open_and_lock_tables (thd=0x7fbbeebf1060, tables=0x7fbbe4052208, derived=true, flags=0, prelocking_strategy=0x7fbc02a8ca90) at 5.5/sql/sql_base.cc:5719 #10 0x00000000005d0299 in open_and_lock_tables (thd=0x7fbbeebf1060, tables=0x7fbbe4052208, derived=true, flags=0) at 5.5/sql/sql_base.h:524 #11 0x00000000006187c5 in mysql_insert (thd=0x7fbbeebf1060, table_list=0x7fbbe4052208, fields=..., values_list=..., update_fields=..., update_values=..., duplic=DUP_ERROR, ignore=false) at 5.5/sql/sql_insert.cc:761 #12 0x00000000006376dd in mysql_execute_command (thd=0x7fbbeebf1060) at 5.5/sql/sql_parse.cc:2974 #13 0x000000000063f485 in mysql_parse (thd=0x7fbbeebf1060, rawbuf=0x7fbbe4052078 "INSERT INTO `table20_aria` ( `col_decimal_unsigned_not_null_key` ) VALUES ( NULL )", length=82, parser_state=0x7fbc02a8d670) at 5.5/sql/sql_parse.cc:5911 #14 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbeebf1060, packet=0x7fbbeebf6061 "INSERT INTO `table20_aria` ( `col_decimal_unsigned_not_null_key` ) VALUES ( NULL )", packet_length=82) at 5.5/sql/sql_parse.cc:1079 #15 0x0000000000632249 in do_command (thd=0x7fbbeebf1060) at 5.5/sql/sql_parse.cc:793 #16 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbeebf1060) at 5.5/sql/sql_connect.cc:1269 #17 0x00000000007350e7 in handle_one_connection (arg=0x7fbbeebf1060) at 5.5/sql/sql_connect.cc:1185 #18 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #19 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #20 0x0000000000000000 in ?? ()   Thread 8 (Thread 0x7fbc02a45700 (LWP 4570)): #0 pthread_cond_timedwait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:216 #1 0x0000000000cf31e4 in safe_cond_timedwait (cond=0x7fbbdac4e188, mp=0x7fbbd685a758, abstime=0x7fbc02a43250, file=0xef8590 "5.5/mysys/thr_lock.c", line=569) at 5.5/mysys/thr_mutex.c:547 #2 0x0000000000cefc7e in inline_mysql_cond_timedwait (that=0x7fbbdac4e188, mutex=0x7fbbd685a758, abstime=0x7fbc02a43250, src_file=0xef8590 "5.5/mysys/thr_lock.c", src_line=569) at 5.5/include/mysql/psi/mysql_thread.h:1017 #3 0x0000000000cf0281 in wait_for_lock (wait=0x7fbbd685a820, data=0x7fbbd69e96f8, in_wait_list=0 '\000', lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:569 #4 0x0000000000cf0a9e in thr_lock (data=0x7fbbd69e96f8, owner=0x7fbbeebfc6f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:893 #5 0x0000000000cf1349 in thr_multi_lock (data=0x7fbbdac568c0, count=1, owner=0x7fbbeebfc6f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:1169 #6 0x00000000008bff5e in mysql_lock_tables (thd=0x7fbbeebfb060, sql_lock=0x7fbbdac568a0, flags=0) at 5.5/sql/lock.cc:321 #7 0x00000000008bfdba in mysql_lock_tables (thd=0x7fbbeebfb060, tables=0x7fbbdac64820, count=1, flags=0) at 5.5/sql/lock.cc:276 #8 0x00000000005dd6bf in lock_tables (thd=0x7fbbeebfb060, tables=0x7fbbdac641a8, count=1, flags=0) at 5.5/sql/sql_base.cc:5947 #9 0x00000000005dce7f in open_and_lock_tables (thd=0x7fbbeebfb060, tables=0x7fbbdac641a8, derived=true, flags=0, prelocking_strategy=0x7fbc02a43550) at 5.5/sql/sql_base.cc:5719 #10 0x00000000005d0299 in open_and_lock_tables (thd=0x7fbbeebfb060, tables=0x7fbbdac641a8, derived=true, flags=0) at 5.5/sql/sql_base.h:524 #11 0x00000000009332ca in mysql_delete (thd=0x7fbbeebfb060, table_list=0x7fbbdac641a8, conds=0x0, order_list=0x7fbbeebfeca0, limit=1, options=0) at 5.5/sql/sql_delete.cc:71 #12 0x0000000000637d30 in mysql_execute_command (thd=0x7fbbeebfb060) at 5.5/sql/sql_parse.cc:3105 #13 0x000000000063f485 in mysql_parse (thd=0x7fbbeebfb060, rawbuf=0x7fbbdac64078 "DELETE FROM `table50_aria` LIMIT 1", length=34, parser_state=0x7fbc02a44670) at 5.5/sql/sql_parse.cc:5911 #14 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbeebfb060, packet=0x7fbbe9b09061 "DELETE FROM `table50_aria` LIMIT 1", packet_length=34) at 5.5/sql/sql_parse.cc:1079 #15 0x0000000000632249 in do_command (thd=0x7fbbeebfb060) at 5.5/sql/sql_parse.cc:793 #16 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbeebfb060) at 5.5/sql/sql_connect.cc:1269 #17 0x00000000007350e7 in handle_one_connection (arg=0x7fbbeebfb060) at 5.5/sql/sql_connect.cc:1185 #18 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #19 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #20 0x0000000000000000 in ?? ()   Thread 7 (Thread 0x7fbc029fc700 (LWP 4572)): #0 pthread_cond_timedwait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:216 #1 0x0000000000cf31e4 in safe_cond_timedwait (cond=0x7fbbd9831188, mp=0x7fbbda26b758, abstime=0x7fbc029fa250, file=0xef8590 "5.5/mysys/thr_lock.c", line=569) at 5.5/mysys/thr_mutex.c:547 #2 0x0000000000cefc7e in inline_mysql_cond_timedwait (that=0x7fbbd9831188, mutex=0x7fbbda26b758, abstime=0x7fbc029fa250, src_file=0xef8590 "5.5/mysys/thr_lock.c", src_line=569) at 5.5/include/mysql/psi/mysql_thread.h:1017 #3 0x0000000000cf0281 in wait_for_lock (wait=0x7fbbda26b820, data=0x7fbbe5cbc6f8, in_wait_list=0 '\000', lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:569 #4 0x0000000000cf0a9e in thr_lock (data=0x7fbbe5cbc6f8, owner=0x7fbbe9b0f6f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:893 #5 0x0000000000cf1349 in thr_multi_lock (data=0x7fbbd98398c0, count=1, owner=0x7fbbe9b0f6f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:1169 #6 0x00000000008bff5e in mysql_lock_tables (thd=0x7fbbe9b0e060, sql_lock=0x7fbbd98398a0, flags=0) at 5.5/sql/lock.cc:321 #7 0x00000000008bfdba in mysql_lock_tables (thd=0x7fbbe9b0e060, tables=0x7fbbd9847878, count=1, flags=0) at 5.5/sql/lock.cc:276 #8 0x00000000005dd6bf in lock_tables (thd=0x7fbbe9b0e060, tables=0x7fbbd9847200, count=1, flags=0) at 5.5/sql/sql_base.cc:5947 #9 0x00000000005dce7f in open_and_lock_tables (thd=0x7fbbe9b0e060, tables=0x7fbbd9847200, derived=true, flags=0, prelocking_strategy=0x7fbc029fa550) at 5.5/sql/sql_base.cc:5719 #10 0x00000000005d0299 in open_and_lock_tables (thd=0x7fbbe9b0e060, tables=0x7fbbd9847200, derived=true, flags=0) at 5.5/sql/sql_base.h:524 #11 0x00000000009332ca in mysql_delete (thd=0x7fbbe9b0e060, table_list=0x7fbbd9847200, conds=0x0, order_list=0x7fbbe9b11ca0, limit=1, options=0) at 5.5/sql/sql_delete.cc:71 #12 0x0000000000637d30 in mysql_execute_command (thd=0x7fbbe9b0e060) at 5.5/sql/sql_parse.cc:3105 #13 0x000000000063f485 in mysql_parse (thd=0x7fbbe9b0e060, rawbuf=0x7fbbd9847078 "DELETE FROM `table50_aria_int_autoinc` LIMIT 1", length=46, parser_state=0x7fbc029fb670) at 5.5/sql/sql_parse.cc:5911 #14 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9b0e060, packet=0x7fbbe9b13061 "DELETE FROM `table50_aria_int_autoinc` LIMIT 1", packet_length=46) at 5.5/sql/sql_parse.cc:1079 #15 0x0000000000632249 in do_command (thd=0x7fbbe9b0e060) at 5.5/sql/sql_parse.cc:793 #16 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9b0e060) at 5.5/sql/sql_connect.cc:1269 #17 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9b0e060) at 5.5/sql/sql_connect.cc:1185 #18 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #19 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #20 0x0000000000000000 in ?? ()   Thread 6 (Thread 0x7fbc029b3700 (LWP 4574)): #0 pthread_cond_wait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:162 #1 0x0000000000cf2f14 in safe_cond_wait (cond=0x1780410, mp=0x1780460, file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", line=2018) at 5.5/mysys/thr_mutex.c:493 #2 0x0000000000b95d8d in inline_mysql_cond_wait (that=0x1780410, mutex=0x1780460, src_file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", src_line=2018) at 5.5/include/mysql/psi/mysql_thread.h:984 #3 0x0000000000b9b446 in translog_wait_for_writers (buffer=0x16803d0) at 5.5/storage/maria/ma_loghandler.c:2018 #4 0x0000000000b9cff8 in translog_buffer_flush (buffer=0x16803d0) at 5.5/storage/maria/ma_loghandler.c:2600 #5 0x0000000000baacf2 in translog_flush_buffers (lsn=0x7fbc029b1b78, sent_to_disk=0x7fbc029b1ba8, flush_horizon=0x7fbc029b1ba0) at 5.5/storage/maria/ma_loghandler.c:7868 #6 0x0000000000bab085 in translog_flush (lsn=4748081021) at 5.5/storage/maria/ma_loghandler.c:7987 #7 0x0000000000bc49cc in ma_commit (trn=0x7fbbd680e4e0) at 5.5/storage/maria/ma_commit.c:65 #8 0x0000000000b8fba8 in ha_maria::implicit_commit (thd=0x7fbbe9b18060, new_trn=false) at 5.5/storage/maria/ha_maria.cc:2877 #9 0x000000000063c45d in mysql_execute_command (thd=0x7fbbe9b18060) at 5.5/sql/sql_parse.cc:4578 #10 0x000000000063f485 in mysql_parse (thd=0x7fbbe9b18060, rawbuf=0x7fbbd9c68078 "UPDATE `table0_aria` SET `col_enum_utf8_not_null` = NULL", length=56, parser_state=0x7fbc029b2670) at 5.5/sql/sql_parse.cc:5911 #11 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9b18060, packet=0x7fbbe9b1d061 "UPDATE `table0_aria` SET `col_enum_utf8_not_null` = NULL", packet_length=56) at 5.5/sql/sql_parse.cc:1079 #12 0x0000000000632249 in do_command (thd=0x7fbbe9b18060) at 5.5/sql/sql_parse.cc:793 #13 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9b18060) at 5.5/sql/sql_connect.cc:1269 #14 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9b18060) at 5.5/sql/sql_connect.cc:1185 #15 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #16 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #17 0x0000000000000000 in ?? ()   Thread 5 (Thread 0x7fbc0296a700 (LWP 4576)): #0 pthread_cond_wait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:162 #1 0x0000000000cf2f14 in safe_cond_wait (cond=0x1780410, mp=0x1780460, file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", line=2018) at 5.5/mysys/thr_mutex.c:493 #2 0x0000000000b95d8d in inline_mysql_cond_wait (that=0x1780410, mutex=0x1780460, src_file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", src_line=2018) at 5.5/include/mysql/psi/mysql_thread.h:984 #3 0x0000000000b9b446 in translog_wait_for_writers (buffer=0x16803d0) at 5.5/storage/maria/ma_loghandler.c:2018 #4 0x0000000000baa0b6 in translog_force_current_buffer_to_finish () at 5.5/storage/maria/ma_loghandler.c:7597 #5 0x0000000000baa97f in translog_flush_buffers (lsn=0x7fbc02968b78, sent_to_disk=0x7fbc02968ba8, flush_horizon=0x7fbc02968ba0) at 5.5/storage/maria/ma_loghandler.c:7814 #6 0x0000000000bab085 in translog_flush (lsn=4750134688) at 5.5/storage/maria/ma_loghandler.c:7987 #7 0x0000000000bc49cc in ma_commit (trn=0x7fbbd9831960) at 5.5/storage/maria/ma_commit.c:65 #8 0x0000000000b8fba8 in ha_maria::implicit_commit (thd=0x7fbbe9b22060, new_trn=false) at 5.5/storage/maria/ha_maria.cc:2877 #9 0x000000000063c45d in mysql_execute_command (thd=0x7fbbe9b22060) at 5.5/sql/sql_parse.cc:4578 #10 0x000000000063f485 in mysql_parse (thd=0x7fbbe9b22060, rawbuf=0x7fbbda077078 "UPDATE `table20_aria` SET `col_blob` = NULL", length=43, parser_state=0x7fbc02969670) at 5.5/sql/sql_parse.cc:5911 #11 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9b22060, packet=0x7fbbe9b27061 "UPDATE `table20_aria` SET `col_blob` = NULL", packet_length=43) at 5.5/sql/sql_parse.cc:1079 #12 0x0000000000632249 in do_command (thd=0x7fbbe9b22060) at 5.5/sql/sql_parse.cc:793 #13 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9b22060) at 5.5/sql/sql_connect.cc:1269 #14 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9b22060) at 5.5/sql/sql_connect.cc:1185 #15 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #16 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #17 0x0000000000000000 in ?? ()   Thread 4 (Thread 0x7fbc02921700 (LWP 4578)): #0 pthread_cond_wait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:162 #1 0x0000000000cf2f14 in safe_cond_wait (cond=0x1d810a8, mp=0x1d81000, file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", line=7701) at 5.5/mysys/thr_mutex.c:493 #2 0x0000000000b95d8d in inline_mysql_cond_wait (that=0x1d810a8, mutex=0x1d81000, src_file=0xecbac0 "5.5/storage/maria/ma_loghandler.c", src_line=7701) at 5.5/include/mysql/psi/mysql_thread.h:984 #3 0x0000000000baa58a in translog_flush_set_new_goal_and_wait (lsn=4750645053) at 5.5/storage/maria/ma_loghandler.c:7700 #4 0x0000000000baaf27 in translog_flush (lsn=4750645053) at 5.5/storage/maria/ma_loghandler.c:7952 #5 0x0000000000bc49cc in ma_commit (trn=0x7fbbd9c52360) at 5.5/storage/maria/ma_commit.c:65 #6 0x0000000000b8fba8 in ha_maria::implicit_commit (thd=0x7fbbe9b2c060, new_trn=false) at 5.5/storage/maria/ha_maria.cc:2877 #7 0x000000000063c45d in mysql_execute_command (thd=0x7fbbe9b2c060) at 5.5/sql/sql_parse.cc:4578 #8 0x000000000063f485 in mysql_parse (thd=0x7fbbe9b2c060, rawbuf=0x7fbbd6920078 "UPDATE `table50_aria` SET `col_float_key` = NULL", length=48, parser_state=0x7fbc02920670) at 5.5/sql/sql_parse.cc:5911 #9 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9b2c060, packet=0x7fbbe9b37061 "UPDATE `table50_aria` SET `col_float_key` = NULL", packet_length=48) at 5.5/sql/sql_parse.cc:1079 #10 0x0000000000632249 in do_command (thd=0x7fbbe9b2c060) at 5.5/sql/sql_parse.cc:793 #11 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9b2c060) at 5.5/sql/sql_connect.cc:1269 #12 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9b2c060) at 5.5/sql/sql_connect.cc:1185 #13 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #14 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #15 0x0000000000000000 in ?? ()   Thread 3 (Thread 0x7fbc028d8700 (LWP 4580)): #0 pthread_cond_timedwait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:216 #1 0x0000000000cf31e4 in safe_cond_timedwait (cond=0x7fbbe9b32508, mp=0x7fbbda11f758, abstime=0x7fbc028d6250, file=0xef8590 "5.5/mysys/thr_lock.c", line=569) at 5.5/mysys/thr_mutex.c:547 #2 0x0000000000cefc7e in inline_mysql_cond_timedwait (that=0x7fbbe9b32508, mutex=0x7fbbda11f758, abstime=0x7fbc028d6250, src_file=0xef8590 "5.5/mysys/thr_lock.c", src_line=569) at 5.5/include/mysql/psi/mysql_thread.h:1017 #3 0x0000000000cf0281 in wait_for_lock (wait=0x7fbbda11f820, data=0x7fbbda2a96f8, in_wait_list=0 '\000', lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:569 #4 0x0000000000cf0a9e in thr_lock (data=0x7fbbda2a96f8, owner=0x7fbbe9b426f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:893 #5 0x0000000000cf1349 in thr_multi_lock (data=0x7fbbe996e180, count=1, owner=0x7fbbe9b426f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:1169 #6 0x00000000008bff5e in mysql_lock_tables (thd=0x7fbbe9b41060, sql_lock=0x7fbbe996e160, flags=0) at 5.5/sql/lock.cc:321 #7 0x00000000008bfdba in mysql_lock_tables (thd=0x7fbbe9b41060, tables=0x7fbbe9b67878, count=1, flags=0) at 5.5/sql/lock.cc:276 #8 0x00000000005dd6bf in lock_tables (thd=0x7fbbe9b41060, tables=0x7fbbe9b67200, count=1, flags=0) at 5.5/sql/sql_base.cc:5947 #9 0x00000000005dce7f in open_and_lock_tables (thd=0x7fbbe9b41060, tables=0x7fbbe9b67200, derived=true, flags=0, prelocking_strategy=0x7fbc028d6550) at 5.5/sql/sql_base.cc:5719 #10 0x00000000005d0299 in open_and_lock_tables (thd=0x7fbbe9b41060, tables=0x7fbbe9b67200, derived=true, flags=0) at 5.5/sql/sql_base.h:524 #11 0x00000000009332ca in mysql_delete (thd=0x7fbbe9b41060, table_list=0x7fbbe9b67200, conds=0x0, order_list=0x7fbbe9b44ca0, limit=1, options=0) at 5.5/sql/sql_delete.cc:71 #12 0x0000000000637d30 in mysql_execute_command (thd=0x7fbbe9b41060) at 5.5/sql/sql_parse.cc:3105 #13 0x000000000063f485 in mysql_parse (thd=0x7fbbe9b41060, rawbuf=0x7fbbe9b67078 "DELETE FROM `table100_aria_int_autoinc` LIMIT 1", length=47, parser_state=0x7fbc028d7670) at 5.5/sql/sql_parse.cc:5911 #14 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9b41060, packet=0x7fbbe9b46061 "DELETE FROM `table100_aria_int_autoinc` LIMIT 1", packet_length=47) at 5.5/sql/sql_parse.cc:1079 #15 0x0000000000632249 in do_command (thd=0x7fbbe9b41060) at 5.5/sql/sql_parse.cc:793 #16 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9b41060) at 5.5/sql/sql_connect.cc:1269 #17 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9b41060) at 5.5/sql/sql_connect.cc:1185 #18 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #19 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #20 0x0000000000000000 in ?? ()   Thread 2 (Thread 0x7fbc0288f700 (LWP 4582)): #0 pthread_cond_timedwait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:216 #1 0x0000000000cf31e4 in safe_cond_timedwait (cond=0x7fbbe7d5a188, mp=0x7fbbe60bc758, abstime=0x7fbc0288d790, file=0xef8590 "5.5/mysys/thr_lock.c", line=569) at 5.5/mysys/thr_mutex.c:547 #2 0x0000000000cefc7e in inline_mysql_cond_timedwait (that=0x7fbbe7d5a188, mutex=0x7fbbe60bc758, abstime=0x7fbc0288d790, src_file=0xef8590 "5.5/mysys/thr_lock.c", src_line=569) at 5.5/include/mysql/psi/mysql_thread.h:1017 #3 0x0000000000cf0281 in wait_for_lock (wait=0x7fbbe60bc820, data=0x7fbbe40b26f8, in_wait_list=0 '\000', lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:569 #4 0x0000000000cf0a9e in thr_lock (data=0x7fbbe40b26f8, owner=0x7fbbe9bbd6f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:893 #5 0x0000000000cf1349 in thr_multi_lock (data=0x7fbbe7d62280, count=1, owner=0x7fbbe9bbd6f0, lock_wait_timeout=31536000) at 5.5/mysys/thr_lock.c:1169 #6 0x00000000008bff5e in mysql_lock_tables (thd=0x7fbbe9bbc060, sql_lock=0x7fbbe7d62260, flags=0) at 5.5/sql/lock.cc:321 #7 0x00000000008bfdba in mysql_lock_tables (thd=0x7fbbe9bbc060, tables=0x7fbbe7d70a38, count=1, flags=0) at 5.5/sql/lock.cc:276 #8 0x00000000005dd6bf in lock_tables (thd=0x7fbbe9bbc060, tables=0x7fbbe7d70200, count=1, flags=0) at 5.5/sql/sql_base.cc:5947 #9 0x00000000005dce7f in open_and_lock_tables (thd=0x7fbbe9bbc060, tables=0x7fbbe7d70200, derived=true, flags=0, prelocking_strategy=0x7fbc0288da90) at 5.5/sql/sql_base.cc:5719 #10 0x00000000005d0299 in open_and_lock_tables (thd=0x7fbbe9bbc060, tables=0x7fbbe7d70200, derived=true, flags=0) at 5.5/sql/sql_base.h:524 #11 0x00000000006187c5 in mysql_insert (thd=0x7fbbe9bbc060, table_list=0x7fbbe7d70200, fields=..., values_list=..., update_fields=..., update_values=..., duplic=DUP_ERROR, ignore=false) at 5.5/sql/sql_insert.cc:761 #12 0x00000000006376dd in mysql_execute_command (thd=0x7fbbe9bbc060) at 5.5/sql/sql_parse.cc:2974 #13 0x000000000063f485 in mysql_parse (thd=0x7fbbe9bbc060, rawbuf=0x7fbbe7d70078 "INSERT INTO `table100_aria` ( `col_float_unsigned_not_null_key` ) VALUES ( NULL )", length=81, parser_state=0x7fbc0288e670) at 5.5/sql/sql_parse.cc:5911 #14 0x00000000006330bd in dispatch_command (command=COM_QUERY, thd=0x7fbbe9bbc060, packet=0x7fbbe9bc1061 "INSERT INTO `table100_aria` ( `col_float_unsigned_not_null_key` ) VALUES ( NULL )", packet_length=81) at 5.5/sql/sql_parse.cc:1079 #15 0x0000000000632249 in do_command (thd=0x7fbbe9bbc060) at 5.5/sql/sql_parse.cc:793 #16 0x000000000073536d in do_handle_one_connection (thd_arg=0x7fbbe9bbc060) at 5.5/sql/sql_connect.cc:1269 #17 0x00000000007350e7 in handle_one_connection (arg=0x7fbbe9bbc060) at 5.5/sql/sql_connect.cc:1185 #18 0x00007fbc049d8b50 in start_thread (arg=<optimized out>) at pthread_create.c:304 #19 0x00007fbc02c8e95d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112 #20 0x0000000000000000 in ?? () All threads' stack trace is attached as deadlock_stack_trace.txt.

Elena Stepanova added a comment - 2018-02-10 16:43 - edited Still reproducible with the concurrent test above on current 5.5-10.3. 10.1 e07451f71f3b4 #3 <signal handler called> #4 0x00007fb599973b2b in make_lock_and_pin (pagecache=0x7fb59ad83940 <maria_pagecache_var>, block=0x7fb584c26770, lock=PAGECACHE_LOCK_READ, pin=PAGECACHE_PIN, any=0 '\000') at /data/src/10.1/storage/maria/ma_pagecache.c:2599 #5 0x00007fb599977c96 in flush_cached_blocks (pagecache=0x7fb59ad83940 <maria_pagecache_var>, file=0x7fb58344e3d0, cache=0x7fb5843fafa0, end=0x7fb5843fafc8, type=FLUSH_KEEP_LAZY, first_errno=0x7fb5843faea4) at /data/src/10.1/storage/maria/ma_pagecache.c:4409 #6 0x00007fb599978808 in flush_pagecache_blocks_int (pagecache=0x7fb59ad83940 <maria_pagecache_var>, file=0x7fb58344e3d0, type=FLUSH_KEEP_LAZY, filter=0x7fb59997a55e <filter_flush_file_evenly>, filter_arg=0x7fb5843feec0) at /data/src/10.1/storage/maria/ma_pagecache.c:4727 #7 0x00007fb599978c19 in flush_pagecache_blocks_with_filter (pagecache=0x7fb59ad83940 <maria_pagecache_var>, file=0x7fb58344e3d0, type=FLUSH_KEEP_LAZY, filter=0x7fb59997a55e <filter_flush_file_evenly>, filter_arg=0x7fb5843feec0) at /data/src/10.1/storage/maria/ma_pagecache.c:4844 #8 0x00007fb59997a80b in ma_checkpoint_background (arg=0x5) at /data/src/10.1/storage/maria/ma_checkpoint.c:669 #9 0x00007fb598914064 in start_thread (arg=0x7fb5843ff700) at pthread_create.c:309 #10 0x00007fb596d3a62d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:111 Curious variation of the stack trace on current 5.5: 5.5 7a63ffab7164 #3 <signal handler called> #4 0x0000000000b7258d in cmp_sec_link (a=0x7f779bffb418, b=0x7f779bffb420) at /data/src/5.5/storage/maria/ma_pagecache.c:4303 #5 0x00007f77c288ddb1 in msort_with_tmp (p=0x7f779bffad70, b=0x7f779bffb418, n=2) at msort.c:83 #6 0x00007f77c288db18 in msort_with_tmp (n=2, b=0x7f779bffb418, p=0x7f779bffad70) at msort.c:45 #7 msort_with_tmp (p=0x7f779bffad70, b=0x7f779bffb410, n=3) at msort.c:54 #8 0x00007f77c288db02 in msort_with_tmp (n=3, b=0x7f779bffb410, p=0x7f779bffad70) at msort.c:45 #9 msort_with_tmp (p=0x7f779bffad70, b=0x7f779bffb410, n=6) at msort.c:53 #10 0x00007f77c288db18 in msort_with_tmp (n=6, b=0x7f779bffb410, p=0x7f779bffad70) at msort.c:45 #11 msort_with_tmp (p=0x7f779bffad70, b=0x7f779bffb3e0, n=12) at msort.c:54 #12 0x00007f77c288db18 in msort_with_tmp (n=12, b=0x7f779bffb3e0, p=0x7f779bffad70) at msort.c:45 #13 msort_with_tmp (p=0x7f779bffad70, b=0x7f779bffb380, n=24) at msort.c:54 #14 0x00007f77c288db02 in msort_with_tmp (n=24, b=0x7f779bffb380, p=0x7f779bffad70) at msort.c:45 #15 msort_with_tmp (p=0x7f779bffad70, b=0x7f779bffb380, n=49) at msort.c:53 #16 0x00007f77c288db18 in msort_with_tmp (n=49, b=0x7f779bffb380, p=0x7f779bffad70) at msort.c:45 #17 msort_with_tmp (p=0x7f779bffad70, b=0x7f779bffb200, n=97) at msort.c:54 #18 0x00007f77c288db18 in msort_with_tmp (n=97, b=0x7f779bffb200, p=0x7f779bffad70) at msort.c:45 #19 msort_with_tmp (p=0x7f779bffad70, b=0x7f779bffaf00, n=193) at msort.c:54 #20 0x00007f77c288e05c in msort_with_tmp (n=193, b=0x7f779bffaf00, p=0x7f779bffad70) at msort.c:45 #21 __GI_qsort_r (b=0x7f779bffaf00, n=193, s=8, cmp=0xb72567 <cmp_sec_link>, arg=<optimized out>) at msort.c:297 #22 0x0000000000b72672 in flush_cached_blocks (pagecache=0x1d06b00 <maria_pagecache_var>, file=0x7f779b04c390, cache=0x7f779bffaf00, end=0x7f779bffb508, type=FLUSH_KEEP_LAZY, first_errno=0x7f779bffaedc) at /data/src/5.5/storage/maria/ma_pagecache.c:4346 #23 0x0000000000b73371 in flush_pagecache_blocks_int (pagecache=0x1d06b00 <maria_pagecache_var>, file=0x7f779b04c390, type=FLUSH_KEEP_LAZY, filter=0xb750e4 <filter_flush_file_evenly>, filter_arg=0x7f779bffee70) at /data/src/5.5/storage/maria/ma_pagecache.c:4690 #24 0x0000000000b7370b in flush_pagecache_blocks_with_filter (pagecache=0x1d06b00 <maria_pagecache_var>, file=0x7f779b04c390, type=FLUSH_KEEP_LAZY, filter=0xb750e4 <filter_flush_file_evenly>, filter_arg=0x7f779bffee70) at /data/src/5.5/storage/maria/ma_pagecache.c:4806 #25 0x0000000000b75371 in ma_checkpoint_background (arg=0x5) at /data/src/5.5/storage/maria/ma_checkpoint.c:665 #26 0x00007f77c3ebc064 in start_thread (arg=0x7f779bfff700) at pthread_create.c:309 #27 0x00007f77c293f62d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:111

Elena Stepanova added a comment - 2018-02-11 01:51 A real-life complaint: MDEV-15256

Elena Stepanova added a comment - 2018-06-12 11:06 The failure stopped being reproducible with the provided RQG test after this commit in 5.5: commit 2b749a7bf4f6a6d70f05e8e4b42d088b397adea8 Author: Monty <monty@mariadb.org> Date: Tue May 15 11:46:55 2018 +0300   MDEV-654 Assertion `share->now_transactional' failed in flush_log_for_bitmap on concurrent workload with Aria tables Problem was that we the bitmap needs to be flushed before disabling logging of redo entires, as writing the bitmap to disk by background checkpoint may cause redo entries. Either it was actually fixed or masked, but it's easily reproducible before and not after. Thus closing the bug as fixed in the scope of MDEV-654 .