# 17:19:53 Server crash reported at dsn dbi:mysql:host=127.0.0.1:port=19306:user=root:database=test # 17:19:54 Killing periodic reporting process with pid 94465... # 17:19:54 Server crash reported, initiating post-crash analysis... # 17:19:54 The last 100 lines from /azalea/mysql-test/var/master-data/../log/master.err : CURRENT_TEST: main.1st 090819 0:18:58 [Warning] The syntax '--log' is deprecated and will be removed in MySQL 7.0. Please use '--general-log --general-log-file' instead. 090819 0:18:58 [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. 090819 0:18:58 [ERROR] An old style --language value with language specific part detected: /azalea/sql/share/english/ 090819 0:18:58 [ERROR] Use --lc-messages-dir without language specific part instead. 090819 0:18:58 [Warning] Setting lower_case_table_names=2 because file system for /azalea/mysql-test/var/master-data/ is case insensitive 090819 0:18:58 [Note] Plugin 'FEDERATED' is disabled. 090819 0:18:58 [Note] Plugin 'ndbcluster' is disabled. InnoDB: The first specified data file ./ibdata1 did not exist: InnoDB: a new database to be created! 090819 0:18:59 InnoDB: Setting file ./ibdata1 size to 10 MB InnoDB: Database physically writes the file full: wait... 090819 0:18:59 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... 090819 0:18:59 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 090819 0:18:59 InnoDB: Started; log sequence number 0 0 090819 0:18:59 [Warning] /azalea/sql/mysqld: unknown variable 'loose-falcon-debug-mask=2' 090819 0:18:59 [Note] Event Scheduler: Loaded 0 events 090819 0:18:59 [Note] /azalea/sql/mysqld: ready for connections. Version: '5.4.4-alpha-debug-log' socket: '/var/folders/Pt/PtJd7NDTGgyOk3+iDGXrQk+++TI/-Tmp-/jKfn8ZJNUh/master.sock' port: 19306 Source distribution 090819 0:19:19 - mysqld got signal 11 ; 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 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 = 60098 K bytes of memory Hope that's ok; if not, decrease some variables in the equation. thd: 0x12ca018 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 = 0xb0512f64 thread_stack 0x30c00 0 mysqld 0x005aae33 my_print_stacktrace + 44 1 mysqld 0x000fcba5 handle_segfault + 909 2 libSystem.B.dylib 0x90e8e2bb _sigtramp + 43 3 ??? 0xffffffff 0x0 + 4294967295 4 mysqld 0x0018f6dd _Z22calc_used_field_lengthP3THDP13st_join_table + 16603 5 mysqld 0x001b3673 _Z23is_indexed_agg_distinctP4JOINP4ListI10Item_fieldE + 9023 6 mysqld 0x001b41a7 _ZN4JOIN8optimizeEv + 2737 7 mysqld 0x000ac78a _ZN30subselect_single_select_engine4execEv + 198 8 mysqld 0x000a6f72 _ZN14Item_subselect4execEv + 114 9 mysqld 0x000a892f _ZN21Item_exists_subselect7val_intEv + 93 10 mysqld 0x00047848 _Z15eval_const_condP4Item + 24 11 mysqld 0x0019990a _Z15remove_eq_condsP3THDP4ItemPNS1_11cond_resultE + 1650 12 mysqld 0x0019934e _Z15remove_eq_condsP3THDP4ItemPNS1_11cond_resultE + 182 13 mysqld 0x00199ba7 _Z15remove_eq_condsP3THDP4ItemPNS1_11cond_resultE + 2319 14 mysqld 0x001b3aa0 _ZN4JOIN8optimizeEv + 938 15 mysqld 0x001bc323 _Z12mysql_selectP3THDPPP4ItemP10TABLE_LISTjR4ListIS1_ES2_jP8st_orderSB_S2_SB_yP13select_resultP18st_select_lex_unitP13st_select_lex + 673 16 mysqld 0x001bc705 _Z13handle_selectP3THDP3LEXP13select_resultm + 537 17 mysqld 0x0010f747 _Z20prepare_schema_tableP3THDP3LEXP11Table_ident18enum_schema_tables + 2033 18 mysqld 0x00115bd6 _Z21mysql_execute_commandP3THD + 3126 19 mysqld 0x0011f6bf _Z11mysql_parseP3THDPKcjPS2_ + 575 20 mysqld 0x0012023c _Z16dispatch_command19enum_server_commandP3THDPcj + 2500 21 mysqld 0x00121612 _Z10do_commandP3THD + 620 22 mysqld 0x0010d077 handle_one_connection + 371 23 libSystem.B.dylib 0x90e53155 _pthread_start + 321 24 libSystem.B.dylib 0x90e53012 thread_start + 34 Trying to get some variables. Some pointers may be invalid and cause the dump to abort... thd->query at 0x12d2028 = SELECT table1 . `int_key` AS field1 , MIN( table1 . `varchar_key` ) AS field2 , table1 . `varchar_key` AS field3 FROM ( C AS table1 STRAIGHT_JOIN D AS table2 ON (table2 . `varchar_nokey` = table1 . `varchar_key` ) ) WHERE ( EXISTS ( ( SELECT SUBQUERY1_t1 . `varchar_key` AS SUBQUERY1_field1 FROM ( C AS SUBQUERY1_t1 ) WHERE ( ( SUBQUERY1_t1 . `varchar_key` , SUBQUERY1_t1 . `varchar_key` ) IN ( SELECT CHILD_SUBQUERY1_t1 . `varchar_key` AS CHILD_SUBQUERY1_field1 , CHILD_SUBQUERY1_t2 . `varchar_key` AS CHILD_SUBQUERY1_field2 FROM ( A AS CHILD_SUBQUERY1_t1 RIGHT JOIN D AS CHILD_SUBQUERY1_t2 ON (CHILD_SUBQUERY1_t2 . `varchar_nokey` = CHILD_SUBQUERY1_t1 . `varchar_key` ) ) ) AND SUBQUERY1_t1 . `int_key` < 2 ) ) ) ) AND table1 . `varchar_key` < table2 . `varchar_key` GROUP BY field1, field3 ORDER BY CONCAT ( table1 . `varchar_nokey`, table2 . `varchar_nokey` ) thd->thread_id=7 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:19:54 datadir is /azalea/mysql-test/var/master-data/ # 17:19:54 Core file appears to be /cores/core.94377 # 17:19:55 Reading symbols for shared libraries .... done # 17:19:55 Core was generated by `/azalea/sql/mysqld'. # 17:19:55 Reading symbols for shared libraries . done # 17:19:55 Reading symbols for shared libraries .... done # 17:19:55 #0 0x90e716fa in select$DARWIN_EXTSN () # 17:19:55 #0 0x90e716fa in select$DARWIN_EXTSN () # 17:19:55 #1 0x001009f8 in handle_connections_sockets () at mysqld.cc:5260 # 17:19:55 #2 0x001075b1 in main (argc=42, argv=0xbfffae2c) at mysqld.cc:4766 # 17:19:56 Reading symbols for shared libraries .... done # 17:19:56 Core was generated by `/azalea/sql/mysqld'. # 17:19:56 Reading symbols for shared libraries . done # 17:19:56 Reading symbols for shared libraries .... done # 17:19:56 #0 0x90e716fa in select$DARWIN_EXTSN () # 17:19:56 # 17:19:56 Thread 11 (core thread 10): # 17:19:56 #0 0x90f03402 in __assert_rtn () # 17:19:56 #1 0x005aaf04 in my_write_core (sig=11) at stacktrace.c:309 # 17:19:56 #2 0x000fcdd0 in handle_segfault (sig=11) at mysqld.cc:2738 # 17:19:56 #3 # 17:19:56 #4 0x0018dd7e in fix_semijoin_strategies_for_picked_join_order (join=0x2b58028) at sql_select.cc:7870 # 17:19:56 #5 0x0018f6dd in get_best_combination (join=0x2b58028) at sql_select.cc:8057 # 17:19:56 #6 0x001b3673 in make_join_statistics (join=0x2b58028, tables_arg=0x12e71c0, conds=0xdfc5f8, keyuse_array=0x2b5cd54) at sql_select.cc:4475 # 17:19:56 #7 0x001b41a7 in JOIN::optimize (this=0x2b58028) at sql_select.cc:1609 # 17:19:56 #8 0x000ac78a in subselect_single_select_engine::exec (this=0x12d5640) at item_subselect.cc:2233 # 17:19:56 #9 0x000a6f72 in Item_subselect::exec (this=0x12d55a8) at item_subselect.cc:285 # 17:19:56 #10 0x000a892f in Item_exists_subselect::val_int (this=0x12d55a8) at item_subselect.cc:787 # 17:19:56 #11 0x00047848 in eval_const_cond (cond=0x12d55a8) at item_func.cc:64 # 17:19:56 #12 0x0019990a in remove_eq_conds (thd=0x12ca018, cond=0x12d55a8, cond_value=0xb0510e74) at sql_select.cc:13601 # 17:19:56 #13 0x0019934e in remove_eq_conds (thd=0x12ca018, cond=0x12510e0, cond_value=0x19fed68) at sql_select.cc:13472 # 17:19:56 #14 0x00199ba7 in optimize_cond (join=0x19fa028, conds=0x12510e0, join_list=0x12cb4e0, build_equalities=true, cond_value=0x19fed68) at sql_select.cc:13439 # 17:19:56 #15 0x001b3aa0 in JOIN::optimize (this=0x19fa028) at sql_select.cc:1482 # 17:19:56 #16 0x001bc323 in mysql_select (thd=0x12ca018, rref_pointer_array=0x12cb520, tables=0x12d2fd0, wild_num=0, fields=@0x12cb4b0, conds=0x12d5908, og_num=3, order=0x12d5e68, group=0x12d5a60, having=0x0, proc_param=0x0, select_options=2147764736, result=0x12d5f08, unit=0x12caf6c, select_lex=0x12cb41c) at sql_select.cc:3077 # 17:19:56 #17 0x001bc705 in handle_select (thd=0x12ca018, lex=0x12caf10, result=0x12d5f08, setup_tables_done_option=0) at sql_select.cc:306 # 17:19:56 #18 0x0010f747 in execute_sqlcom_select (thd=0x12ca018, all_tables=0x12d2fd0) at sql_parse.cc:4930 # 17:19:56 #19 0x00115bd6 in mysql_execute_command (thd=0x12ca018) at sql_parse.cc:2112 # 17:19:56 #20 0x0011f6bf in mysql_parse (thd=0x12ca018, inBuf=0x12d2028 "SELECT table1 . `int_key` AS field1 , MIN( table1 . `varchar_key` ) AS field2 , table1 . `varchar_key` AS field3 FROM ( C AS table1 STRAIGHT_JOIN D AS table2 ON (table2 . `varchar_nokey` = table1 ."..., length=882, found_semicolon=0xb0512e14) at sql_parse.cc:5945 # 17:19:56 #21 0x0012023c in dispatch_command (command=COM_QUERY, thd=0x12ca018, packet=0x19f0019 " SELECT table1 . `int_key` AS field1 , MIN( table1 . `varchar_key` ) AS field2 , table1 . `varchar_key` AS field3 FROM ( C AS table1 STRAIGHT_JOIN D AS table2 ON (table2 . `varchar_nokey` = table1 "..., packet_length=883) at sql_parse.cc:1062 # 17:19:56 #22 0x00121612 in do_command (thd=0x12ca018) at sql_parse.cc:744 # 17:19:56 #23 0x0010d077 in handle_one_connection (arg=0x12ca018) at sql_connect.cc:1163 # 17:19:56 #24 0x90e53155 in _pthread_start () # 17:19:56 #25 0x90e53012 in thread_start () # 17:19:56 # 17:19:56 Thread 10 (core thread 9): # 17:19:56 #0 0x90e45f9a in read$UNIX2003 () # 17:19:56 #1 0x006048cc in vio_read (vio=0x1f69d08, buf=0x19eb018 "\a", size=4) at viosocket.c:44 # 17:19:56 #2 0x000ef426 in my_real_read (net=0x11546ac, complen=0xb0490ea8) at net_serv.cc:839 # 17:19:56 #3 0x000efaa6 in my_net_read (net=0x11546ac) at net_serv.cc:1029 # 17:19:56 #4 0x00121446 in do_command (thd=0x1154618) at sql_parse.cc:690 # 17:19:56 #5 0x0010d077 in handle_one_connection (arg=0x1154618) at sql_connect.cc:1163 # 17:19:56 #6 0x90e53155 in _pthread_start () # 17:19:56 #7 0x90e53012 in thread_start () # 17:19:56 # 17:19:56 Thread 9 (core thread 8): # 17:19:56 #0 0x90e97412 in sigwait$UNIX2003 () # 17:19:56 #1 0x001079a2 in signal_hand (arg=0x0) at mysqld.cc:2940 # 17:19:56 #2 0x90e53155 in _pthread_start () # 17:19:56 #3 0x90e53012 in thread_start () # 17:19:56 # 17:19:56 Thread 8 (core thread 7): # 17:19:56 #0 0x90e2946e in nanosleep$UNIX2003 () # 17:19:56 #1 0x90e53dcd in pthread_cond_wait$UNIX2003 () # 17:19:56 #2 0x005b047f in safe_cond_wait (cond=0xe057a4, mp=0xe05710, file=0x6e4afe "os/os0sync.c", line=422) at thr_mutex.c:423 # 17:19:56 #3 0x00406a60 in os_event_wait_low (event=0xe05710, reset_sig_count=0) at os/os0sync.c:422 # 17:19:56 #4 0x00439925 in srv_master_thread (arg=0x0) at srv/srv0srv.c:2629 # 17:19:56 #5 0x90e53155 in _pthread_start () # 17:19:56 #6 0x90e53012 in thread_start () # 17:19:56 # 17:19:56 Thread 7 (core thread 6): # 17:19:56 #0 0x90e716fa in select$DARWIN_EXTSN () # 17:19:56 #1 0x00407280 in os_thread_sleep (tm=1000000) at os/os0thread.c:268 # 17:19:56 #2 0x00438de3 in srv_error_monitor_thread (arg=0x0) at srv/srv0srv.c:2140 # 17:19:56 #3 0x90e53155 in _pthread_start () # 17:19:56 #4 0x90e53012 in thread_start () # 17:19:56 # 17:19:56 Thread 6 (core thread 5): # 17:19:56 #0 0x90e716fa in select$DARWIN_EXTSN () # 17:19:56 #1 0x00407280 in os_thread_sleep (tm=1000000) at os/os0thread.c:268 # 17:19:56 #2 0x00438737 in srv_lock_timeout_and_monitor_thread (arg=0x0) at srv/srv0srv.c:1914 # 17:19:56 #3 0x90e53155 in _pthread_start () # 17:19:56 #4 0x90e53012 in thread_start () # 17:19:56 # 17:19:56 Thread 5 (core thread 4): # 17:19:56 #0 0x90e2946e in nanosleep$UNIX2003 () # 17:19:56 #1 0x90e53dcd in pthread_cond_wait$UNIX2003 () # 17:19:56 #2 0x005b047f in safe_cond_wait (cond=0x1f14064, mp=0x1f13fd0, file=0x6e4afe "os/os0sync.c", line=422) at thr_mutex.c:423 # 17:19:56 #3 0x00406a60 in os_event_wait_low (event=0x1f13fd0, reset_sig_count=0) at os/os0sync.c:422 # 17:19:56 #4 0x004057fc in os_aio_simulated_handle (global_segment=3, message1=0xb0206f34, message2=0xb0206f30, type=0xb0206f2c) at os/os0file.c:4207 # 17:19:56 #5 0x003df9dc in fil_aio_wait (segment=3) at fil/fil0fil.c:4246 # 17:19:56 #6 0x00439fb9 in io_handler_thread (arg=0x909d0c) at srv/srv0start.c:435 # 17:19:56 #7 0x90e53155 in _pthread_start () # 17:19:56 #8 0x90e53012 in thread_start () # 17:19:56 # 17:19:56 Thread 4 (core thread 3): # 17:19:56 #0 0x90e2946e in nanosleep$UNIX2003 () # 17:19:56 #1 0x90e53dcd in pthread_cond_wait$UNIX2003 () # 17:19:56 #2 0x005b047f in safe_cond_wait (cond=0x1f13f94, mp=0x1f13f00, file=0x6e4afe "os/os0sync.c", line=422) at thr_mutex.c:423 # 17:19:56 #3 0x00406a60 in os_event_wait_low (event=0x1f13f00, reset_sig_count=0) at os/os0sync.c:422 # 17:19:56 #4 0x004057fc in os_aio_simulated_handle (global_segment=2, message1=0xb0184f34, message2=0xb0184f30, type=0xb0184f2c) at os/os0file.c:4207 # 17:19:56 #5 0x003df9dc in fil_aio_wait (segment=2) at fil/fil0fil.c:4246 # 17:19:56 #6 0x00439fb9 in io_handler_thread (arg=0x909d08) at srv/srv0start.c:435 # 17:19:56 #7 0x90e53155 in _pthread_start () # 17:19:56 #8 0x90e53012 in thread_start () # 17:19:56 # 17:19:56 Thread 3 (core thread 2): # 17:19:56 #0 0x90e2946e in nanosleep$UNIX2003 () # 17:19:56 #1 0x90e53dcd in pthread_cond_wait$UNIX2003 () # 17:19:56 #2 0x005b047f in safe_cond_wait (cond=0x1f13ec4, mp=0x1f13e30, file=0x6e4afe "os/os0sync.c", line=422) at thr_mutex.c:423 # 17:19:56 #3 0x00406a60 in os_event_wait_low (event=0x1f13e30, reset_sig_count=0) at os/os0sync.c:422 # 17:19:56 #4 0x004057fc in os_aio_simulated_handle (global_segment=1, message1=0xb0102f34, message2=0xb0102f30, type=0xb0102f2c) at os/os0file.c:4207 # 17:19:56 #5 0x003df9dc in fil_aio_wait (segment=1) at fil/fil0fil.c:4246 # 17:19:56 #6 0x00439fb9 in io_handler_thread (arg=0x909d04) at srv/srv0start.c:435 # 17:19:56 #7 0x90e53155 in _pthread_start () # 17:19:56 #8 0x90e53012 in thread_start () # 17:19:56 # 17:19:56 Thread 2 (core thread 1): # 17:19:56 #0 0x90e2946e in nanosleep$UNIX2003 () # 17:19:56 #1 0x90e53dcd in pthread_cond_wait$UNIX2003 () # 17:19:56 #2 0x005b047f in safe_cond_wait (cond=0x1f13df4, mp=0x1f13d60, file=0x6e4afe "os/os0sync.c", line=422) at thr_mutex.c:423 # 17:19:56 #3 0x00406a60 in os_event_wait_low (event=0x1f13d60, reset_sig_count=0) at os/os0sync.c:422 # 17:19:56 #4 0x004057fc in os_aio_simulated_handle (global_segment=0, message1=0xb0080f34, message2=0xb0080f30, type=0xb0080f2c) at os/os0file.c:4207 # 17:19:56 #5 0x003df9dc in fil_aio_wait (segment=0) at fil/fil0fil.c:4246 # 17:19:56 #6 0x00439fb9 in io_handler_thread (arg=0x909d00) at srv/srv0start.c:435 # 17:19:56 #7 0x90e53155 in _pthread_start () # 17:19:56 #8 0x90e53012 in thread_start () # 17:19:56 # 17:19:56 Thread 1 (core thread 0): # 17:19:56 #0 0x90e716fa in select$DARWIN_EXTSN () # 17:19:56 #1 0x001009f8 in handle_connections_sockets () at mysqld.cc:5260 # 17:19:56 #2 0x001075b1 in main (argc=42, argv=0xbfffae2c) at mysqld.cc:4766 # 17:19:56 The last 100 lines from /mysql-5.1/mysql-test/var/master-data/../log/master.err : CURRENT_TEST: main.1st 090819 0:19:03 [Warning] The syntax '--log' is deprecated and will be removed in MySQL 7.0. Please use '--general_log'/'--general_log_file' instead. 090819 0:19:03 [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. 090819 0:19:03 [Warning] Setting lower_case_table_names=2 because file system for /mysql-5.1/mysql-test/var/master-data/ is case insensitive 090819 0:19:03 [Note] Plugin 'FEDERATED' is disabled. 090819 0:19:03 [Note] Plugin 'ndbcluster' is disabled. InnoDB: The first specified data file ./ibdata1 did not exist: InnoDB: a new database to be created! 090819 0:19:03 InnoDB: Setting file ./ibdata1 size to 10 MB InnoDB: Database physically writes the file full: wait... 090819 0:19:04 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... 090819 0:19:04 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 090819 0:19:04 InnoDB: Started; log sequence number 0 0 090819 0:19:04 [Warning] /mysql-5.1/sql/mysqld: unknown variable 'loose-falcon-debug-mask=2' 090819 0:19:04 [Note] Event Scheduler: Loaded 0 events 090819 0:19:04 [Note] /mysql-5.1/sql/mysqld: ready for connections. Version: '5.1.39-debug-log' socket: '/var/folders/Pt/PtJd7NDTGgyOk3+iDGXrQk+++TI/-Tmp-/4atXNHs0Fz/master.sock' port: 19308 Source distribution # 17:19:56 datadir is /mysql-5.1/mysql-test/var/master-data/ # 17:19:56 Core file appears to be "/rqg/mysql-test/gentest/" is not a core dump: File format not recognized No stack. # 17:19:57 Reading symbols for shared libraries .... done "/rqg/mysql-test/gentest/" is not a core dump: File format not recognized # 17:19:58 Reading symbols for shared libraries .... done # 17:19:58 Test completed with failure status 101. # 17:19:58 gentest.pl exited with exit status 101 Tue Aug 18 17:19:58 2009 [94296] ./runall.pl will exit with exit status 101