percona-projects-qa

innodb.innodb_bug52745 sporadically fails in 5.5.11

Bug #746526 reported by Alexey Kopytov on 2011-03-31

This bug report is a duplicate of: Bug #756391: The innodb.innodb-zip fails in 5.5.11. Edit Remove

This bug affects 1 person

Affects		Status	Importance	Assigned to	Milestone
	percona-projects-qa	New	Undecided	Unassigned

Bug Description

I get the following server crash when running innodb.innodb_bug52745 on Mac OS X. It may be applicable to other non-Linux platforms as well.

innodb.innodb_bug52745 [ fail ]
Test ended at 2011-03-31 19:44:45

CURRENT_TEST: innodb.innodb_bug52745
mysqltest: At line 67: query 'INSERT INTO bug52745 SET
col40='0000-00-00 00:00:00',
col51=16547,
col53='7711484',
col54=-28604,
col55='7112612',
col56='wakefulness\'',
col57=repeat('absorbefacient\'',106),
col58=11027,
col59='AM09gW7',
col60=repeat('Noelani\'',16),
col61='2520576',
col62='substitutiv',
col63='19950106155112',
col64=-12038,
col65='86238806',
col66='19600719080256',
col68=repeat('Sagittarius\'',54),
col69='38943902',
col70=1232,
col71='Elora\'',
col74=repeat('zipp',11),
col75='0',
col76=23254,
col78=13247,
col79='56219',
col80='20500609035724',
col81=11632,
col82=7,
col84=-23863,
col85=6341,
col87='HZdkf.4 s7t,5Rmq 8so fmr,ruGLUG25TrtI.yQ 2SuHq0ML7rw7.4 b2yf2E5TJxOtBBZImezDnzpj,uPYfznnEUDN1e9aQoO 2DsplB7TFWy oQJ br HLF :F,eQ p4i1oWsr lL3PG,hjCz6hYqN h1QTjLCjrv:QCdSzpYBibJAtZCxLOk3l6Blsh.W',
col88=16894,
col89=6161,
col90=repeat('gale',48)' failed: 2013: Lost connection to MySQL server during query

The result from queries just before the failure was:
< snip >
col75 bit(34) DEFAULT NULL,
col76 float unsigned zerofill DEFAULT NULL,
col77 year(2) DEFAULT NULL,
col78 tinyint(3) unsigned DEFAULT NULL,
col79 set('msfheowh','tbpxbgf','by','wahnrjw','myqfasxz','rsokyumrt') CHARACTER SET latin2 DEFAULT NULL,
col80 datetime DEFAULT NULL,
col81 smallint(6) DEFAULT NULL,
col82 enum('xtaurnqfqz','rifrse','kuzwpbvb','niisabk','zxavro','rbvasv','','uulrfaove','','') DEFAULT NULL,
col83 bigint(20) unsigned zerofill DEFAULT NULL,
col84 float unsigned zerofill DEFAULT NULL,
col85 double DEFAULT NULL,
col86 enum('ylannv','','vlkhycqc','snke','cxifustp','xiaxaswzp','oxl') CHARACTER SET latin1 COLLATE latin1_german2_ci DEFAULT NULL,
col87 varbinary(221) DEFAULT NULL,
col88 double unsigned DEFAULT NULL,
col89 float unsigned zerofill DEFAULT NULL,
col90 tinyblob
) ENGINE=InnoDB DEFAULT CHARSET=latin1 ROW_FORMAT=COMPRESSED KEY_BLOCK_SIZE=1;
Warnings:
Note 1291 Column 'col82' has duplicated value '' in ENUM
Note 1291 Column 'col82' has duplicated value '' in ENUM

More results from queries before failure can be found in /Users/kaa/src/percona/5.5/Percona-Server-debug/mysql-test/var/log/innodb_bug52745.log

