# 14:12:00 Server crash reported, initiating post-crash analysis... # 14:12:00 The last 100 lines from /azalea/mysql-test/var/master-data/../log/master.err : CURRENT_TEST: main.1st 090812 21:11:15 [Warning] The syntax '--log' is deprecated and will be removed in MySQL 7.0. Please use '--general-log --general-log-file' instead. 090812 21:11:15 [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. 090812 21:11:15 [ERROR] An old style --language value with language specific part detected: /azalea/sql/share/english/ 090812 21:11:15 [ERROR] Use --lc-messages-dir without language specific part instead. 090812 21:11:15 [Warning] Setting lower_case_table_names=2 because file system for /azalea/mysql-test/var/master-data/ is case insensitive 090812 21:11:15 [Note] Plugin 'FEDERATED' is disabled. 090812 21:11:15 [Note] Plugin 'ndbcluster' is disabled. InnoDB: The first specified data file ./ibdata1 did not exist: InnoDB: a new database to be created! 090812 21:11:15 InnoDB: Setting file ./ibdata1 size to 10 MB InnoDB: Database physically writes the file full: wait... 090812 21:11:15 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... 090812 21:11:15 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 090812 21:11:15 InnoDB: Started; log sequence number 0 0 090812 21:11:15 [Warning] /azalea/sql/mysqld: unknown variable 'loose-falcon-debug-mask=2' 090812 21:11:15 [Note] Event Scheduler: Loaded 0 events 090812 21:11:15 [Note] /azalea/sql/mysqld: ready for connections. Version: '5.4.4-alpha-debug-log' socket: '/var/folders/Pt/PtJd7NDTGgyOk3+iDGXrQk+++TI/-Tmp-/ftarzJYW6T/master.sock' port: 19306 Source distribution Assertion failed: (exec_method != MATERIALIZATION || (exec_method == MATERIALIZATION && engine->engine_type() == subselect_engine::HASH_SJ_ENGINE)), function exec, file item_subselect.cc, line 305. 090812 21:11:27 - 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 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 = 60020 K bytes of memory Hope that's ok; if not, decrease some variables in the equation. thd: 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 0x30c00 0 mysqld 0x005aa497 my_print_stacktrace + 44 1 mysqld 0x000fca5f handle_segfault + 919 2 libSystem.B.dylib 0x90e8e2bb _sigtramp + 43 3 ??? 0xffffffff 0x0 + 4294967295 4 mysqld 0x0010746d main + 1427 5 mysqld 0x00002352 start + 54 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 # 14:12:00 datadir is /azalea/mysql-test/var/master-data/ # 14:12:00 Core file appears to be /cores/core.64090 # 14:12:01 Reading symbols for shared libraries .... done # 14:12:01 Core was generated by `/azalea/sql/mysqld'. # 14:12:01 Reading symbols for shared libraries . done # 14:12:01 Reading symbols for shared libraries .... done # 14:12:01 #0 0x90f03402 in __assert_rtn () # 14:12:01 #0 0x90f03402 in __assert_rtn () # 14:12:01 #1 0x005aa568 in my_write_core (sig=6) at stacktrace.c:309 # 14:12:01 #2 0x000fcc8a in handle_segfault (sig=6) at mysqld.cc:2734 # 14:12:01 #3 # 14:12:01 #4 0x90e716fa in select$DARWIN_EXTSN () # 14:12:01 #5 0x001008b4 in handle_connections_sockets () at mysqld.cc:5256 # 14:12:01 #6 0x0010746d in main (argc=42, argv=0xbfffaf34) at mysqld.cc:4762 # 14:12:04 Reading symbols for shared libraries .... done # 14:12:04 Core was generated by `/azalea/sql/mysqld'. # 14:12:04 Reading symbols for shared libraries . done # 14:12:04 Reading symbols for shared libraries .... done # 14:12:04 #0 0x90f03402 in __assert_rtn () # 14:12:04 # 14:12:04 Thread 11 (core thread 10): # 14:12:04 #0 0x90efe136 in clock_get_attributes () # 14:12:04 #1 0x90ef7013 in usleep$NOCANCEL$UNIX2003 () # 14:12:04 #2 0x90f0e685 in abort () # 14:12:04 #3 0x90f033db in __assert_rtn () # 14:12:04 #4 0x000aba0a in Item_in_subselect::exec (this=0x132a430) at item_subselect.cc:303 # 14:12:04 #5 0x000a8aa4 in Item_in_subselect::val_bool (this=0x132a430) at item_subselect.cc:925 # 14:12:04 #6 0x00071d18 in Item::val_bool_result (this=0x132a430) at item.h:750 # 14:12:04 #7 0x0006542b in Item_in_optimizer::val_int (this=0x132b448) at item_cmpfunc.cc:1612 # 14:12:04 #8 0x001b8cf5 in return_zero_rows (join=0x19fa028, result=0x132a540, tables=0x124cdc0, fields=@0x124aaa8, send_row=true, select_options=2147764736, info=0x6a14a0 "no matching row in const table", having=0x132b448) at sql_select.cc:10895 # 14:12:04 #9 0x001b944b in JOIN::exec (this=0x19fa028) at sql_select.cc:2404 # 14:12:04 #10 0x001bb573 in mysql_select (thd=0x1249818, rref_pointer_array=0x124ab18, tables=0x124cdc0, wild_num=0, fields=@0x124aaa8, conds=0x1328108, og_num=0, order=0x0, group=0x0, having=0x132a430, proc_param=0x0, select_options=2147764736, result=0x132a540, unit=0x124a778, select_lex=0x124aa14) at sql_select.cc:3091 # 14:12:04 #11 0x001bb8c5 in handle_select (thd=0x1249818, lex=0x124a71c, result=0x132a540, setup_tables_done_option=0) at sql_select.cc:306 # 14:12:04 #12 0x0010f608 in execute_sqlcom_select (thd=0x1249818, all_tables=0x124cdc0) at sql_parse.cc:4927 # 14:12:04 #13 0x00115aba in mysql_execute_command (thd=0x1249818) at sql_parse.cc:2112 # 14:12:04 #14 0x0011f603 in mysql_parse (thd=0x1249818, inBuf=0x124b828 "SELECT MIN( table2 . `int_key` ) AS field1 , MIN( table2 . `pk` ) AS field2 , CONCAT ( table2 . `varchar_key` , table2 . `varchar_nokey` ) AS field3 , ( ( table2 . `pk` ) - ( table2 . `int_key` ) ) "..., length=969, found_semicolon=0xb0512e14) at sql_parse.cc:5942 # 14:12:04 #15 0x00120180 in dispatch_command (command=COM_QUERY, thd=0x1249818, packet=0x19f0019 " SELECT MIN( table2 . `int_key` ) AS field1 , MIN( table2 . `pk` ) AS field2 , CONCAT ( table2 . `varchar_key` , table2 . `varchar_nokey` ) AS field3 , ( ( table2 . `pk` ) - ( table2 . `int_key` ) )"..., packet_length=971) at sql_parse.cc:1062 # 14:12:04 #16 0x00121588 in do_command (thd=0x1249818) at sql_parse.cc:744 # 14:12:04 #17 0x0010cf33 in handle_one_connection (arg=0x1249818) at sql_connect.cc:1163 # 14:12:04 #18 0x90e53155 in _pthread_start () # 14:12:04 #19 0x90e53012 in thread_start () # 14:12:04 # 14:12:04 Thread 10 (core thread 9): # 14:12:04 #0 0x90e45f9a in read$UNIX2003 () # 14:12:04 #1 0x00603f30 in vio_read (vio=0x1f69cb8, buf=0x19eb018 "\a", size=4) at viosocket.c:44 # 14:12:04 #2 0x000ef2d8 in my_real_read (net=0x11524b4, complen=0xb0490ea8) at net_serv.cc:839 # 14:12:04 #3 0x000ef958 in my_net_read (net=0x11524b4) at net_serv.cc:1029 # 14:12:04 #4 0x001213bc in do_command (thd=0x1152418) at sql_parse.cc:690 # 14:12:04 #5 0x0010cf33 in handle_one_connection (arg=0x1152418) at sql_connect.cc:1163 # 14:12:04 #6 0x90e53155 in _pthread_start () # 14:12:04 #7 0x90e53012 in thread_start () # 14:12:04 # 14:12:04 Thread 9 (core thread 8): # 14:12:04 #0 0x90e97412 in sigwait$UNIX2003 () # 14:12:04 #1 0x0010785e in signal_hand (arg=0x0) at mysqld.cc:2936 # 14:12:04 #2 0x90e53155 in _pthread_start () # 14:12:04 #3 0x90e53012 in thread_start () # 14:12:04 # 14:12:04 Thread 8 (core thread 7): # 14:12:04 #0 0x90e2946e in nanosleep$UNIX2003 () # 14:12:04 #1 0x90e53dcd in pthread_cond_wait$UNIX2003 () # 14:12:04 #2 0x005afae3 in safe_cond_wait (cond=0xe05794, mp=0xe05700, file=0x6e3b7e "os/os0sync.c", line=422) at thr_mutex.c:423 # 14:12:04 #3 0x00406308 in os_event_wait_low (event=0xe05700, reset_sig_count=0) at os/os0sync.c:422 # 14:12:04 #4 0x004391cd in srv_master_thread (arg=0x0) at srv/srv0srv.c:2629 # 14:12:04 #5 0x90e53155 in _pthread_start () # 14:12:04 #6 0x90e53012 in thread_start () # 14:12:04 # 14:12:04 Thread 7 (core thread 6): # 14:12:04 #0 0x90e716fa in select$DARWIN_EXTSN () # 14:12:04 #1 0x00406b28 in os_thread_sleep (tm=1000000) at os/os0thread.c:268 # 14:12:04 #2 0x0043868b in srv_error_monitor_thread (arg=0x0) at srv/srv0srv.c:2140 # 14:12:04 #3 0x90e53155 in _pthread_start () # 14:12:04 #4 0x90e53012 in thread_start () # 14:12:04 # 14:12:04 Thread 6 (core thread 5): # 14:12:04 #0 0x90e716fa in select$DARWIN_EXTSN () # 14:12:04 #1 0x00406b28 in os_thread_sleep (tm=1000000) at os/os0thread.c:268 # 14:12:04 #2 0x00437fdf in srv_lock_timeout_and_monitor_thread (arg=0x0) at srv/srv0srv.c:1914 # 14:12:04 #3 0x90e53155 in _pthread_start () # 14:12:04 #4 0x90e53012 in thread_start () # 14:12:04 # 14:12:04 Thread 5 (core thread 4): # 14:12:04 #0 0x90e2946e in nanosleep$UNIX2003 () # 14:12:04 #1 0x90e53dcd in pthread_cond_wait$UNIX2003 () # 14:12:04 #2 0x005afae3 in safe_cond_wait (cond=0x1f14054, mp=0x1f13fc0, file=0x6e3b7e "os/os0sync.c", line=422) at thr_mutex.c:423 # 14:12:04 #3 0x00406308 in os_event_wait_low (event=0x1f13fc0, reset_sig_count=0) at os/os0sync.c:422 # 14:12:04 #4 0x004050a4 in os_aio_simulated_handle (global_segment=3, message1=0xb0206f34, message2=0xb0206f30, type=0xb0206f2c) at os/os0file.c:4207 # 14:12:04 #5 0x003df284 in fil_aio_wait (segment=3) at fil/fil0fil.c:4246 # 14:12:04 #6 0x00439861 in io_handler_thread (arg=0x908ecc) at srv/srv0start.c:435 # 14:12:04 #7 0x90e53155 in _pthread_start () # 14:12:04 #8 0x90e53012 in thread_start () # 14:12:04 # 14:12:04 Thread 4 (core thread 3): # 14:12:04 #0 0x90e2946e in nanosleep$UNIX2003 () # 14:12:04 #1 0x90e53dcd in pthread_cond_wait$UNIX2003 () # 14:12:04 #2 0x005afae3 in safe_cond_wait (cond=0x1f13f84, mp=0x1f13ef0, file=0x6e3b7e "os/os0sync.c", line=422) at thr_mutex.c:423 # 14:12:04 #3 0x00406308 in os_event_wait_low (event=0x1f13ef0, reset_sig_count=0) at os/os0sync.c:422 # 14:12:04 #4 0x004050a4 in os_aio_simulated_handle (global_segment=2, message1=0xb0184f34, message2=0xb0184f30, type=0xb0184f2c) at os/os0file.c:4207 # 14:12:04 #5 0x003df284 in fil_aio_wait (segment=2) at fil/fil0fil.c:4246 # 14:12:04 #6 0x00439861 in io_handler_thread (arg=0x908ec8) at srv/srv0start.c:435 # 14:12:04 #7 0x90e53155 in _pthread_start () # 14:12:04 #8 0x90e53012 in thread_start () # 14:12:04 # 14:12:04 Thread 3 (core thread 2): # 14:12:04 #0 0x90e2946e in nanosleep$UNIX2003 () # 14:12:04 #1 0x90e53dcd in pthread_cond_wait$UNIX2003 () # 14:12:04 #2 0x005afae3 in safe_cond_wait (cond=0x1f13eb4, mp=0x1f13e20, file=0x6e3b7e "os/os0sync.c", line=422) at thr_mutex.c:423 # 14:12:04 #3 0x00406308 in os_event_wait_low (event=0x1f13e20, reset_sig_count=0) at os/os0sync.c:422 # 14:12:04 #4 0x004050a4 in os_aio_simulated_handle (global_segment=1, message1=0xb0102f34, message2=0xb0102f30, type=0xb0102f2c) at os/os0file.c:4207 # 14:12:04 #5 0x003df284 in fil_aio_wait (segment=1) at fil/fil0fil.c:4246 # 14:12:04 #6 0x00439861 in io_handler_thread (arg=0x908ec4) at srv/srv0start.c:435 # 14:12:04 #7 0x90e53155 in _pthread_start () # 14:12:04 #8 0x90e53012 in thread_start () # 14:12:04 # 14:12:04 Thread 2 (core thread 1): # 14:12:04 #0 0x90e2946e in nanosleep$UNIX2003 () # 14:12:04 #1 0x90e53dcd in pthread_cond_wait$UNIX2003 () # 14:12:04 #2 0x005afae3 in safe_cond_wait (cond=0x1f13de4, mp=0x1f13d50, file=0x6e3b7e "os/os0sync.c", line=422) at thr_mutex.c:423 # 14:12:04 #3 0x00406308 in os_event_wait_low (event=0x1f13d50, reset_sig_count=0) at os/os0sync.c:422 # 14:12:04 #4 0x004050a4 in os_aio_simulated_handle (global_segment=0, message1=0xb0080f34, message2=0xb0080f30, type=0xb0080f2c) at os/os0file.c:4207 # 14:12:04 #5 0x003df284 in fil_aio_wait (segment=0) at fil/fil0fil.c:4246 # 14:12:04 #6 0x00439861 in io_handler_thread (arg=0x908ec0) at srv/srv0start.c:435 # 14:12:04 #7 0x90e53155 in _pthread_start () # 14:12:04 #8 0x90e53012 in thread_start () # 14:12:04 # 14:12:04 Thread 1 (core thread 0): # 14:12:04 #0 0x90f03402 in __assert_rtn () # 14:12:04 #1 0x005aa568 in my_write_core (sig=6) at stacktrace.c:309 # 14:12:04 #2 0x000fcc8a in handle_segfault (sig=6) at mysqld.cc:2734 # 14:12:04 #3 # 14:12:04 #4 0x90e716fa in select$DARWIN_EXTSN () # 14:12:04 #5 0x001008b4 in handle_connections_sockets () at mysqld.cc:5256 # 14:12:04 #6 0x0010746d in main (argc=42, argv=0xbfffaf34) at mysqld.cc:4762 # 14:12:04 The last 100 lines from /mysql-5.1/mysql-test/var/master-data/../log/master.err : CURRENT_TEST: main.1st 090812 21:11:19 [Warning] The syntax '--log' is deprecated and will be removed in MySQL 7.0. Please use '--general_log'/'--general_log_file' instead. 090812 21:11:19 [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. 090812 21:11:19 [Warning] Setting lower_case_table_names=2 because file system for /mysql-5.1/mysql-test/var/master-data/ is case insensitive 090812 21:11:19 [Note] Plugin 'FEDERATED' is disabled. 090812 21:11:19 [Note] Plugin 'ndbcluster' is disabled. InnoDB: The first specified data file ./ibdata1 did not exist: InnoDB: a new database to be created! 090812 21:11:19 InnoDB: Setting file ./ibdata1 size to 10 MB InnoDB: Database physically writes the file full: wait... 090812 21:11:20 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... 090812 21:11:20 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 090812 21:11:20 InnoDB: Started; log sequence number 0 0 090812 21:11:20 [Warning] /mysql-5.1/sql/mysqld: unknown variable 'loose-falcon-debug-mask=2' 090812 21:11:20 [Note] Event Scheduler: Loaded 0 events 090812 21:11:20 [Note] /mysql-5.1/sql/mysqld: ready for connections. Version: '5.1.38-debug-log' socket: '/var/folders/Pt/PtJd7NDTGgyOk3+iDGXrQk+++TI/-Tmp-/SMlZu2EAU3/master.sock' port: 19308 Source distribution # 14:12:04 datadir is /mysql-5.1/mysql-test/var/master-data/ # 14:12:04 Core file appears to be "/rqg/mysql-test/gentest/" is not a core dump: File format not recognized No stack. # 14:12:04 Reading symbols for shared libraries .... done "/rqg/mysql-test/gentest/" is not a core dump: File format not recognized # 14:12:05 Reading symbols for shared libraries .... done # 14:12:05 Test completed with failure status 101. # 14:12:05 gentest.pl exited with exit status 101