innodb.innodb_bug56680 fails in 5.5.11

Bug #758891 reported by Alexey Kopytov on 2011-04-12
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
percona-projects-qa
Undecided
Unassigned

Bug Description

I get the following assertion failure when running innodb.innodb_bug56680 in 5.5.11 on Linux:

innodb.innodb_bug56680 [ fail ]
        Test ended at 2011-04-11 03:49:59

CURRENT_TEST: innodb.innodb_bug56680
mysqltest: At line 81: query 'DELETE FROM bug56680 WHERE a=1' failed: 2013: Lost connection to MySQL server during query

The result from queries just before the failure was:
< snip >
b
x
SET GLOBAL tx_isolation='READ-UNCOMMITTED';
INSERT INTO bug56680 SELECT 0,b,c FROM bug56680;
INSERT INTO bug56680 SELECT 0,b,c FROM bug56680;
INSERT INTO bug56680 SELECT 0,b,c FROM bug56680;
INSERT INTO bug56680 SELECT 0,b,c FROM bug56680;
INSERT INTO bug56680 SELECT 0,b,c FROM bug56680;
INSERT INTO bug56680 SELECT 0,b,c FROM bug56680;
INSERT INTO bug56680 SELECT 0,b,c FROM bug56680;
INSERT INTO bug56680 SELECT 0,b,c FROM bug56680;
INSERT INTO bug56680 SELECT 0,b,c FROM bug56680;
INSERT INTO bug56680 SELECT 0,b,c FROM bug56680;
INSERT INTO bug56680 SELECT 0,b,c FROM bug56680;
BEGIN;
SELECT b FROM bug56680 LIMIT 2;
b
x
x
BEGIN;

More results from queries before failure can be found in /home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/mysql-test/var/log/innodb_bug56680.log

Server [mysqld.1 - pid: 5214, winpid: 5214, exit: 256] failed during test run
Server log from this test:
----------SERVER LOG START-----------
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
InnoDB: DEBUG: update_statistics for test/bug56680.
110411 13:49:58 InnoDB: Assertion failure in thread 1082792256 in file /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/buf/buf0flu.c line 1192
InnoDB: Failing assertion: mutex_own(&buf_pool->mutex)
InnoDB: We intentionally generate a memory trap.
InnoDB: Submit a detailed bug report to http://bugs.mysql.com.
InnoDB: If you get repeated assertion failures or crashes, even
InnoDB: immediately after the mysqld startup, there may be
InnoDB: corruption in the InnoDB tablespace. Please refer to
InnoDB: http://dev.mysql.com/doc/refman/5.5/en/forcing-innodb-recovery.html
InnoDB: about forcing recovery.
110411 13:49:58 - mysqld got signal 6 ;
This could be because you hit a bug. It is also possible that this binary
or one of the libraries it was linked against is corrupt, improperly built,
or misconfigured. This error can also be caused by malfunctioning hardware.
We will try our best to scrape up some info that will hopefully help diagnose
the problem, but since we have already crashed, something is definitely wrong
and this may fail.

key_buffer_size=1048576
read_buffer_size=131072
max_used_connections=5
max_threads=151
thread_count=2
connection_count=2
It is possible that mysqld could use up to
key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 60913 K
bytes of memory
Hope that's ok; if not, decrease some variables in the equation.