Server [mysqld.1 - pid: 9904, winpid: 9904, exit: 256] failed during test run
Server log from this test:
----------SERVER LOG START-----------
110331 18:44:40 [Warning] Setting lower_case_table_names=2 because file system for /Users/kaa/src/percona/5.5/Percona-Server-debug/mysql-test/var/mysqld.1/data/ is case insensitive
110331 18:44:40 InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
110331 18:44:40 InnoDB: The InnoDB memory heap is disabled
110331 18:44:40 InnoDB: Mutexes and rw_locks use GCC atomic builtins
110331 18:44:40 InnoDB: Compressed tables use zlib 1.2.3
110331 18:44:40 InnoDB: Initializing buffer pool, size = 32.0M
110331 18:44:40 InnoDB: Completed initialization of buffer pool
110331 18:44:40 InnoDB: highest supported file format is Barracuda.
110331 18:44:40 InnoDB: Waiting for the background threads to start
110331 18:44:41 Percona XtraDB (http://www.percona.com) 1.1.5-12.1 started; log sequence number 1597945
110331 18:44:41 [Note] Event Scheduler: Loaded 0 events
110331 18:44:41 [Note] /Users/kaa/src/percona/5.5/Percona-Server-debug/sql/mysqld: ready for connections.
Version: '5.5.10-debug-log' socket: '/Users/kaa/src/percona/5.5/Percona-Server-debug/mysql-test/var/tmp/mysqld.1.sock' port: 13000 Source distribution
InnoDB: DEBUG: update_statistics for test/bug52745.
InnoDB: DEBUG: update_statistics for test/bug52745.
110331 18:44:42 InnoDB: Assertion failure in thread 4401729536 in file /Users/kaa/src/percona/5.5/Percona-Server/storage/innobase/buf/buf0buf.c line 2422
InnoDB: Failing assertion: buf_page_in_file(bpage)
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.
110331 18:44:42 - 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=1
max_threads=151
thread_count=1
connection_count=1
It is possible that mysqld could use up to
key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 60917 K
bytes of memory
Hope that's ok; if not, decrease some variables in the equation.

Thread pointer: 0x0
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 = 0x0 thread_stack 0x40000
0 mysqld 0x00000001003874c9 my_print_stacktrace + 57
1 mysqld 0x0000000100144ed2 handle_segfault + 834
2 libSystem.B.dylib 0x00007fff8393d66a _sigtramp + 26
3 mysqld 0x0000000100000000 __dso_handle + 0
4 mysqld 0x000000010014e0cf _Z11mysqld_mainiPPc + 2383
5 mysqld 0x00000001000221a0 start + 52
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-------------

Revision history for this message

Alexey Kopytov (akopytov) wrote on 2011-04-11:

Download full text (29.9 KiB)

The failure is sporadic and can be observed on Linux as well:

innodb.innodb_bug52745 [ fail ]
Test ended at 2011-04-10 04:33:53

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_bug52745.log

The failure is sporadic and can be observed on Linux as well:

innodb.innodb_bug52745                   [ fail ]
        Test ended at 2011-04-10 04:33:53

CURRENT_TEST: innodb.innodb_bug52745
mysqltest: At line 67: query 'INSERT INTO bug52745 SET
col40='0000-00-00 00:00:00',
col51=16547,
col53='7711484',
col54=-28604,
col55='7112612',
col56='wakefulness\'',
col57=repeat('absorbefacient\'',106),
col58=11027,
col59='AM09gW7',
col60=repeat('Noelani\'',16),
col61='2520576',
col62='substitutiv',
col63='19950106155112',
col64=-12038,
col65='86238806',
col66='19600719080256',
col68=repeat('Sagittarius\'',54),
col69='38943902',
col70=1232,
col71='Elora\'',
col74=repeat('zipp',11),
col75='0',
col76=23254,
col78=13247,
col79='56219',
col80='20500609035724',
col81=11632,
col82=7,
col84=-23863,
col85=6341,
col87='HZdkf.4 s7t,5Rmq 8so fmr,ruGLUG25TrtI.yQ 2SuHq0ML7rw7.4 b2yf2E5TJxOtBBZImezDnzpj,uPYfznnEUDN1e9aQoO 2DsplB7TFWy  oQJ br  HLF :F,eQ p4i1oWsr lL3PG,hjCz6hYqN h1QTjLCjrv:QCdSzpYBibJAtZCxLOk3l6Blsh.W',
col88=16894,
col89=6161,
col90=repeat('gale',48)' failed: 2013: Lost connection to MySQL server during query

The result from queries just before the failure was:
< snip >
col75 bit(34) DEFAULT NULL,
col76 float unsigned zerofill DEFAULT NULL,
col77 year(2) DEFAULT NULL,
col78 tinyint(3) unsigned DEFAULT NULL,
col79 set('msfheowh','tbpxbgf','by','wahnrjw','myqfasxz','rsokyumrt') CHARACTER SET latin2 DEFAULT NULL,
col80 datetime DEFAULT NULL,
col81 smallint(6) DEFAULT NULL,
col82 enum('xtaurnqfqz','rifrse','kuzwpbvb','niisabk','zxavro','rbvasv','','uulrfaove','','') DEFAULT NULL,
col83 bigint(20) unsigned zerofill DEFAULT NULL,
col84 float unsigned zerofill DEFAULT NULL,
col85 double DEFAULT NULL,
col86 enum('ylannv','','vlkhycqc','snke','cxifustp','xiaxaswzp','oxl') CHARACTER SET latin1 COLLATE latin1_german2_ci DEFAULT NULL,
col87 varbinary(221) DEFAULT NULL,
col88 double unsigned DEFAULT NULL,
col89 float unsigned zerofill DEFAULT NULL,
col90 tinyblob
) ENGINE=InnoDB DEFAULT CHARSET=latin1 ROW_FORMAT=COMPRESSED KEY_BLOCK_SIZE=1;
Warnings:
Note    1291    Column 'col82' has duplicated value '' in ENUM
Note    1291    Column 'col82' has duplicated value '' in ENUM

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_bug52745.log

