Assertion `block->hash_link == hash_link && hash_link->block == block' in ma_pagecache.c:2275 with Aria

[Philip Stoev]

The SMF scenario produced the following assertion:

mysqld: ma_pagecache.c:2275: find_block: Assertion `block->hash_link == hash_link && hash_link->block == block' failed.

# 2011-07-21T15:29:36 #6 0x00000033b58296e6 in __assert_fail () from /lib64/libc.so.6
# 2011-07-21T15:29:36 #7 0x00000000009d8417 in find_block (pagecache=0x1a267e0, file=0x13b04190, pageno=1, init_hits_left=3, wrmode=0 '\000', block_is_copied=0 '\000',
# 2011-07-21T15:29:36 reg_req=1 '\001', page_st=0x4ece66dc) at ma_pagecache.c:2274
# 2011-07-21T15:29:36 #8 0x00000000009dc64e in pagecache_read (pagecache=0x1a267e0, file=0x13b04190, pageno=1, level=3, buff=0x0, type=PAGECACHE_LSN_PAGE,
# 2011-07-21T15:29:36 lock=PAGECACHE_LOCK_READ, page_link=0x4ece67f0) at ma_pagecache.c:3460
# 2011-07-21T15:29:36 #9 0x000000000095144e in _ma_fetch_keypage (page=0x4ece68d0, info=0x2aaac0035818, keyinfo=0x13b04840, pos=16384, lock=PAGECACHE_LOCK_READ, level=3,
# 2011-07-21T15:29:36 buff=0x0, return_buffer=0 '\000') at ma_page.c:109
# 2011-07-21T15:29:36 #10 0x000000000095ba4a in _ma_search_no_save (info=0x2aaac0035818, key=0x4ece6f00, nextflag=33, pos=16384, res_page_link=0x4ece6e50,
# 2011-07-21T15:29:36 res_page_buff=0x4ece6e48) at ma_search.c:141
# 2011-07-21T15:29:36 #11 0x000000000095b77b in _ma_search (info=0x2aaac0035818, key=0x4ece6f00, nextflag=33, pos=16384) at ma_search.c:77
# 2011-07-21T15:29:36 #12 0x0000000000962507 in maria_rkey (info=0x2aaac0035818,
# 2011-07-21T15:29:36 buf=0x2aaac010e590 "\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\217\217\217\217\217\217\217\377\021", inx=0, key_data=0x1404d318 "", keypart_map=1, search_flag=HA_READ_KEY_EXACT)
# 2011-07-21T15:29:36 at ma_rkey.c:101
# 2011-07-21T15:29:36 #13 0x0000000000933506 in ha_maria::index_read_idx_map (this=0x2aaac001f680,
# 2011-07-21T15:29:36 buf=0x2aaac010e590 "\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\217\217\217\217\217\217\217\377\021", index=0, key=0x1404d318 "", keypart_map=1, find_flag=HA_READ_KEY_EXACT)
# 2011-07-21T15:29:36 at ha_maria.cc:2161
# 2011-07-21T15:29:36 #14 0x0000000000718ada in handler::ha_index_read_idx_map (this=0x2aaac001f680,
# 2011-07-21T15:29:36 buf=0x2aaac010e590 "\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\376\217\217\217\217\217\217\217\377\021", index=0, key=0x1404d318 "", keypart_map=1, find_flag=HA_READ_KEY_EXACT)
# 2011-07-21T15:29:36 at sql_class.h:3271
# 2011-07-21T15:29:36 #15 0x00000000006f0f41 in join_read_const (tab=0x1404ce48) at sql_select.cc:12297
# 2011-07-21T15:29:36 #16 0x0000000000705fe9 in join_read_const_table (tab=0x1404ce48, pos=0x13b83fb0) at sql_select.cc:12188
# 2011-07-21T15:29:36 #17 0x000000000070b0e3 in make_join_statistics (join=0x13b83f10, tables_arg=0x1404c448, conds=0x1404cc30, keyuse_array=0x13b854d8) at sql_select.cc:2965
# 2011-07-21T15:29:36 #18 0x000000000070e4cb in JOIN::optimize (this=0x13b83f10) at sql_select.cc:1034
# 2011-07-21T15:29:36 #19 0x00000000007129f1 in mysql_select (thd=0x1403cbb8, rref_pointer_array=0x1403f5b0, tables=0x1404c448, wild_num=0, fields=..., conds=0x1404c948,
# 2011-07-21T15:29:36 og_num=0, order=0x0, group=0x0, having=0x0, proc_param=0x0, select_options=2147764736, result=0x1404cb60, unit=0x1403ef90, select_lex=0x1403f3e0)
# 2011-07-21T15:29:36 at sql_select.cc:2551
# 2011-07-21T15:29:36 #20 0x00000000007183f8 in handle_select (thd=0x1403cbb8, lex=0x1403eef0, result=0x1404cb60, setup_tables_done_option=0) at sql_select.cc:280
# 2011-07-21T15:29:36 #21 0x0000000000678f1e in execute_sqlcom_select (thd=0x1403cbb8, all_tables=0x1404c448) at sql_parse.cc:5139
# 2011-07-21T15:29:36 #22 0x000000000067ab79 in mysql_execute_command (thd=0x1403cbb8) at sql_parse.cc:2285
# 2011-07-21T15:29:36 #23 0x00000000006838a1 in mysql_parse (thd=0x1403cbb8, rawbuf=0x1404c1e0 "SELECT id_member_started FROM smf_topics WHERE id_topic = 11963648 LIMIT 1",
# 2011-07-21T15:29:36 length=74, found_semicolon=0x4ece8f18) at sql_parse.cc:6138
# 2011-07-21T15:29:36 #24 0x0000000000684732 in dispatch_command (command=COM_QUERY, thd=0x1403cbb8,
# 2011-07-21T15:29:36 packet=0x14040179 "SELECT id_member_started FROM smf_topics WHERE id_topic = 11963648 LIMIT 1", packet_length=74) at sql_parse.cc:1213
# 2011-07-21T15:29:36 #25 0x0000000000685d4f in do_command (thd=0x1403cbb8) at sql_parse.cc:903
# 2011-07-21T15:29:36 #26 0x00000000006708c8 in handle_one_connection (arg=0x1403cbb8) at sql_connect.cc:1177
# 2011-07-21T15:29:36 #27 0x00000033b600673d in start_thread () from /lib64/libpthread.so.0
# 2011-07-21T15:29:36 #28 0x00000033b58d40cd in clone () from /lib64/libc.so.6
# 2011-07-21T15:29:36 #5 0x00000033b5831d10 in abort () from /lib64/libc.so.6