Thread pointer: 0xe65fe00
Attempting backtrace. You can use the following information to find out
where mysqld died. If you see no messages after this, something went
terribly wrong...
stack_bottom = 0x408a10a0 thread_stack 0x40000
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(my_print_stacktrace+0x39)[0x8452c9]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(handle_segfault+0x379)[0x4fec99]
/lib64/libpthread.so.0[0x3bbe00eb10]
/lib64/libc.so.6(gsignal+0x35)[0x3bbd830265]
/lib64/libc.so.6(abort+0x110)[0x3bbd831d10]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x923458]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x919de8]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x8f492c]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x88e2f9]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x8a6c54]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x885e51]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x85f42f]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(_ZN7handler13ha_delete_rowEPKh+0x54)[0x6d49f4]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(_Z12mysql_deleteP3THDP10TABLE_LISTP4ItemP10SQL_I_ListI8st_orderEyy+0xb58)[0x7f1e68]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(_Z21mysql_execute_commandP3THD+0x57f0)[0x598770]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(_Z11mysql_parseP3THDPcjP12Parser_state+0x3cb)[0x59a6eb]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(_Z16dispatch_command19enum_server_commandP3THDPcj+0x153c)[0x59bd4c]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(_Z10do_commandP3THD+0x1cc)[0x59c20c]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(_Z24do_handle_one_connectionP3THD+0x307)[0x651fb7]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(handle_one_connection+0x54)[0x6520b4]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(pfs_spawn_thread+0x5b)[0xa5b7bb]
/lib64/libpthread.so.0[0x3bbe00673d]
/lib64/libc.so.6(clone+0x6d)[0x3bbd8d3f6d]

Trying to get some variables.
Some pointers may be invalid and cause the dump to abort.
Query (0xe5d7ad0): DELETE FROM bug56680 WHERE a=1
Connection ID (thread ID): 618
Status: NOT_KILLED

The manual page at http://dev.mysql.com/doc/mysql/en/crashing.html contains
information that should help you find out what is causing the crash.
Writing a core file
----------SERVER LOG END-------------

 - saving '/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/mysql-test/var/log/innodb.innodb_bug56680/' to '/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/mysql-test/var/log/innodb.innodb_bug56680/'
 - found 'core.5215' (0/5)

Trying 'dbx' to get a backtrace