Server [mysqld.1 - pid: 9133, winpid: 9133, exit: 256] failed during test run
Server log from this test:
----------SERVER LOG START-----------
InnoDB: DEBUG: update_statistics for test/bug52745.
InnoDB: DEBUG: update_statistics for test/bug52745.
110410 14:33:53  InnoDB: Assertion failure in thread 1094277440 in file /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/buf/buf0buf.c line 2422
InnoDB: Failing assertion: buf_page_in_file(bpage)
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.
110410 14:33:53 - 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=1
connection_count=1
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: 0xd9e4b70
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 = 0x413950a0 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[0x91041e]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x92267f]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x92c35a]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x8f5f08]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x8f7362]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x9eb4b5]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x9ebdba]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x9ec2df]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x88959f]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld[0x869e2b]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(_ZN7handler12ha_write_rowEPh+0x8f)[0x6d4f7f]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(_Z12write_recordP3THDP5TABLEP12st_copy_info+0x8b)[0x57962b]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(_Z12mysql_insertP3THDP10TABLE_LISTR4ListI4ItemERS3_IS5_ES6_S6_15enum_duplicatesb+0xc44)[0x582ab4]
/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/sql/mysqld(_Z21mysql_execute_commandP3THD+0x56aa)[0x59862a]
/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)[0xa5b19b]
/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 (0xda74c90): INSERT INTO bug52745 SET col40='0000-00-00 00:00:00', col51=16547, col53='7711484', col54=-28604, col55='7112612', col56='wakefulness\'', col57=repeat('absorbefacient\'',106), col58=11027, col59='AM09gW7', col60=repeat('Noelani\'',16), col61='2520576', col62='substitutiv', col63='19950106155112', col64=-12038, col65='86238806', col66='19600719080256', col68=repeat('Sagittarius\'',54), col69
='38943902', col70=1232, col71='Elora\'', col74=repeat('zipp',11), col75='0', col76=23254, col78=13247, col79='56219', col80='20500609035724', col81=11632, col82=7, col84=-23863, col85=6341, col87='HZdkf.4 s7t,5Rmq 8so fmr,ruGLUG25TrtI.yQ 2SuHq0ML7rw7.4 b2yf2E5TJxOtBBZImezDnzpj,uPYfznnEUDN1e9aQoO 2DsplB7TFWy oQJ br  HLF :F,eQ p4i1oWsr lL3PG,hjCz6hYqN h1QTjLCjrv:QCdSzpYBibJAtZCxLOk3l6Blsh.W', col88=16894, col89=6161, col90=repeat('gale',48)
Connection ID (thread ID): 131
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_bug52745/' to '/home/alexey.kopytov/src/percona/5.5.11/Percona-Server-debug/mysql-test/var/log/innodb.innodb_bug52745/'
 - found 'core.9134' (2/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 9149]
