# 17:01:08 Server crash reported, initiating post-crash analysis... # 17:01:08 The last 100 lines from /mysql-5.1/mysql-test/var/master-data/../log/master.err : CURRENT_TEST: main.1st 091002 0:00:41 [Warning] The syntax '--log' is deprecated and will be removed in MySQL 7.0. Please use '--general_log'/'--general_log_file' instead. 091002 0:00:41 [Warning] The syntax '--log_slow_queries' is deprecated and will be removed in MySQL 7.0. Please use '--slow_query_log'/'--slow_query_log_file' instead. 091002 0:00:41 [Note] Plugin 'FEDERATED' is disabled. InnoDB: The InnoDB memory heap is disabled InnoDB: Mutexes and rw_locks use GCC atomic builtins. InnoDB: The first specified data file ./ibdata1 did not exist: InnoDB: a new database to be created! 091002 0:00:42 InnoDB: Setting file ./ibdata1 size to 10 MB InnoDB: Database physically writes the file full: wait... 091002 0:00:42 InnoDB: Log file ./ib_logfile0 did not exist: new to be created InnoDB: Setting log file ./ib_logfile0 size to 128 MB InnoDB: Database physically writes the file full: wait... InnoDB: Progress in MB: 100 091002 0:00:44 InnoDB: Log file ./ib_logfile1 did not exist: new to be created InnoDB: Setting log file ./ib_logfile1 size to 128 MB InnoDB: Database physically writes the file full: wait... InnoDB: Progress in MB: 100 091002 0:00:46 InnoDB: Log file ./ib_logfile2 did not exist: new to be created InnoDB: Setting log file ./ib_logfile2 size to 128 MB InnoDB: Database physically writes the file full: wait... InnoDB: Progress in MB: 100 InnoDB: Doublewrite buffer not found: creating new InnoDB: Doublewrite buffer created InnoDB: Creating foreign key constraint system tables InnoDB: Foreign key constraint system tables created 091002 0:00:48 InnoDB Plugin 1.0.4 started; log sequence number 0 091002 0:00:48 [Warning] /mysql-5.1/sql/mysqld: unknown option '--loose-skip-ndbcluster' 091002 0:00:48 [Warning] /mysql-5.1/sql/mysqld: unknown variable 'loose-falcon-debug-mask=2' 091002 0:00:48 [Note] Event Scheduler: Loaded 0 events 091002 0:00:48 [Note] /mysql-5.1/sql/mysqld: ready for connections. Version: '5.4.3-beta-gcov-debug-log' socket: '/mysql-5.1/mysql-test/var/tmp/master.sock' port: 19306 Source distribution 091002 0:01:06 InnoDB: Assertion failure in thread 1769970576 in file row/row0mysql.c line 1355 InnoDB: Failing assertion: node->pcur->rel_pos == BTR_PCUR_ON 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.1/en/forcing-recovery.html InnoDB: about forcing recovery. 091002 0:01:06 - 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=2 max_threads=151 threads_connected=2 It is possible that mysqld could use up to key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 59977 K bytes of memory Hope that's ok; if not, decrease some variables in the equation. thd: 0xd3ee750 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 = 0x697f93a4 thread_stack 0x30000 /mysql-5.1/sql/mysqld(my_print_stacktrace+0x63)[0x8de4be0] /mysql-5.1/sql/mysqld(handle_segfault+0x5e4)[0x840b879] [0xb7fac400] /lib/tls/i686/cmov/libc.so.6(abort+0x188)[0xb7dd8098] /mysql-5.1/sql/mysqld[0x8b10a36] /mysql-5.1/sql/mysqld[0x8a4d052] /mysql-5.1/sql/mysqld(_ZN7handler13ha_update_rowEPKhPh+0xed)[0x878b533] /mysql-5.1/sql/mysqld(_ZN12ha_partition10update_rowEPKhPh+0x32f)[0x87b0373] /mysql-5.1/sql/mysqld(_ZN7handler13ha_update_rowEPKhPh+0xed)[0x878b533] /mysql-5.1/sql/mysqld(_Z12mysql_updateP3THDP10TABLE_LISTR4ListI4ItemES6_PS4_jP8st_ordery15enum_duplicatesbPySB_+0x55a1)[0x863d305] /mysql-5.1/sql/mysqld(_Z21mysql_execute_commandP3THD+0x99da)[0x8448cd4] /mysql-5.1/sql/mysqld(_Z11mysql_parseP3THDPKcjPS2_+0x7be)[0x845f33f] /mysql-5.1/sql/mysqld(_Z16dispatch_command19enum_server_commandP3THDPcj+0x2145)[0x8461ae4] /mysql-5.1/sql/mysqld(_Z10do_commandP3THD+0x61d)[0x8465739] /mysql-5.1/sql/mysqld(handle_one_connection+0x3ba)[0x842a3bf] /lib/tls/i686/cmov/libpthread.so.0[0xb7f8a4ff] /lib/tls/i686/cmov/libc.so.6(clone+0x5e)[0xb7e8f49e] Trying to get some variables. Some pointers may be invalid and cause the dump to abort... thd->query at 0xd40c708 = UPDATE `PP_G` SET `varchar_5` = 'c' WHERE ( `PP_G` . `varchar_5` > 'f' ) thd->thread_id=5 thd->killed=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 # 17:01:08 datadir is /mysql-5.1/mysql-test/var/master-data/ # 17:01:08 Core file appears to be /mysql-5.1/mysql-test/var/master-data//core warning: Can't read pathname for load map: Input/output error. # 17:01:08 Core was generated by `/mysql-5.1/sql/mysqld --no-defaults --basedir=/h'. # 17:01:08 Program terminated with signal 6, Aborted. # 17:01:08 [New process 23956] # 17:01:08 [New process 23819] # 17:01:08 [New process 23815] # 17:01:08 [New process 23817] # 17:01:08 [New process 23838] # 17:01:08 [New process 23837] # 17:01:08 [New process 23936] # 17:01:08 [New process 23818] # 17:01:08 [New process 23821] # 17:01:08 [New process 23822] # 17:01:08 [New process 23820] # 17:01:08 [New process 23825] # 17:01:08 [New process 23824] # 17:01:08 [New process 23823] # 17:01:08 [New process 23828] # 17:01:08 [New process 23829] # 17:01:08 [New process 23826] # 17:01:08 [New process 23830] # 17:01:08 [New process 23827] # 17:01:08 [New process 23831] # 17:01:08 [New process 23835] # 17:01:08 [New process 23832] # 17:01:08 [New process 23833] # 17:01:08 [New process 23836] # 17:01:08 [New process 23834] # 17:01:08 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:08 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:08 #1 0xb7f8f1c8 in pthread_kill () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:08 #2 0x08de4e4f in my_write_core (sig=6) at stacktrace.c:310 # 17:01:08 #3 0x0840befc in handle_segfault (sig=6) at mysqld.cc:2569 # 17:01:08 #4 # 17:01:08 #5 0xb7fac430 in __kernel_vsyscall () # 17:01:08 #6 0xb7dd66d0 in raise () from /lib/tls/i686/cmov/libc.so.6 # 17:01:08 #7 0xb7dd8098 in abort () from /lib/tls/i686/cmov/libc.so.6 # 17:01:08 #8 0x08b10a36 in row_update_for_mysql (mysql_rec=0xd469c70 "\021?", prebuilt=0xd483170) at row/row0mysql.c:1355 # 17:01:08 #9 0x08a4d052 in ha_innobase::update_row (this=0xd480720, old_row=0xd469c70 "\021?", new_row=0xd469c28 "\021?") at handler/ha_innodb.cc:4663 # 17:01:08 #10 0x0878b533 in handler::ha_update_row (this=0xd480720, old_data=0xd469c70 "\021?", new_data=0xd469c28 "\021?") at handler.cc:4690 # 17:01:08 #11 0x087b0373 in ha_partition::update_row (this=0xd4695a0, old_data=0xd469c70 "\021?", new_data=0xd469c28 "\021?") at ha_partition.cc:3090 # 17:01:08 #12 0x0878b533 in handler::ha_update_row (this=0xd4695a0, old_data=0xd469c70 "\021?", new_data=0xd469c28 "\021?") at handler.cc:4690 # 17:01:08 #13 0x0863d305 in mysql_update (thd=0xd3ee750, table_list=0xd40c820, fields=@0xd3efb84, values=@0xd3efda0, conds=0xd40cc70, order_num=0, order=0x0, # 17:01:08 limit=18446744073709551590, handle_duplicates=DUP_ERROR, ignore=false, found_return=0x697f86a0, updated_return=0x697f8698) at sql_update.cc:649 # 17:01:08 #14 0x08448cd4 in mysql_execute_command (thd=0xd3ee750) at sql_parse.cc:3057 # 17:01:08 #15 0x0845f33f in mysql_parse (thd=0xd3ee750, inBuf=0xd40c708 "UPDATE `PP_G` SET `varchar_5` = 'c' WHERE ( `PP_G` . `varchar_5` > 'f' )", length=72, # 17:01:08 found_semicolon=0x697f9054) at sql_parse.cc:6002 # 17:01:08 #16 0x08461ae4 in dispatch_command (command=COM_QUERY, thd=0xd3ee750, # 17:01:08 packet=0xd400691 "UPDATE `PP_G` SET `varchar_5` = 'c' WHERE ( `PP_G` . `varchar_5` > 'f' )", packet_length=72) at sql_parse.cc:1222 # 17:01:08 #17 0x08465739 in do_command (thd=0xd3ee750) at sql_parse.cc:855 # 17:01:08 #18 0x0842a3bf in handle_one_connection (arg=0xd3ee750) at sql_connect.cc:1131 # 17:01:08 #19 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:08 #20 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 warning: Can't read pathname for load map: Input/output error. # 17:01:09 Core was generated by `/mysql-5.1/sql/mysqld --no-defaults --basedir=/h'. # 17:01:09 Program terminated with signal 6, Aborted. # 17:01:09 [New process 23956] # 17:01:09 [New process 23819] # 17:01:09 [New process 23815] # 17:01:09 [New process 23817] # 17:01:09 [New process 23838] # 17:01:09 [New process 23837] # 17:01:09 [New process 23936] # 17:01:09 [New process 23818] # 17:01:09 [New process 23821] # 17:01:09 [New process 23822] # 17:01:09 [New process 23820] # 17:01:09 [New process 23825] # 17:01:09 [New process 23824] # 17:01:09 [New process 23823] # 17:01:09 [New process 23828] # 17:01:09 [New process 23829] # 17:01:09 [New process 23826] # 17:01:09 [New process 23830] # 17:01:09 [New process 23827] # 17:01:09 [New process 23831] # 17:01:09 [New process 23835] # 17:01:09 [New process 23832] # 17:01:09 [New process 23833] # 17:01:09 [New process 23836] # 17:01:09 [New process 23834] # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 # 17:01:09 Thread 25 (process 23834): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba011e4, mp=0xba01198, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba01198, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=17, message1=0x6be9f380, message2=0x6be9f37c, type=0x6be9f378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=17) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x93591a4) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 24 (process 23836): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7e877b1 in select () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 #2 0x08aaed1e in os_thread_sleep (tm=1000000) at os/os0thread.c:294 # 17:01:09 #3 0x08b4e494 in srv_error_monitor_thread (arg=0x0) at srv/srv0srv.c:2214 # 17:01:09 #4 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #5 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 23 (process 23833): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba0115c, mp=0xba01110, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba01110, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=16, message1=0x6c6a0380, message2=0x6c6a037c, type=0x6c6a0378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=16) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x93591a0) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 22 (process 23832): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba010d4, mp=0xba01088, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba01088, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=15, message1=0x6cea1380, message2=0x6cea137c, type=0x6cea1378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=15) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x935919c) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 21 (process 23835): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7e877b1 in select () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 #2 0x08aaed1e in os_thread_sleep (tm=1000000) at os/os0thread.c:294 # 17:01:09 #3 0x08b4d2d2 in srv_lock_timeout_and_monitor_thread (arg=0x0) at srv/srv0srv.c:1978 # 17:01:09 #4 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #5 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 20 (process 23831): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba0104c, mp=0xba01000, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba01000, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=14, message1=0x6d6a2380, message2=0x6d6a237c, type=0x6d6a2378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=14) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x9359198) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 19 (process 23827): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba00e2c, mp=0xba00de0, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00de0, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=10, message1=0x6f6a6380, message2=0x6f6a637c, type=0x6f6a6378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=10) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x9359188) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 18 (process 23830): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba00fc4, mp=0xba00f78, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00f78, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=13, message1=0x6dea3380, message2=0x6dea337c, type=0x6dea3378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=13) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x9359194) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 17 (process 23826): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba00da4, mp=0xba00d58, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00d58, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=9, message1=0x6fea7380, message2=0x6fea737c, type=0x6fea7378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=9) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x9359184) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 16 (process 23829): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba00f3c, mp=0xba00ef0, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00ef0, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=12, message1=0x6e6a4380, message2=0x6e6a437c, type=0x6e6a4378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=12) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x9359190) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 15 (process 23828): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba00eb4, mp=0xba00e68, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00e68, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=11, message1=0x6eea5380, message2=0x6eea537c, type=0x6eea5378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=11) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x935918c) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 14 (process 23823): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba00c0c, mp=0xba00bc0, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00bc0, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=6, message1=0x716aa380, message2=0x716aa37c, type=0x716aa378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=6) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x9359178) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 13 (process 23824): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba00c94, mp=0xba00c48, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00c48, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=7, message1=0x70ea9380, message2=0x70ea937c, type=0x70ea9378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=7) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x935917c) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 12 (process 23825): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba00d1c, mp=0xba00cd0, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00cd0, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=8, message1=0x706a8380, message2=0x706a837c, type=0x706a8378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=8) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x9359180) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 11 (process 23820): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba00a74, mp=0xba00a28, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00a28, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=3, message1=0x72ead380, message2=0x72ead37c, type=0x72ead378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=3) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x935916c) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 10 (process 23822): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba00b84, mp=0xba00b38, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00b38, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=5, message1=0x71eab380, message2=0x71eab37c, type=0x71eab378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=5) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x9359174) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 9 (process 23821): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba00afc, mp=0xba00ab0, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00ab0, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=4, message1=0x726ac380, message2=0x726ac37c, type=0x726ac378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=4) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x9359170) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 8 (process 23818): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba00964, mp=0xba00918, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00918, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=1, message1=0x73eaf380, message2=0x73eaf37c, type=0x73eaf378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=1) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x9359164) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 7 (process 23936): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f910fb in read () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08d6b7c4 in vio_read (vio=0xd3e5ec8, buf=0xd3ea728 "\a", size=4) at viosocket.c:44 # 17:01:09 #3 0x083e0247 in my_real_read (net=0xd3c6004, complen=0x6982a2e8) at net_serv.cc:839 # 17:01:09 #4 0x083e12df in my_net_read (net=0xd3c6004) at net_serv.cc:1029 # 17:01:09 #5 0x0846529c in do_command (thd=0xd3c5f88) at sql_parse.cc:797 # 17:01:09 #6 0x0842a3bf in handle_one_connection (arg=0xd3c5f88) at sql_connect.cc:1131 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 6 (process 23837): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7e877b1 in select () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 #2 0x08aaed1e in os_thread_sleep (tm=1000000) at os/os0thread.c:294 # 17:01:09 #3 0x08b4ec4d in srv_master_thread (arg=0x0) at srv/srv0srv.c:2371 # 17:01:09 #4 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #5 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 5 (process 23838): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f92300 in sigwait () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x084092bc in signal_hand (arg=0x0) at mysqld.cc:2771 # 17:01:09 #3 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #4 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 4 (process 23817): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba008dc, mp=0xba00890, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba00890, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=0, message1=0xb7da8380, message2=0xb7da837c, type=0xb7da8378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=0) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x9359160) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 3 (process 23815): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7e877b1 in select () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 #2 0x0840d917 in handle_connections_sockets (arg=0x0) at mysqld.cc:5084 # 17:01:09 #3 0x0841b3be in main (argc=41, argv=0xbfbc59e4) at mysqld.cc:4568 # 17:01:09 # 17:01:09 Thread 2 (process 23819): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8e0e5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08df0edc in safe_cond_wait (cond=0xba009ec, mp=0xba009a0, file=0x909a9dd "os/os0sync.c", line=396) at thr_mutex.c:237 # 17:01:09 #3 0x08aad421 in os_event_wait_low (event=0xba009a0, reset_sig_count=0) at os/os0sync.c:396 # 17:01:09 #4 0x08aa9eb1 in os_aio_simulated_handle (global_segment=2, message1=0x736ae380, message2=0x736ae37c, type=0x736ae378) at os/os0file.c:3997 # 17:01:09 #5 0x08c43d32 in fil_aio_wait (segment=2) at fil/fil0fil.c:4412 # 17:01:09 #6 0x08b51869 in io_handler_thread (arg=0x9359168) at srv/srv0start.c:490 # 17:01:09 #7 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #8 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 # 17:01:09 Thread 1 (process 23956): # 17:01:09 #0 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #1 0xb7f8f1c8 in pthread_kill () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #2 0x08de4e4f in my_write_core (sig=6) at stacktrace.c:310 # 17:01:09 #3 0x0840befc in handle_segfault (sig=6) at mysqld.cc:2569 # 17:01:09 #4 # 17:01:09 #5 0xb7fac430 in __kernel_vsyscall () # 17:01:09 #6 0xb7dd66d0 in raise () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 #7 0xb7dd8098 in abort () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 #8 0x08b10a36 in row_update_for_mysql (mysql_rec=0xd469c70 "\021?", prebuilt=0xd483170) at row/row0mysql.c:1355 # 17:01:09 #9 0x08a4d052 in ha_innobase::update_row (this=0xd480720, old_row=0xd469c70 "\021?", new_row=0xd469c28 "\021?") at handler/ha_innodb.cc:4663 # 17:01:09 #10 0x0878b533 in handler::ha_update_row (this=0xd480720, old_data=0xd469c70 "\021?", new_data=0xd469c28 "\021?") at handler.cc:4690 # 17:01:09 #11 0x087b0373 in ha_partition::update_row (this=0xd4695a0, old_data=0xd469c70 "\021?", new_data=0xd469c28 "\021?") at ha_partition.cc:3090 # 17:01:09 #12 0x0878b533 in handler::ha_update_row (this=0xd4695a0, old_data=0xd469c70 "\021?", new_data=0xd469c28 "\021?") at handler.cc:4690 # 17:01:09 #13 0x0863d305 in mysql_update (thd=0xd3ee750, table_list=0xd40c820, fields=@0xd3efb84, values=@0xd3efda0, conds=0xd40cc70, order_num=0, order=0x0, # 17:01:09 limit=18446744073709551590, handle_duplicates=DUP_ERROR, ignore=false, found_return=0x697f86a0, updated_return=0x697f8698) at sql_update.cc:649 # 17:01:09 #14 0x08448cd4 in mysql_execute_command (thd=0xd3ee750) at sql_parse.cc:3057 # 17:01:09 #15 0x0845f33f in mysql_parse (thd=0xd3ee750, inBuf=0xd40c708 "UPDATE `PP_G` SET `varchar_5` = 'c' WHERE ( `PP_G` . `varchar_5` > 'f' )", length=72, # 17:01:09 found_semicolon=0x697f9054) at sql_parse.cc:6002 # 17:01:09 #16 0x08461ae4 in dispatch_command (command=COM_QUERY, thd=0xd3ee750, # 17:01:09 packet=0xd400691 "UPDATE `PP_G` SET `varchar_5` = 'c' WHERE ( `PP_G` . `varchar_5` > 'f' )", packet_length=72) at sql_parse.cc:1222 # 17:01:09 #17 0x08465739 in do_command (thd=0xd3ee750) at sql_parse.cc:855 # 17:01:09 #18 0x0842a3bf in handle_one_connection (arg=0xd3ee750) at sql_connect.cc:1131 # 17:01:09 #19 0xb7f8a4ff in start_thread () from /lib/tls/i686/cmov/libpthread.so.0 # 17:01:09 #20 0xb7e8f49e in clone () from /lib/tls/i686/cmov/libc.so.6 # 17:01:09 The last 100 lines from /mysql-5.0/mysql-test/var/master-data/../log/master.err : CURRENT_TEST: alias 091002 0:00:52 [Warning] /mysql-5.0/sql/mysqld: unknown variable 'loose-falcon-debug-mask=2' InnoDB: The first specified data file ./ibdata1 did not exist: InnoDB: a new database to be created! 091002 0:00:52 InnoDB: Setting file ./ibdata1 size to 10 MB InnoDB: Database physically writes the file full: wait... 091002 0:00:52 InnoDB: Log file ./ib_logfile0 did not exist: new to be created InnoDB: Setting log file ./ib_logfile0 size to 5 MB InnoDB: Database physically writes the file full: wait... 091002 0:00:52 InnoDB: Log file ./ib_logfile1 did not exist: new to be created InnoDB: Setting log file ./ib_logfile1 size to 5 MB InnoDB: Database physically writes the file full: wait... InnoDB: Doublewrite buffer not found: creating new InnoDB: Doublewrite buffer created InnoDB: Creating foreign key constraint system tables InnoDB: Foreign key constraint system tables created 091002 0:00:53 InnoDB: Started; log sequence number 0 0 091002 0:00:53 [Note] /mysql-5.0/sql/mysqld: ready for connections. Version: '5.0.87-debug-log' socket: '/mysql-5.0/mysql-test/var/tmp/master.sock' port: 19308 Source distribution # 17:01:09 datadir is /mysql-5.0/mysql-test/var/master-data/ # 17:01:09 Core file appears to be "/rqg/mysql-test/gentest/" is not a core dump: Is a directory No stack. # 17:01:09 "/rqg/mysql-test/gentest/" is not a core dump: Is a directory /rqg/mysql-test/gentest/backtrace-all.gdb:1: Error in sourced command file: No registers. # 17:01:10 # 17:01:10 Test completed with failure status 101. # 17:01:10 gentest.pl exited with exit status 101 Thu Oct 1 17:01:10 2009 [23794] ./runall.pl will exit with exit status 101