Bug #75079 | Assertion `!do_checksum || remains == 0' failed in MYSQL_BIN_LOG::do_write_cache | ||
---|---|---|---|
Submitted: | 3 Dec 2014 5:50 | Modified: | 8 Dec 2014 11:40 |
Reporter: | Ramesh Sivaraman | Email Updates: | |
Status: | Verified | Impact on me: | |
Category: | MySQL Server: DDL | Severity: | S3 (Non-critical) |
Version: | 5.6.21, 5.6.23, 5.6.22, 5.7.6 | OS: | Linux (CentOS 7) |
Assigned to: | CPU Architecture: | Any | |
Tags: | debug |
[3 Dec 2014 5:50]
Ramesh Sivaraman
[3 Dec 2014 5:51]
Ramesh Sivaraman
testcase
Attachment: testcase.sql (application/sql, text), 32.67 KiB.
[8 Dec 2014 11:36]
MySQL Verification Team
Hello Ramesh Sivaraman, Thank you for the report and test case. I could not repeat this issue with debug/optimized builds of 5.6.22 GA release, and with latest builds of 5.6.23. Could you please provide exact conf/command used for this issue? Thanks, Umesh
[8 Dec 2014 11:40]
MySQL Verification Team
Pls ignore my earlier request, able confirm this on debug builds. Thanks, Umesh
[8 Dec 2014 11:44]
MySQL Verification Team
Confirmed that 5.6.23 debug builds affected (gdb) bt #0 0x00007f5fb11b0771 in pthread_kill () from /lib64/libpthread.so.0 #1 0x0000000000b0070b in my_write_core (sig=6) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/mysys/stacktrace.c:422 #2 0x000000000077ec8c in handle_fatal_signal (sig=6) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/signal_handler.cc:230 #3 <signal handler called> #4 0x00007f5fafdb65c9 in raise () from /lib64/libc.so.6 #5 0x00007f5fafdb7cd8 in abort () from /lib64/libc.so.6 #6 0x00007f5fafdaf536 in __assert_fail_base () from /lib64/libc.so.6 #7 0x00007f5fafdaf5e2 in __assert_fail () from /lib64/libc.so.6 #8 0x0000000000a90b10 in MYSQL_BIN_LOG::do_write_cache (this=0x199d840 <mysql_bin_log>, cache=0x7f5f5c02dad8) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/binlog.cc:5792 #9 0x0000000000a9106a in MYSQL_BIN_LOG::write_cache (this=0x199d840 <mysql_bin_log>, thd=0x2943e10, cache_data=0x7f5f5c02dad0) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/binlog.cc:5928 #10 0x0000000000a853f5 in binlog_cache_data::flush (this=0x7f5f5c02dad0, thd=0x2943e10, bytes_written=0x7f5f86b76e30, wrote_xid=0x7f5f86b76e87) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/binlog.cc:1227 #11 0x0000000000a9a027 in binlog_cache_mngr::flush (this=0x7f5f5c02dad0, thd=0x2943e10, bytes_written=0x7f5f86b76e88, wrote_xid=0x7f5f86b76e87) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/binlog.cc:774 #12 0x0000000000a9285c in MYSQL_BIN_LOG::flush_thread_caches (this=0x199d840 <mysql_bin_log>, thd=0x2943e10) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/binlog.cc:6515 #13 0x0000000000a92a5d in MYSQL_BIN_LOG::process_flush_stage_queue (this=0x199d840 <mysql_bin_log>, total_bytes_var=0x7f5f86b77000, rotate_var=0x7f5f86b76fff, out_queue_var=0x7f5f86b76ff0) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/binlog.cc:6571 #14 0x0000000000a93733 in MYSQL_BIN_LOG::ordered_commit (this=0x199d840 <mysql_bin_log>, thd=0x2943e10, all=false, skip_commit=true) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/binlog.cc:6988 #15 0x0000000000a8641d in MYSQL_BIN_LOG::rollback (this=0x199d840 <mysql_bin_log>, thd=0x2943e10, all=false) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/binlog.cc:1667 #16 0x00000000008fd245 in trans_rollback_stmt (thd=0x2943e10) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/transaction.cc:492 #17 0x0000000000834e62 in mysql_execute_command (thd=0x2943e10) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/sql_parse.cc:5001 #18 0x0000000000838085 in mysql_parse (thd=0x2943e10, rawbuf=0x7f5f5c01ee20 "CREATE TABLE t0(c0 SET('','abcdefghijabcdefghijabcdefghijabcdefghijabcdefghij','abcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghij"..., length=33354, parser_state=0x7f5f86b79700) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/sql_parse.cc:6357 #19 0x000000000082aa07 in dispatch_command (command=COM_QUERY, thd=0x2943e10, packet=0x2a23941 "CREATE TABLE t0(c0 SET('','abcdefghijabcdefghijabcdefghijabcdefghijabcdefghij','abcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghij"..., packet_length=33354) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/sql_parse.cc:1332 #20 0x0000000000829a6c in do_command (thd=0x2943e10) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/sql_parse.cc:1034 #21 0x00000000007f0e5f in do_handle_one_connection (thd_arg=0x2943e10) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/sql_connect.cc:982 #22 0x00000000007f0930 in handle_one_connection (arg=0x2943e10) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/sql/sql_connect.cc:898 #23 0x0000000000e652e1 in pfs_spawn_thread (arg=0x29e3350) at /pb2/build/sb_0-13700644-1416330726.69/mysqlcom-pro-5.6.23/storage/perfschema/pfs.cc:1860 #24 0x00007f5fb11abdf3 in start_thread () from /lib64/libpthread.so.0 #25 0x00007f5fafe7747d in clone () from /lib64/libc.so.6
[8 Dec 2014 11:45]
MySQL Verification Team
// 5.6.22 debug builds affected (gdb) bt #0 0x00007f26ce244771 in pthread_kill () from /lib64/libpthread.so.0 #1 0x0000000000aab407 in my_write_core (sig=6) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/mysys/stacktrace.c:422 #2 0x0000000000714392 in handle_fatal_signal (sig=6) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/signal_handler.cc:230 #3 <signal handler called> #4 0x00007f26cce4a5c9 in raise () from /lib64/libc.so.6 #5 0x00007f26cce4bcd8 in abort () from /lib64/libc.so.6 #6 0x00007f26cce43536 in __assert_fail_base () from /lib64/libc.so.6 #7 0x00007f26cce435e2 in __assert_fail () from /lib64/libc.so.6 #8 0x0000000000a334e5 in MYSQL_BIN_LOG::do_write_cache (this=0x1808200 <mysql_bin_log>, cache=0x7f267806bc98) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/binlog.cc:5790 #9 0x0000000000a39c82 in MYSQL_BIN_LOG::write_cache (this=0x1808200 <mysql_bin_log>, thd=0x3d99f10, cache_data=0x7f267806bc90) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/binlog.cc:5926 #10 0x0000000000a3c4f8 in binlog_cache_data::flush (this=0x7f267806bc90, thd=0x3d99f10, bytes_written=0x7f26a3c0ab00, wrote_xid=0x7f26a3c0ab47) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/binlog.cc:1227 #11 0x0000000000a43a17 in binlog_cache_mngr::flush (this=0x7f267806bc90, thd=0x3d99f10, bytes_written=0x7f26a3c0ab48, wrote_xid=0x7f26a3c0ab47) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/binlog.cc:774 #12 0x0000000000a3c5d1 in MYSQL_BIN_LOG::flush_thread_caches (this=0x1808200 <mysql_bin_log>, thd=0x3d99f10) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/binlog.cc:6513 #13 0x0000000000a3c7c0 in MYSQL_BIN_LOG::process_flush_stage_queue (this=0x1808200 <mysql_bin_log>, total_bytes_var=0x7f26a3c0ad00, rotate_var=0x7f26a3c0acff, out_queue_var=0x7f26a3c0acf0) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/binlog.cc:6569 #14 0x0000000000a3cc01 in MYSQL_BIN_LOG::ordered_commit (this=0x1808200 <mysql_bin_log>, thd=0x3d99f10, all=false, skip_commit=true) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/binlog.cc:6986 #15 0x0000000000a40824 in MYSQL_BIN_LOG::rollback (this=0x1808200 <mysql_bin_log>, thd=0x3d99f10, all=false) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/binlog.cc:1667 #16 0x0000000000895892 in trans_rollback_stmt (thd=0x3d99f10) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/transaction.cc:492 #17 0x00000000007ceea6 in mysql_execute_command (thd=0x3d99f10) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/sql_parse.cc:5001 #18 0x00000000007cf5f1 in mysql_parse (thd=0x3d99f10, rawbuf=0x7f26780192a0 "CREATE TABLE t0(c0 SET('','abcdefghijabcdefghijabcdefghijabcdefghijabcdefghij','abcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghij"..., length=33354, parser_state=0x7f26a3c0d700) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/sql_parse.cc:6357 #19 0x00000000007d119b in dispatch_command (command=COM_QUERY, thd=0x3d99f10, packet=0x3e77f91 "CREATE TABLE t0(c0 SET('','abcdefghijabcdefghijabcdefghijabcdefghijabcdefghij','abcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghij"..., packet_length=33354) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/sql_parse.cc:1332 #20 0x00000000007d29d5 in do_command (thd=0x3d99f10) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/sql_parse.cc:1034 #21 0x000000000078880d in do_handle_one_connection (thd_arg=0x3d99f10) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/sql_connect.cc:982 #22 0x00000000007888d3 in handle_one_connection (arg=0x3d99f10) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/sql/sql_connect.cc:898 #23 0x0000000000d9ea7e in pfs_spawn_thread (arg=0x3ced710) at /export/home/pb2/build/sb_0-13724721-1416549605.94/mysql-5.6.22/storage/perfschema/pfs.cc:1860 #24 0x00007f26ce23fdf3 in start_thread () from /lib64/libpthread.so.0 #25 0x00007f26ccf0b47d in clone () from /lib64/libc.so.6
[8 Dec 2014 11:49]
MySQL Verification Team
// With 5.6.23 optimized build mysql> show variables like '%version%'; +-------------------------+---------------------------------------------------------+ | Variable_name | Value | +-------------------------+---------------------------------------------------------+ | innodb_version | 5.6.23 | | protocol_version | 10 | | slave_type_conversions | | | version | 5.6.23-enterprise-commercial-advanced-log | | version_comment | MySQL Enterprise Server - Advanced Edition (Commercial) | | version_compile_machine | x86_64 | | version_compile_os | Linux | +-------------------------+---------------------------------------------------------+ 7 rows in set (0.00 sec) mysql> source testcase.sql; Query OK, 1 row affected (0.00 sec) Query OK, 1 row affected (0.00 sec) Database changed Query OK, 0 rows affected, 1 warning (0.00 sec) ERROR 1705 (HY000): Multi-row statements required more than 'max_binlog_stmt_cache_size' bytes of storage; increase this mysqld variable and try again
[8 Dec 2014 11:54]
MySQL Verification Team
// 5.7.6 debug build (gdb) bt #0 0x00007fed86000771 in pthread_kill () from /lib64/libpthread.so.0 #1 0x0000000000f70894 in my_write_core (sig=6) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/mysys/stacktrace.c:247 #2 0x00000000009206ce in handle_fatal_signal (sig=6) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/signal_handler.cc:219 #3 <signal handler called> #4 0x00007fed84c065c9 in raise () from /lib64/libc.so.6 #5 0x00007fed84c07cd8 in abort () from /lib64/libc.so.6 #6 0x00007fed84bff536 in __assert_fail_base () from /lib64/libc.so.6 #7 0x00007fed84bff5e2 in __assert_fail () from /lib64/libc.so.6 #8 0x0000000000eecbcd in MYSQL_BIN_LOG::do_write_cache (this=0x20f7540 <mysql_bin_log>, cache=0x7fed0806be18, last_committed_arg=26, sequence_number_arg=27) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/binlog.cc:6363 #9 0x0000000000eed276 in MYSQL_BIN_LOG::write_cache (this=0x20f7540 <mysql_bin_log>, thd=0x7fed08011d80, cache_data=0x7fed0806be10) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/binlog.cc:6546 #10 0x0000000000ee03e2 in binlog_cache_data::flush (this=0x7fed0806be10, thd=0x7fed08011d80, bytes_written=0x7fed702e7af0, wrote_xid=0x7fed702e7b27) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/binlog.cc:1227 #11 0x0000000000ef6e6b in binlog_cache_mngr::flush (this=0x7fed0806be10, thd=0x7fed08011d80, bytes_written=0x7fed702e7b28, wrote_xid=0x7fed702e7b27) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/binlog.cc:751 #12 0x0000000000eeedc5 in MYSQL_BIN_LOG::flush_thread_caches (this=0x20f7540 <mysql_bin_log>, thd=0x7fed08011d80) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/binlog.cc:7201 #13 0x0000000000eeefa6 in MYSQL_BIN_LOG::process_flush_stage_queue (this=0x20f7540 <mysql_bin_log>, total_bytes_var=0x7fed702e7c40, rotate_var=0x7fed702e7c3f, out_queue_var=0x7fed702e7c30) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/binlog.cc:7262 #14 0x0000000000ef0076 in MYSQL_BIN_LOG::ordered_commit (this=0x20f7540 <mysql_bin_log>, thd=0x7fed08011d80, all=false, skip_commit=true) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/binlog.cc:7740 #15 0x0000000000ee17e2 in MYSQL_BIN_LOG::rollback (this=0x20f7540 <mysql_bin_log>, thd=0x7fed08011d80, all=false) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/binlog.cc:1746 #16 0x0000000000d752de in trans_rollback_stmt (thd=0x7fed08011d80) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/transaction.cc:428 #17 0x0000000000c9eb09 in mysql_execute_command (thd=0x7fed08011d80) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/sql_parse.cc:4835 #18 0x0000000000ca039f in mysql_parse (thd=0x7fed08011d80, parser_state=0x7fed702e9ea0) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/sql_parse.cc:5386 #19 0x0000000000c950db in dispatch_command (command=COM_QUERY, thd=0x7fed08011d80, packet=0x7fed0805e021 "CREATE TABLE t0(c0 SET('','abcdefghijabcdefghijabcdefghijabcdefghijabcdefghij','abcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghijabcdefghij"..., packet_length=33354) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/sql_parse.cc:1249 #20 0x0000000000c93df5 in do_command (thd=0x7fed08011d80) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/sql_parse.cc:833 #21 0x0000000000d9d9ea in handle_connection (arg=0x426db50) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/sql/conn_handler/connection_handler_per_thread.cc:298 #22 0x0000000000fa0dc7 in pfs_spawn_thread (arg=0x42ebe00) at /export/home/pb2/build/sb_0-13761755-1417089283.97/mysqlcom-pro-5.7.6-m16/storage/perfschema/pfs.cc:2137 #23 0x00007fed85ffbdf3 in start_thread () from /lib64/libpthread.so.0 #24 0x00007fed84cc747d in clone () from /lib64/libc.so.6