[New Thread 9148]
[New Thread 9147]
[New Thread 9146]
[New Thread 9145]
[New Thread 9144]
[New Thread 9143]
[New Thread 9141]
[New Thread 9140]
[New Thread 9139]
[New Thread 9138]
[New Thread 9137]
[New Thread 9136]
[New Thread 9134]
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  0x000000000091041e in buf_pool_watch_is_sentinel (buf_pool=0xd8414e8, bpage=0x2aaaacad5490) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/buf/buf0buf.c:2422
#6  0x000000000092267f in buf_page_get_mutex (bpage=0x2aaaacad5490, dpage=0x2aaaacd5d400) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/include/buf0buf.ic:320
#7  buf_flush_relocate_on_flush_list (bpage=0x2aaaacad5490, dpage=0x2aaaacd5d400) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/buf/buf0flu.c:588
#8  0x000000000092c35a in buf_LRU_free_block (bpage=0x2aaaacad5490, zip=0, have_LRU_mutex=1) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/buf/buf0lru.c:1753
#9  0x00000000008f5f08 in btr_blob_free (block=0x2aaaacad5490, all=0, mtr=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/btr/btr0cur.c:4172
#10 0x00000000008f7362 in btr_store_big_rec_extern_fields_func (index=0xdb4ae28, rec_block=<value optimized out>, rec=0x2aaaacd4c091 "", offsets=0xda54348, local_mtr=<value optimized out>, 
    update_in_place=<value optimized out>, big_rec_vec=0xdb5bae8) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/btr/btr0cur.c:4500
#11 0x00000000009eb4b5 in row_ins_index_entry_low (mode=<value optimized out>, index=0xdb4ae28, entry=0xdacd768, n_ext=0, thr=<value optimized out>)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0ins.c:2131
#12 0x00000000009ebdba in row_ins_index_entry_step (node=0xda9e448, thr=0xda9f538) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0ins.c:2180
#13 row_ins (node=0xda9e448, thr=0xda9f538) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0ins.c:2397
#14 0x00000000009ec2df in row_ins_step (thr=0xda9f538) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0ins.c:2507
#15 0x000000000088959f in row_insert_for_mysql (mysql_rec=0xdacf160 "\377_", prebuilt=0xdb4abb8) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0mysql.c:1218
#16 0x0000000000869e2b in ha_innobase::write_row (this=0xda06ef0, record=0xdacf160 "\377_") at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/handler/ha_innodb.cc:5450
#17 0x00000000006d4f7f in handler::ha_write_row (this=0xda06ef0, buf=0xdacf160 "\377_") at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/handler.cc:4909
#18 0x000000000057962b in write_record (thd=0xd9e4b70, table=0xdad3280, info=0x41393670) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_insert.cc:1737
#19 0x0000000000582ab4 in mysql_insert (thd=0xd9e4b70, table_list=0xda753d8, fields=..., values_list=..., update_fields=..., update_values=..., duplic=DUP_ERROR, ignore=false)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_insert.cc:928
#20 0x000000000059862a in mysql_execute_command (thd=0xd9e4b70) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:2917
#21 0x000000000059a6eb in mysql_parse (thd=0xd9e4b70, rawbuf=<value optimized out>, length=<value optimized out>, parser_state=0x41394c70)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:5676
#22 0x000000000059bd4c in dispatch_command (command=COM_QUERY, thd=0xd9e4b70, 
    packet=0xdad5021 "INSERT INTO bug52745 SET\ncol40='0000-00-00 00:00:00',\ncol51=16547,\ncol53='7711484',\ncol54=-28604,\ncol55='7112612',\ncol56='wakefulness\\'',\ncol57=repeat('absorbefacient\\'',106),\ncol58=11027,\ncol59='AM09"..., packet_length=836) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:1052
#23 0x000000000059c20c in do_command (thd=0xd9e4b70) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:785
#24 0x0000000000651fb7 in do_handle_one_connection (thd_arg=0xd9e4b70) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_connect.cc:1391
#25 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
#26 0x0000000000a5b19b in pfs_spawn_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/perfschema/pfs.cc:1015
#27 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#28 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