RQG command line:

runall.pl --queries=100000000 --queries=1M --engine=Aria --mysqld=--default-storage-engine=Aria --mysqld=--safe-mode --mysqld=--loose-debug-assert-if-crashed-table --mysqld=--sync-sys=0 --mysqld=--log-output=file --mysqld=--aria_log_purge_type=at_flush --reporters=ErrorLog,Backtrace,AriaDoubleRecovery,Shutdown --duration=120 --threads=20 --rows=100 --mask-level=2 --mysqld=--aria-repair-threads=2 --mysqld=--loose-aria-group-commit=hard --mysqld=--loose-aria_group_commit_interval=1 --mysqld=--aria-checkpoint-interval=120 --mysqld=--aria-block-size=16K --mysqld=--aria-pagecache-buffer-size=512K --mysqld=--init-file=/home/philips/bzr/randgen-aria-recovery/conf/smf/smf2.sql --grammar=conf/smf/smf2.yy --mtr-build-thread=300 --mask=43267 --basedir1=/home/philips/bzr/maria-5.2 --seed=1311251371

bzr version-info:

revision-id: <email address hidden>
date: 2011-07-12 22:42:00 +0200
build-date: 2011-07-21 15:36:36 +0300
revno: 3002
branch-nick: maria-5.2

[Michael Widenius (monty)]

Pushed into 5.2 tree