Percona Server moved to https://jira.percona.com/projects/PS

Failing assertion: !(thr_get_trx(thr)->fake_changes) in file ibuf0ibuf.cc line 3527 | abort in ibuf_insert_low

Bug #1193138 reported by Roel Van de Paar
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
Percona Server moved to https://jira.percona.com/projects/PS
Triaged
Medium
Unassigned
5.1
Invalid
Medium
Unassigned
5.5
Invalid
Medium
Unassigned
5.6
Triaged
Medium
Unassigned

Bug Description

2013-06-20 14:45:45 7f899d2dd700 InnoDB: Assertion failure in thread 140229024274176 in file ibuf0ibuf.cc line 3527
InnoDB: Failing assertion: !(thr_get_trx(thr)->fake_changes)

Thread 1 (LWP 20254):
+bt
#0 0x0000003fde20c69c in pthread_kill () from /lib64/libpthread.so.0
#1 0x000000000068302e in handle_fatal_signal (sig=6) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/signal_handler.cc:251
#2 <signal handler called>
#3 0x0000003fdde328a5 in raise () from /lib64/libc.so.6
#4 0x0000003fdde34085 in abort () from /lib64/libc.so.6
#5 0x0000000000a172f7 in ibuf_insert_low (mode=36, op=IBUF_OP_INSERT, no_counter=0, entry=0x7f892803cb60, entry_size=10, index=0x7f896854c678, space=39, zip_size=0, page_no=54, thr=0x7f89180410a0) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/innobase/ibuf/ibuf0ibuf.cc:3527
#6 0x0000000000a1798d in ibuf_insert (op=IBUF_OP_INSERT, entry=0x7f892803cb60, index=0x7f896854c678, space=39, zip_size=0, page_no=54, thr=0x7f89180410a0) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/innobase/ibuf/ibuf0ibuf.cc:3943
#7 0x0000000000b40883 in btr_cur_search_to_nth_level (index=0x7f896854c678, level=0, tuple=0x7f892803cb60, mode=4, latch_mode=2, cursor=0x7f899d2daa80, has_search_latch=0, file=0xdc5250 "/bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/innobase/row/row0ins.cc", line=2663, mtr=0x7f899d2da5b0) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/innobase/btr/btr0cur.cc:688
#8 0x0000000000a9a78f in row_ins_sec_index_entry_low (flags=0, mode=2, index=0x7f896854c678, offsets_heap=0x7f8928032a90, heap=0x7f892803d170, entry=0x7f892803cb60, trx_id=0, thr=0x7f89180410a0) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/innobase/row/row0ins.cc:2663
#9 0x0000000000a9b279 in row_ins_sec_index_entry (index=0x7f896854c678, entry=0x7f892803cb60, thr=0x7f89180410a0) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/innobase/row/row0ins.cc:2948
#10 0x0000000000a9b9a7 in row_ins_index_entry (thr=0x7f89180410a0, entry=0x7f892803cb60, index=0x7f896854c678) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/innobase/row/row0ins.cc:2983
#11 row_ins_index_entry_step (thr=0x7f89180410a0, node=0x7f8918040bb8) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/innobase/row/row0ins.cc:3058
#12 row_ins (thr=0x7f89180410a0, node=0x7f8918040bb8) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/innobase/row/row0ins.cc:3198
#13 row_ins_step (thr=0x7f89180410a0) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/innobase/row/row0ins.cc:3323
#14 0x0000000000aae1ec in row_insert_for_mysql (mysql_rec=<optimized out>, prebuilt=<optimized out>) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/innobase/row/row0mysql.cc:1312
#15 0x00000000009ea39e in ha_innobase::write_row (this=0x7f891803aa20, record=0x7f8918038918 "\377", <incomplete sequence \367>) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/innobase/handler/ha_innodb.cc:6929
#16 0x00000000005b7b9f in handler::ha_write_row (this=0x7f891803aa20, buf=0x7f8918038918 "\377", <incomplete sequence \367>) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/handler.cc:7414
#17 0x0000000000c4a3e9 in ha_partition::write_row (this=0x7f8918038290, buf=0x7f8918038918 "\377", <incomplete sequence \367>) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/ha_partition.cc:3927
#18 0x00000000005b7b04 in handler::ha_write_row (this=0x7f8918038290, buf=0x7f8918038918 "\377", <incomplete sequence \367>) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/handler.cc:7414
#19 0x00000000006f86f8 in write_record (thd=0x31003e0, table=0x7f8918037920, info=0x7f899d2db210, update=0x7f899d2db190) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/sql_insert.cc:1650
#20 0x00000000007002d1 in mysql_insert (thd=0x31003e0, table_list=0x7f890c00c1d8, fields=..., values_list=..., update_fields=..., update_values=..., duplic=DUP_REPLACE, ignore=false) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/sql_insert.cc:1054
#21 0x000000000071806e in mysql_execute_command (thd=0x31003e0) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/sql_parse.cc:3634
#22 0x000000000071b8b8 in mysql_parse (thd=0x31003e0, rawbuf=0x3102798 "p\234\065\001", length=<optimized out>, parser_state=<optimized out>) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/sql_parse.cc:6451
#23 0x000000000071c923 in dispatch_command (command=COM_QUERY, thd=0x31003e0, packet=0x3104681 "REPLACE INTO `view_table500_innodb_compressed_key_pk_parts_2_int` ( `c17` ) VALUES ( 7697664 )", packet_length=94) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/sql_parse.cc:1376
#24 0x000000000071d86b in do_command (thd=0x31003e0) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/sql_parse.cc:1051
#25 0x00000000007c82c7 in threadpool_process_request (thd=0x31003e0) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/threadpool_common.cc:312
#26 0x00000000007cafa8 in handle_event (connection=0x2fe9900) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/threadpool_unix.cc:1466
#27 worker_main (param=0x14ea000 <all_groups>) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/sql/threadpool_unix.cc:1519
#28 0x00000000009beb49 in pfs_spawn_thread (arg=0x7f89340b3490) at /bzr/5.6_dbg/Percona-Server-5.6.11-rc60.3/storage/perfschema/pfs.cc:1853
#29 0x0000003fde207851 in start_thread () from /lib64/libpthread.so.0
#30 0x0000003fddee890d in clone () from /lib64/libc.so.6