Thread 15 (Thread 9134):
#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=0xd19f918) 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 14 (Thread 9136):
#0  0x0000003199c005b4 in ?? () from /usr/lib64/libaio.so.1
#1  0x00000000009b35f8 in os_aio_linux_collect (global_seg=0, message1=0x41291100, message2=0x412910f8, type=0x412910f0, space_id=0x412910e8)
    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=0x41291100, message2=0x412910f8, type=0x412910f0, space_id=0x412910e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4615
#3  0x0000000000957382 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 13 (Thread 9137):
#0  0x0000003199c005b4 in ?? () from /usr/lib64/libaio.so.1
#1  0x00000000009b35f8 in os_aio_linux_collect (global_seg=1, message1=0x42503100, message2=0x425030f8, type=0x425030f0, space_id=0x425030e8)
    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=0x42503100, message2=0x425030f8, type=0x425030f0, space_id=0x425030e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4615
#3  0x0000000000957382 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 12 (Thread 9138):
#0  0x0000003199c005b4 in ?? () from /usr/lib64/libaio.so.1
#1  0x00000000009b35f8 in os_aio_linux_collect (global_seg=2, message1=0x42f04100, message2=0x42f040f8, type=0x42f040f0, space_id=0x42f040e8)
    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=0x42f04100, message2=0x42f040f8, type=0x42f040f0, space_id=0x42f040e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4615
#3  0x0000000000957382 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 11 (Thread 9139):
#0  0x0000003199c005b4 in ?? () from /usr/lib64/libaio.so.1
#1  0x00000000009b35f8 in os_aio_linux_collect (global_seg=3, message1=0x43905100, message2=0x439050f8, type=0x439050f0, space_id=0x439050e8)
    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=0x43905100, message2=0x439050f8, type=0x439050f0, space_id=0x439050e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4615
#3  0x0000000000957382 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 10 (Thread 9140):
#0  0x0000003199c005b4 in ?? () from /usr/lib64/libaio.so.1
#1  0x00000000009b35f8 in os_aio_linux_collect (global_seg=4, message1=0x44306100, message2=0x443060f8, type=0x443060f0, space_id=0x443060e8)
    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=0x44306100, message2=0x443060f8, type=0x443060f0, space_id=0x443060e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4615
#3  0x0000000000957382 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 9 (Thread 9141):
#0  0x0000003199c005b4 in ?? () from /usr/lib64/libaio.so.1
#1  0x00000000009b35f8 in os_aio_linux_collect (global_seg=5, message1=0x44d07100, message2=0x44d070f8, type=0x44d070f0, space_id=0x44d070e8)
    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=0x44d07100, message2=0x44d070f8, type=0x44d070f0, space_id=0x44d070e8)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/os/os0file.c:4615
#3  0x0000000000957382 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 8 (Thread 9143):
#0  0x0000003bbe00b150 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
#1  0x000000000084b8c2 in safe_cond_timedwait (cond=0xd5e0918, mp=0xd5e08a0, abstime=0x461090a0, 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  0x00000000009b61a7 in os_cond_wait_timed (event=0xd5e08a0, 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=0xd5e08a0, 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 7 (Thread 9144):
#0  0x0000003bbe00b150 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
#1  0x000000000084b8c2 in safe_cond_timedwait (cond=0xd5e0858, mp=0xd5e07e0, abstime=0x46b0a050, 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  0x00000000009b61a7 in os_cond_wait_timed (event=0xd5e07e0, 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=0xd5e07e0, 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 6 (Thread 9145):
#0  0x0000003bbe00b150 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
#1  0x000000000084b8c2 in safe_cond_timedwait (cond=0xd5e09d8, mp=0xd5e0960, abstime=0x4750b090, 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  0x00000000009b61a7 in os_cond_wait_timed (event=0xd5e0960, 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=0xd5e0960, 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 5 (Thread 9146):
#0  0x0000003bbd8cd212 in select () from /lib64/libc.so.6
#1  0x00000000009b6f5f 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 4 (Thread 9147):
#0  0x0000003bbd8cd212 in select () from /lib64/libc.so.6
#1  0x00000000009b6f5f 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 3 (Thread 9148):
#0  0x0000003bbd8cd212 in select () from /lib64/libc.so.6
#1  0x00000000009b6f5f 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 2 (Thread 9149):
#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  0x0000000000a5b19b 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 1 (Thread 9636):
#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  0x000000000091041e in buf_pool_watch_is_sentinel (buf_pool=0xd8414e8, bpage=0x2aaaacad5490) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/buf/buf0buf.c:2422
#6  0x000000000092267f in buf_page_get_mutex (bpage=0x2aaaacad5490, dpage=0x2aaaacd5d400) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/include/buf0buf.ic:320
#7  buf_flush_relocate_on_flush_list (bpage=0x2aaaacad5490, dpage=0x2aaaacd5d400) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/buf/buf0flu.c:588
#8  0x000000000092c35a in buf_LRU_free_block (bpage=0x2aaaacad5490, zip=0, have_LRU_mutex=1) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/buf/buf0lru.c:1753
#9  0x00000000008f5f08 in btr_blob_free (block=0x2aaaacad5490, all=0, mtr=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/btr/btr0cur.c:4172
#10 0x00000000008f7362 in btr_store_big_rec_extern_fields_func (index=0xdb4ae28, rec_block=<value optimized out>, rec=0x2aaaacd4c091 "", offsets=0xda54348, local_mtr=<value optimized out>, 
    update_in_place=<value optimized out>, big_rec_vec=0xdb5bae8) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/btr/btr0cur.c:4500