Trying 'gdb' to get a backtrace
Core generated by '/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld'
Output from gdb follows. The first stack trace is from the failing thread.
The following stack traces are from all threads (so the failing one is
duplicated).
--------------------------
[New Thread 7534]
[New Thread 5230]
[New Thread 5229]
[New Thread 5228]
[New Thread 5227]
[New Thread 5226]
[New Thread 5225]
[New Thread 5224]
[New Thread 5222]
[New Thread 5221]
[New Thread 5220]
[New Thread 5219]
[New Thread 5218]
[New Thread 5217]
[New Thread 5215]
Core was generated by `/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld --defau'.
Program terminated with signal 6, Aborted.
#0 0x0000003bbe00bd02 in pthread_kill () from /lib64/libpthread.so.0
#0 0x0000003bbe00bd02 in pthread_kill () from /lib64/libpthread.so.0
#1 0x00000000004fecc7 in handle_segfault (sig=6) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/mysqld.cc:2553
#2 <signal handler called>
#3 0x0000003bbd830265 in raise () from /lib64/libc.so.6
#4 0x0000003bbd831d10 in abort () from /lib64/libc.so.6
#5 0x0000000000923458 in buf_flush_page_try (buf_pool=0xe3eb4e8, block=0x2aaaacb6d0b0) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/buf/buf0flu.c:1192
#6 0x0000000000919de8 in buf_page_get_gen (space=145, zip_size=0, offset=9, rw_latch=2, guess=0x0, mode=<value optimized out>,
    file=0xb6c3e8 "/home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0row.c", line=771, mtr=0x4089e990)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/buf/buf0buf.c:3791
#7 0x00000000008f492c in btr_cur_search_to_nth_level (index=0xe5ccd28, level=0, tuple=0xe65f7d8, mode=4, latch_mode=<value optimized out>, cursor=0x4089ee60, has_search_latch=0,
    file=0xb6c3e8 "/home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0row.c", line=771, mtr=0x4089e990)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/btr/btr0cur.c:616
#8 0x000000000088e2f9 in btr_pcur_open_func (index=0xe5ccd28, entry=0xe65f7d8, mode=4098, pcur=0x4089ee60, mtr=0x4089e990)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/include/btr0pcur.ic:498
#9 row_search_index_entry (index=0xe5ccd28, entry=0xe65f7d8, mode=4098, pcur=0x4089ee60, mtr=0x4089e990) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0row.c:771
#10 0x00000000008a6c54 in row_upd (thr=0xe5acd60) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0upd.c:1606
#11 row_upd_step (thr=0xe5acd60) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0upd.c:2444
#12 0x0000000000885e51 in row_update_for_mysql (mysql_rec=<value optimized out>, prebuilt=0xe632538) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0mysql.c:1464
#13 0x000000000085f42f in ha_innobase::delete_row (this=0xe65ea60, record=0xe61eab0 "\371\001") at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/handler/ha_innodb.cc:5863
#14 0x00000000006d49f4 in handler::ha_delete_row (this=0xe65ea60, buf=0xe61eab0 "\371\001") at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/handler.cc:4951
#15 0x00000000007f1e68 in mysql_delete (thd=0xe65fe00, table_list=0xe5d7bc8, conds=0xe5d8270, order_list=<value optimized out>, limit=18446744073709551615, options=0)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_delete.cc:313
#16 0x0000000000598770 in mysql_execute_command (thd=0xe65fe00) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:3019
#17 0x000000000059a6eb in mysql_parse (thd=0xe65fe00, rawbuf=<value optimized out>, length=<value optimized out>, parser_state=0x408a0c70)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:5676
#18 0x000000000059bd4c in dispatch_command (command=COM_QUERY, thd=0xe65fe00, packet=0xe59b8f1 "DELETE FROM bug56680 WHERE a=1", packet_length=30)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:1052
#19 0x000000000059c20c in do_command (thd=0xe65fe00) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:785
#20 0x0000000000651fb7 in do_handle_one_connection (thd_arg=0xe65fe00) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_connect.cc:1391
#21 0x00000000006520b4 in handle_one_connection (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_connect.cc:1314
#22 0x0000000000a5b7bb in pfs_spawn_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/perfschema/pfs.cc:1015
#23 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#24 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6
Thread 16 (Thread 5215):
#0 0x0000003bbd8cb186 in poll () from /lib64/libc.so.6
#1 0x0000000000501179 in handle_connections_sockets () at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/mysqld.cc:5312
#2 0x0000000000506c31 in mysqld_main (argc=46, argv=0xdd49918) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/mysqld.cc:4762
#3 0x0000003bbd81d994 in __libc_start_main () from /lib64/libc.so.6
#4 0x00000000004fcee9 in _start ()

Thread 15 (Thread 5217):
#0 0x0000003199c005b4 in ?? () from /usr/lib64/libaio.so.1
#1 0x00000000009b3bf8 in os_aio_linux_collect (global_seg=0, message1=0x426a1100, message2=0x426a10f8, type=0x426a10f0, space_id=0x426a10e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4481
#2 os_aio_linux_handle (global_seg=0, message1=0x426a1100, message2=0x426a10f8, type=0x426a10f0, space_id=0x426a10e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4615
#3 0x0000000000957942 in fil_aio_wait (segment=0) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/fil/fil0fil.c:5155
#4 0x00000000008b18f0 in io_handler_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/srv/srv0start.c:483
#5 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#6 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 14 (Thread 5218):
#0 0x0000003199c005b4 in ?? () from /usr/lib64/libaio.so.1
#1 0x00000000009b3bf8 in os_aio_linux_collect (global_seg=1, message1=0x430a2100, message2=0x430a20f8, type=0x430a20f0, space_id=0x430a20e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4481
#2 os_aio_linux_handle (global_seg=1, message1=0x430a2100, message2=0x430a20f8, type=0x430a20f0, space_id=0x430a20e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4615
#3 0x0000000000957942 in fil_aio_wait (segment=1) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/fil/fil0fil.c:5155
#4 0x00000000008b18f0 in io_handler_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/srv/srv0start.c:483
#5 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#6 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 13 (Thread 5219):
#0 0x0000003199c005b4 in ?? () from /usr/lib64/libaio.so.1
#1 0x00000000009b3bf8 in os_aio_linux_collect (global_seg=2, message1=0x43aa3100, message2=0x43aa30f8, type=0x43aa30f0, space_id=0x43aa30e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4481
#2 os_aio_linux_handle (global_seg=2, message1=0x43aa3100, message2=0x43aa30f8, type=0x43aa30f0, space_id=0x43aa30e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4615
#3 0x0000000000957942 in fil_aio_wait (segment=2) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/fil/fil0fil.c:5155
#4 0x00000000008b18f0 in io_handler_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/srv/srv0start.c:483
#5 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#6 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 12 (Thread 5220):
#0 0x0000003199c005b4 in ?? () from /usr/lib64/libaio.so.1
#1 0x00000000009b3bf8 in os_aio_linux_collect (global_seg=3, message1=0x444a4100, message2=0x444a40f8, type=0x444a40f0, space_id=0x444a40e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4481
#2 os_aio_linux_handle (global_seg=3, message1=0x444a4100, message2=0x444a40f8, type=0x444a40f0, space_id=0x444a40e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4615
#3 0x0000000000957942 in fil_aio_wait (segment=3) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/fil/fil0fil.c:5155
#4 0x00000000008b18f0 in io_handler_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/srv/srv0start.c:483
#5 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#6 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 11 (Thread 5221):
#0 0x0000003199c005b4 in ?? () from /usr/lib64/libaio.so.1
#1 0x00000000009b3bf8 in os_aio_linux_collect (global_seg=4, message1=0x44ea5100, message2=0x44ea50f8, type=0x44ea50f0, space_id=0x44ea50e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4481
#2 os_aio_linux_handle (global_seg=4, message1=0x44ea5100, message2=0x44ea50f8, type=0x44ea50f0, space_id=0x44ea50e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4615
#3 0x0000000000957942 in fil_aio_wait (segment=4) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/fil/fil0fil.c:5155
#4 0x00000000008b18f0 in io_handler_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/srv/srv0start.c:483
#5 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#6 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 10 (Thread 5222):
#0 0x0000003199c005b4 in ?? () from /usr/lib64/libaio.so.1
#1 0x00000000009b3bf8 in os_aio_linux_collect (global_seg=5, message1=0x458a6100, message2=0x458a60f8, type=0x458a60f0, space_id=0x458a60e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4481
#2 os_aio_linux_handle (global_seg=5, message1=0x458a6100, message2=0x458a60f8, type=0x458a60f0, space_id=0x458a60e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4615
#3 0x0000000000957942 in fil_aio_wait (segment=5) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/fil/fil0fil.c:5155
#4 0x00000000008b18f0 in io_handler_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/srv/srv0start.c:483
#5 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#6 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 9 (Thread 5224):
#0 0x0000003bbe00b150 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
#1 0x000000000084b8c2 in safe_cond_timedwait (cond=0xe18a918, mp=0xe18a8a0, abstime=0x462a70a0, file=0xffffffffffffff92 <Address 0xffffffffffffff92 out of bounds>, line=171)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/mysys/thr_mutex.c:278
#2 0x00000000009b67a7 in os_cond_wait_timed (event=0xe18a8a0, time_in_usec=<value optimized out>, reset_sig_count=<value optimized out>)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0sync.c:171
#3 os_event_wait_time_low (event=0xe18a8a0, time_in_usec=<value optimized out>, reset_sig_count=<value optimized out>)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0sync.c:743
#4 0x00000000008af0f1 in srv_lock_timeout_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/srv/srv0srv.c:2670
#5 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#6 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 8 (Thread 5225):
#0 0x0000003bbe00b150 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
#1 0x000000000084b8c2 in safe_cond_timedwait (cond=0xe18a858, mp=0xe18a7e0, abstime=0x46ca8050, file=0xffffffffffffff92 <Address 0xffffffffffffff92 out of bounds>, line=171)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/mysys/thr_mutex.c:278
#2 0x00000000009b67a7 in os_cond_wait_timed (event=0xe18a7e0, time_in_usec=<value optimized out>, reset_sig_count=<value optimized out>)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0sync.c:171
#3 os_event_wait_time_low (event=0xe18a7e0, time_in_usec=<value optimized out>, reset_sig_count=<value optimized out>)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0sync.c:743
#4 0x00000000008b1438 in srv_error_monitor_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/srv/srv0srv.c:2843
#5 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#6 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 7 (Thread 5226):
#0 0x0000003bbe00b150 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
#1 0x000000000084b8c2 in safe_cond_timedwait (cond=0xe18a9d8, mp=0xe18a960, abstime=0x476a9090, file=0xffffffffffffff92 <Address 0xffffffffffffff92 out of bounds>, line=171)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/mysys/thr_mutex.c:278
#2 0x00000000009b67a7 in os_cond_wait_timed (event=0xe18a960, time_in_usec=<value optimized out>, reset_sig_count=<value optimized out>)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0sync.c:171
#3 os_event_wait_time_low (event=0xe18a960, time_in_usec=<value optimized out>, reset_sig_count=<value optimized out>)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0sync.c:743
#4 0x00000000008b08ab in srv_monitor_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/srv/srv0srv.c:2520
#5 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#6 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 6 (Thread 5227):
#0 0x0000003bbd8cd212 in select () from /lib64/libc.so.6
#1 0x00000000009b755f in os_thread_sleep (tm=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0thread.c:274
#2 0x00000000008ab4ac in srv_LRU_dump_restore_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/srv/srv0srv.c:2887
#3 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#4 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 5 (Thread 5228):
#0 0x0000003bbd8cd212 in select () from /lib64/libc.so.6
#1 0x00000000009b755f in os_thread_sleep (tm=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0thread.c:274
#2 0x00000000008acfa2 in srv_master_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/srv/srv0srv.c:3195
#3 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#4 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 4 (Thread 5229):
#0 0x0000003bbd8cd212 in select () from /lib64/libc.so.6
#1 0x00000000009b755f in os_thread_sleep (tm=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0thread.c:274
#2 0x00000000008b10b3 in srv_purge_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/srv/srv0srv.c:3876
#3 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#4 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 3 (Thread 5230):
#0 0x0000003bbe00e838 in do_sigwait () from /lib64/libpthread.so.0
#1 0x0000003bbe00e8dd in sigwait () from /lib64/libpthread.so.0
#2 0x000000000050246c in signal_hand (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/mysqld.cc:2746
#3 0x0000000000a5b7bb in pfs_spawn_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/perfschema/pfs.cc:1015
#4 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#5 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 2 (Thread 7534):
#0 0x0000003bbe00d91b in read () from /lib64/libpthread.so.0
#1 0x0000000000a922fa in vio_read (vio=0xe5c8030, buf=0xe666c90 "\001", size=4) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/vio/viosocket.c:44
#2 0x000000000050a249 in my_real_read (net=0xe615170, complen=0x415d8ef0) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/net_serv.cc:832
#3 0x000000000050a53e in my_net_read (net=0x13) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/net_serv.cc:1029
#4 0x000000000059c164 in do_command (thd=0xe614ef0) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:731
#5 0x0000000000651fb7 in do_handle_one_connection (thd_arg=0xe614ef0) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_connect.cc:1391
#6 0x00000000006520b4 in handle_one_connection (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_connect.cc:1314
#7 0x0000000000a5b7bb in pfs_spawn_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/perfschema/pfs.cc:1015
#8 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#9 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 1 (Thread 7536):
#0 0x0000003bbe00bd02 in pthread_kill () from /lib64/libpthread.so.0
#1 0x00000000004fecc7 in handle_segfault (sig=6) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/mysqld.cc:2553
#2 <signal handler called>
#3 0x0000003bbd830265 in raise () from /lib64/libc.so.6
#4 0x0000003bbd831d10 in abort () from /lib64/libc.so.6
#5 0x0000000000923458 in buf_flush_page_try (buf_pool=0xe3eb4e8, block=0x2aaaacb6d0b0) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/buf/buf0flu.c:1192
#6 0x0000000000919de8 in buf_page_get_gen (space=145, zip_size=0, offset=9, rw_latch=2, guess=0x0, mode=<value optimized out>,
    file=0xb6c3e8 "/home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0row.c", line=771, mtr=0x4089e990)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/buf/buf0buf.c:3791
#7 0x00000000008f492c in btr_cur_search_to_nth_level (index=0xe5ccd28, level=0, tuple=0xe65f7d8, mode=4, latch_mode=<value optimized out>, cursor=0x4089ee60, has_search_latch=0,
    file=0xb6c3e8 "/home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0row.c", line=771, mtr=0x4089e990)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/btr/btr0cur.c:616
#8 0x000000000088e2f9 in btr_pcur_open_func (index=0xe5ccd28, entry=0xe65f7d8, mode=4098, pcur=0x4089ee60, mtr=0x4089e990)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/include/btr0pcur.ic:498
#9 row_search_index_entry (index=0xe5ccd28, entry=0xe65f7d8, mode=4098, pcur=0x4089ee60, mtr=0x4089e990) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0row.c:771
#10 0x00000000008a6c54 in row_upd (thr=0xe5acd60) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0upd.c:1606
#11 row_upd_step (thr=0xe5acd60) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0upd.c:2444
#12 0x0000000000885e51 in row_update_for_mysql (mysql_rec=<value optimized out>, prebuilt=0xe632538) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0mysql.c:1464
#13 0x000000000085f42f in ha_innobase::delete_row (this=0xe65ea60, record=0xe61eab0 "\371\001") at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/handler/ha_innodb.cc:5863
#14 0x00000000006d49f4 in handler::ha_delete_row (this=0xe65ea60, buf=0xe61eab0 "\371\001") at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/handler.cc:4951
#15 0x00000000007f1e68 in mysql_delete (thd=0xe65fe00, table_list=0xe5d7bc8, conds=0xe5d8270, order_list=<value optimized out>, limit=18446744073709551615, options=0)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_delete.cc:313
#16 0x0000000000598770 in mysql_execute_command (thd=0xe65fe00) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:3019
#17 0x000000000059a6eb in mysql_parse (thd=0xe65fe00, rawbuf=<value optimized out>, length=<value optimized out>, parser_state=0x408a0c70)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:5676
#18 0x000000000059bd4c in dispatch_command (command=COM_QUERY, thd=0xe65fe00, packet=0xe59b8f1 "DELETE FROM bug56680 WHERE a=1", packet_length=30)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:1052
#19 0x000000000059c20c in do_command (thd=0xe65fe00) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:785
#20 0x0000000000651fb7 in do_handle_one_connection (thd_arg=0xe65fe00) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_connect.cc:1391
#21 0x00000000006520b4 in handle_one_connection (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_connect.cc:1314
#22 0x0000000000a5b7bb in pfs_spawn_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/perfschema/pfs.cc:1015
#23 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#24 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Changed in percona-projects-qa:
status: New → Confirmed
assignee: nobody → Yasufumi Kinoshita (yasufumi-kinoshita)

The added debug code for the bug56680 (http://lists.mysql.com/commits/121051) was not applied innodb_split_buf_pool_mutex.patch yet.

It is only for DEBUG code. Not affects to normal binary.

I will look soon.

Alexey Kopytov (akopytov) wrote :

See also https://bugs.launchpad.net/bugs/759441, it may be related.

Currently, 5.1.x has similar problem to this bug of 5.5.
Anyway, I will fix also 5.1 after 5.5.
But I think bug759441 might not related, for now.

Please excuse the direct push.

5.5.11/ rev.106
5.1.56/ rev.221

Changed in percona-projects-qa:
status: Confirmed → Fix Committed
Changed in percona-projects-qa:
status: Fix Committed → Fix Released
To post a comment you must log in.
This report contains Public information  Edit
Everyone can see this information.

Other bug subscribers