Revision history for this message
Roel Van de Paar (roel11) wrote :
Revision history for this message
Laurynas Biveinis (laurynas-biveinis) wrote :

Roel -

Need a SQL trace of the crashed connection.

tags: added: fake-changes i20439
tags: added: xtradb
Revision history for this message
Roel Van de Paar (roel11) wrote :
Revision history for this message
Roel Van de Paar (roel11) wrote :
Revision history for this message
Roel Van de Paar (roel11) wrote :

Laurynas, stack traces (assume that is what you meant) added.

Revision history for this message
Roel Van de Paar (roel11) wrote :

Tested, and regrettably not easy to reproduce. Please see if issue can be analyzed from stack traces.

Revision history for this message
Roel Van de Paar (roel11) wrote :

Since QA Branch rev 428 (Percona-Server-5.6.13-rc60.5-428-debug-valgrind.Linux.x86_64), this assertion is now seen heaps on various queries

2013-09-11 04:55:07 1a37e700 InnoDB: Assertion failure in thread 439871232 in file ibuf0ibuf.cc line 3531
InnoDB: Failing assertion: !(thr_get_trx(thr)->fake_changes)
[...]
Query (19dcb310): LOAD DATA INFILE '/ssd//349312/tmp/gentest6628.tmp' INTO TABLE `table500_innodb_default_key_c1_parts_2`

2013-09-11 05:00:03 1a3bf700 InnoDB: Assertion failure in thread 440137472 in file ibuf0ibuf.cc line 3531
InnoDB: Failing assertion: !(thr_get_trx(thr)->fake_changes)
[...]
Query (213641a0): INSERT HIGH_PRIORITY INTO `table500_innodb_compressed_int` ( `c4` ) VALUES ( 'look' ) ON DUPLICATE KEY UPDATE `c26` = LOAD_FILE('/ssd/randgen/data/earth2kb.jpg')

2013-09-11 08:00:51 1abbf700 InnoDB: Assertion failure in thread 448526080 in file ibuf0ibuf.cc line 3531
InnoDB: Failing assertion: !(thr_get_trx(thr)->fake_changes)
[...]
2013-09-11T15:00:51 [25878] Query: REPLACE INTO `view_table100_innodb_default_key_c1_parts_2` ( `c25` ) VALUES ( -1 )

2013-09-11 05:28:23 1a176700 InnoDB: Assertion failure in thread 437741312 in file ibuf0ibuf.cc line 3531
InnoDB: Failing assertion: !(thr_get_trx(thr)->fake_changes)
[...]
Query (2121db50): INSERT INTO n ( `c6` ) VALUES ( '2004' )

Revision history for this message
Roel Van de Paar (roel11) wrote :

Bug was maybe masked before?

tags: added: qablock
Revision history for this message
Roel Van de Paar (roel11) wrote :

Marking as "still seen" as per IRC with Laurynas, and also has missing DBUG_RETURN

/ssd/Percona-Server-5.6.13-rc60.5-431-debug.Linux.x86_64/bin/mysqld: debugger aborting because missing DBUG_RETURN or DBUG_VOID_RETURN macro in function "ibuf_insert"

Roel Van de Paar (roel11)
tags: added: 56qual
Revision history for this message
Roel Van de Paar (roel11) wrote :

FC is alpha, so no 56qual

tags: removed: 56qual
Roel Van de Paar (roel11)
tags: removed: qablock
Revision history for this message
Ramesh Sivaraman (rameshvs02) wrote :

********** Testcase

DROP DATABASE test;CREATE DATABASE test;USE test;
set global innodb_limit_optimistic_insert_debug=2;
CREATE TABLE t1(a INT,INDEX(a)) ENGINE=InnoDB;
INSERT INTO t1 VALUES(1),(1),(1),(1),(1),(1),(1),(1),(1),(1),(1),(1),(1),(1),(1),(1),(1),(1),(1),(1);
insert into t1 value(1);
insert into t1 values(1);
SET innodb_fake_changes=1;
SET GLOBAL innodb_disable_background_merge=ON;
INSERT INTO t1 VALUES(),(),();

Revision history for this message
Krunal Bauskar (krunal-bauskar) wrote :

This bug is duplicate of https://bugs.launchpad.net/percona-server/+bug/1410410

To post a comment you must log in.
This report contains Public information  
Everyone can see this information.
Subscribing...

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.