#11 0x00000000009eb4b5 in row_ins_index_entry_low (mode=<value optimized out>, index=0xdb4ae28, entry=0xdacd768, n_ext=0, thr=<value optimized out>)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0ins.c:2131
#12 0x00000000009ebdba in row_ins_index_entry_step (node=0xda9e448, thr=0xda9f538) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0ins.c:2180
#13 row_ins (node=0xda9e448, thr=0xda9f538) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0ins.c:2397
#14 0x00000000009ec2df in row_ins_step (thr=0xda9f538) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0ins.c:2507
#15 0x000000000088959f in row_insert_for_mysql (mysql_rec=0xdacf160 "\377_", prebuilt=0xdb4abb8) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/row/row0mysql.c:1218
#16 0x0000000000869e2b in ha_innobase::write_row (this=0xda06ef0, record=0xdacf160 "\377_") at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/innobase/handler/ha_innodb.cc:5450
#17 0x00000000006d4f7f in handler::ha_write_row (this=0xda06ef0, buf=0xdacf160 "\377_") at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/handler.cc:4909
#18 0x000000000057962b in write_record (thd=0xd9e4b70, table=0xdad3280, info=0x41393670) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_insert.cc:1737
#19 0x0000000000582ab4 in mysql_insert (thd=0xd9e4b70, table_list=0xda753d8, fields=..., values_list=..., update_fields=..., update_values=..., duplic=DUP_ERROR, ignore=false)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_insert.cc:928
#20 0x000000000059862a in mysql_execute_command (thd=0xd9e4b70) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:2917
#21 0x000000000059a6eb in mysql_parse (thd=0xd9e4b70, rawbuf=<value optimized out>, length=<value optimized out>, parser_state=0x41394c70)
    at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:5676
#22 0x000000000059bd4c in dispatch_command (command=COM_QUERY, thd=0xd9e4b70, 
    packet=0xdad5021 "INSERT INTO bug52745 SET\ncol40='0000-00-00 00:00:00',\ncol51=16547,\ncol53='7711484',\ncol54=-28604,\ncol55='7112612',\ncol56='wakefulness\\'',\ncol57=repeat('absorbefacient\\'',106),\ncol58=11027,\ncol59='AM09"..., packet_length=836) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:1052
#23 0x000000000059c20c in do_command (thd=0xd9e4b70) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_parse.cc:785
#24 0x0000000000651fb7 in do_handle_one_connection (thd_arg=0xd9e4b70) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/sql/sql_connect.cc:1391
#25 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
#26 0x0000000000a5b19b in pfs_spawn_thread (arg=<value optimized out>) at /home/alexey.kopytov/src/percona/5.5.11/Percona-Server/storage/perfschema/pfs.cc:1015
#27 0x0000003bbe00673d in start_thread () from /lib64/libpthread.so.0
#28 0x0000003bbd8d3f6d in clone () from /lib64/libc.so.6

summary:

- innodb.innodb_bug52745 crashes the server on Mac OS X
+ innodb.innodb_bug52745 sporadically fails in 5.5.11

Yasufumi Kinoshita (yasufumi-kinoshita) on 2011-04-14