Uploaded image for project: 'MariaDB Server'
  1. MariaDB Server
  2. MDEV-21178

Crash on galera_var_certify_nonPK_off test case

Details

    • Bug
    • Status: Open (View Workflow)
    • Major
    • Resolution: Unresolved
    • 10.4(EOL)
    • 10.4(EOL)
    • Galera
    • None

    Description

      2019-11-29T08:13:43.3201322Z galera.galera_var_certify_nonPK_off 'innodb' w1 [ fail ]
      2019-11-29T08:13:43.3202404Z         Test ended at 2019-11-29 08:13:43
      2019-11-29T08:13:43.3202690Z 
      2019-11-29T08:13:43.3210133Z CURRENT_TEST: galera.galera_var_certify_nonPK_off
      2019-11-29T08:13:43.3210977Z mysqltest: At line 20: query 'INSERT INTO t1 VALUES (1), (2)' failed with wrong errno 2013: 'Lost connection to MySQL server during query', instead of 1213...
      2019-11-29T08:13:43.3211845Z 
      2019-11-29T08:13:43.3212153Z The result from queries just before the failure was:
      2019-11-29T08:13:43.3212389Z SET GLOBAL wsrep_certify_nonPK = OFF;
      2019-11-29T08:13:43.3212586Z connection node_2;
      2019-11-29T08:13:43.3212791Z SET GLOBAL wsrep_certify_nonPK = OFF;
      2019-11-29T08:13:43.3212998Z connection node_1;
      2019-11-29T08:13:43.3213213Z CREATE TABLE t1 (f1 INTEGER) ENGINE=InnoDB /* Table has no primary key */;
      2019-11-29T08:13:43.3213448Z CREATE TABLE t2 (f1 INTEGER PRIMARY KEY) ENGINE=InnoDB;
      2019-11-29T08:13:43.3213670Z INSERT INTO t1 VALUES (1), (2);
      2019-11-29T08:13:43.3214024Z 
      2019-11-29T08:13:43.3214746Z 
      2019-11-29T08:13:43.3215453Z Server [mysqld.1 - pid: 3269, winpid: 3269, exit: 256] failed during test run
      2019-11-29T08:13:43.3215814Z Server log from this test:
      2019-11-29T08:13:43.3216308Z ----------SERVER LOG START-----------
      2019-11-29T08:13:43.3216941Z 2019-11-29  8:13:42 140138363930368 [Warning] WSREP: SQL statement was ineffective  thd: 129  buf: 129
      2019-11-29T08:13:43.3217292Z schema: test 
      2019-11-29T08:13:43.3217543Z QUERY: INSERT INTO t1 VALUES (1), (2)
      2019-11-29T08:13:43.3218702Z  => Skipping replication
      2019-11-29T08:13:43.3219312Z 2019-11-29  8:13:42 140138363930368 [ERROR] WSREP: FSM: no such a transition ROLLED_BACK -> ROLLED_BACK
      2019-11-29T08:13:43.3219626Z 191129  8:13:42 [ERROR] mysqld got signal 6 ;
      2019-11-29T08:13:43.3219857Z This could be because you hit a bug. It is also possible that this binary
      2019-11-29T08:13:43.3220295Z or one of the libraries it was linked against is corrupt, improperly built,
      2019-11-29T08:13:43.3220535Z or misconfigured. This error can also be caused by malfunctioning hardware.
      2019-11-29T08:13:43.3220712Z 
      2019-11-29T08:13:43.3221148Z To report this bug, see https://mariadb.com/kb/en/reporting-bugs
      2019-11-29T08:13:43.3221381Z 
      2019-11-29T08:13:43.3221586Z We will try our best to scrape up some info that will hopefully help
      2019-11-29T08:13:43.3221810Z diagnose the problem, but since we have already crashed, 
      2019-11-29T08:13:43.3222025Z something is definitely wrong and this may fail.
      2019-11-29T08:13:43.3222187Z 
      2019-11-29T08:13:43.3222583Z Server version: 10.2.29-4-MariaDB-enterprise-log
      2019-11-29T08:13:43.3222849Z key_buffer_size=1048576
      2019-11-29T08:13:43.3223055Z read_buffer_size=131072
      2019-11-29T08:13:43.3223230Z max_used_connections=5
      2019-11-29T08:13:43.3223431Z max_threads=153
      2019-11-29T08:13:43.3223625Z thread_count=13
      2019-11-29T08:13:43.3223978Z It is possible that mysqld could use up to 
      2019-11-29T08:13:43.3224719Z key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 63033 K  bytes of memory
      2019-11-29T08:13:43.3225466Z Hope that's ok; if not, decrease some variables in the equation.
      2019-11-29T08:13:43.3226137Z 
      2019-11-29T08:13:43.3226449Z Thread pointer: 0x7f7478012378
      2019-11-29T08:13:43.3226728Z Attempting backtrace. You can use the following information to find out
      2019-11-29T08:13:43.3227045Z where mysqld died. If you see no messages after this, something went
      2019-11-29T08:13:43.3227314Z terribly wrong...
      2019-11-29T08:13:43.3227562Z stack_bottom = 0x7f748166bda8 thread_stack 0x49000
      2019-11-29T08:13:43.3227811Z /__w/1/s/bin/mysqld(my_print_stacktrace+0x2e)[0x55a5314e7a5e]
      2019-11-29T08:13:43.3228084Z mysys/stacktrace.c:268(my_print_stacktrace)[0x55a530f5d763]
      2019-11-29T08:13:43.3229112Z /lib/x86_64-linux-gnu/libpthread.so.0(+0x12890)[0x7f7491ca2890]
      2019-11-29T08:13:43.3229401Z linux/raise.c:51(__GI_raise)[0x7f74911b6e97]
      2019-11-29T08:13:43.3229631Z stdlib/abort.c:81(__GI_abort)[0x7f74911b8801]
      2019-11-29T08:13:43.3229889Z src/fsm.hpp:81(galera::FSM<galera::TrxHandle::State, galera::TrxHandle::Transition, galera::EmptyGuard, galera::EmptyAction>::shift_to(galera::TrxHandle::State))[0x7f748a62d0c8]
      2019-11-29T08:13:43.3230179Z src/gu_atomic.hpp:59(galera::ReplicatorSMM::post_rollback(galera::TrxHandle*))[0x7f748a621d66]
      2019-11-29T08:13:43.3230429Z src/gu_mutex.hpp:38(galera_post_rollback)[0x7f748a6420a2]
      2019-11-29T08:13:43.3230774Z /__w/1/s/bin/mysqld(+0x5fa665)[0x55a530eeb665]
      2019-11-29T08:13:43.3231205Z sql/wsrep_hton.cc:273(wsrep_rollback(handlerton*, THD*, bool) [clone .part.16])[0x55a530eeb7c8]
      2019-11-29T08:13:43.3231432Z sql/wsrep_hton.cc:284(wsrep_rollback(handlerton*, THD*, bool))[0x55a530f606d3]
      2019-11-29T08:13:43.3231855Z sql/handler.cc:1764(ha_rollback_trans(THD*, bool))[0x55a530f60e23]
      2019-11-29T08:13:43.3232453Z sql/handler.cc:1589(ha_commit_trans(THD*, bool))[0x55a530e9ed9d]
      2019-11-29T08:13:43.3232715Z sql/transaction.cc:511(trans_commit_stmt(THD*))[0x55a530db7dfd]
      2019-11-29T08:13:43.3235417Z sql/sql_class.h:3600(mysql_execute_command(THD*))[0x55a530dbffd2]
      2019-11-29T08:13:43.3235863Z sql/sql_parse.cc:7768(mysql_parse(THD*, char*, unsigned int, Parser_state*, bool, bool))[0x55a530dc0782]
      2019-11-29T08:13:43.3236174Z sql/sql_parse.cc:7563(wsrep_mysql_parse(THD*, char*, unsigned int, Parser_state*, bool, bool))[0x55a530dc28a8]
      2019-11-29T08:13:43.3236498Z sql/sql_parse.cc:1826(dispatch_command(enum_server_command, THD*, char*, unsigned int, bool, bool))[0x55a530dc39c8]
      2019-11-29T08:13:43.3236834Z sql/sql_parse.cc:1386(do_command(THD*))[0x55a530e9006e]
      2019-11-29T08:13:43.3237114Z sql/sql_connect.cc:1336(do_handle_one_connection(CONNECT*))[0x55a530e9013d]
      2019-11-29T08:13:43.3237390Z sql/sql_connect.cc:1243(handle_one_connection)[0x55a53149cd2a]
      2019-11-29T08:13:43.3239743Z nptl/pthread_create.c:463(start_thread)[0x7f7491c976db]
      2019-11-29T08:13:43.3240615Z /lib/x86_64-linux-gnu/libc.so.6(clone+0x3f)[0x7f749129988f]
      2019-11-29T08:13:43.3241073Z 
      2019-11-29T08:13:43.3241281Z Trying to get some variables.
      2019-11-29T08:13:43.3241511Z Some pointers may be invalid and cause the dump to abort.
      2019-11-29T08:13:43.3241744Z Query (0x7f7478020a70): INSERT INTO t1 VALUES (1), (2)
      2019-11-29T08:13:43.3242143Z Connection ID (thread ID): 129
      2019-11-29T08:13:43.3242519Z Status: NOT_KILLED
      2019-11-29T08:13:43.3242842Z 
      2019-11-29T08:13:43.3243433Z Optimizer switch: index_merge=on,index_merge_union=on,index_merge_sort_union=on,index_merge_intersection=on,index_merge_sort_intersection=off,engine_condition_pushdown=off,index_condition_pushdown=on,derived_merge=on,derived_with_keys=on,firstmatch=on,loosescan=on,materialization=on,in_to_exists=on,semijoin=on,partial_match_rowid_merge=on,partial_match_table_scan=on,subquery_cache=on,mrr=off,mrr_cost_based=off,mrr_sort_keys=off,outer_join_with_cache=on,semijoin_with_cache=on,join_cache_incremental=on,join_cache_hashed=on,join_cache_bka=on,optimize_join_buffer_size=off,table_elimination=on,extended_keys=on,exists_to_in=on,orderby_uses_equalities=on,condition_pushdown_for_derived=on
      2019-11-29T08:13:43.3244554Z 
      2019-11-29T08:13:43.3244917Z The manual page at http://dev.mysql.com/doc/mysql/en/crashing.html contains
      2019-11-29T08:13:43.3245225Z information that should help you find out what is causing the crash.
      2019-11-29T08:13:43.3245497Z Writing a core file...
      2019-11-29T08:13:43.3245751Z Working directory at /var/tmp/mtr/1/mysqld.1/data
      2019-11-29T08:13:43.3246018Z Resource Limits:
      2019-11-29T08:13:43.3246282Z Limit                     Soft Limit           Hard Limit           Units     
      2019-11-29T08:13:43.3246583Z Max cpu time              unlimited            unlimited            seconds   
      2019-11-29T08:13:43.3246881Z Max file size             unlimited            unlimited            bytes     
      2019-11-29T08:13:43.3247169Z Max data size             unlimited            unlimited            bytes     
      2019-11-29T08:13:43.3247605Z Max stack size            8388608              unlimited            bytes     
      2019-11-29T08:13:43.3248217Z Max core file size        unlimited            unlimited            bytes     
      2019-11-29T08:13:43.3248447Z Max resident set          unlimited            unlimited            bytes     
      2019-11-29T08:13:43.3248674Z Max processes             unlimited            unlimited            processes 
      2019-11-29T08:13:43.3248902Z Max open files            1024                 1024                 files     
      2019-11-29T08:13:43.3249117Z Max locked memory         65536                65536                bytes     
      2019-11-29T08:13:43.3249560Z Max address space         unlimited            unlimited            bytes     
      2019-11-29T08:13:43.3251356Z Max file locks            unlimited            unlimited            locks     
      2019-11-29T08:13:43.3251662Z Max pending signals       27709                27709                signals   
      2019-11-29T08:13:43.3251902Z Max msgqueue size         819200               819200               bytes     
      2019-11-29T08:13:43.3252163Z Max nice priority         0                    0                    
      2019-11-29T08:13:43.3252393Z Max realtime priority     0                    0                    
      2019-11-29T08:13:43.3252614Z Max realtime timeout      unlimited            unlimited            us        
      2019-11-29T08:13:43.3252836Z Core pattern: |/usr/share/apport/apport %p %s %c %d %P
      2019-11-29T08:13:43.3253001Z 
      2019-11-29T08:13:43.3253473Z ----------SERVER LOG END-------------
      2019-11-29T08:13:43.3256790Z 
      2019-11-29T08:13:43.3257133Z 
      2019-11-29T08:13:43.3258116Z  - saving '/var/tmp/mtr/1/log/galera.galera_var_certify_nonPK_off-innodb/' to '/var/tmp/mtr/log/galera.galera_var_certify_nonPK_off-innodb/'
      2019-11-29T08:13:43.3295938Z ***Warnings generated in error logs during shutdown after running tests: galera.galera_toi_alter_auto_increment galera.galera_update_limit galera.galera_var_auto_inc_control_off galera.galera_truncate galera.galera_toi_truncate galera.galera_toi_drop_database galera.galera_toi_ddl_sequential galera.galera_bf_lock_wait galera.galera_unicode_identifiers galera.galera_transaction_replay galera.galera_unicode_pk galera.galera_var_OSU_method2 galera.galera_toi_ftwrl galera.galera_toi_lock_exclusive galera.galera_transaction_read_only galera.galera_toi_lock_shared galera.galera_var_OSU_method galera.galera_var_certify_nonPK_off galera.galera_truncate_temporary galera.galera_toi_ddl_nonconflicting
      2019-11-29T08:13:43.3297029Z 
      2019-11-29T08:13:43.3298433Z 2019-11-29  8:13:42 140138363930368 [Warning] WSREP: SQL statement was ineffective  thd: 129  buf: 129
      2019-11-29T08:13:43.3299074Z 2019-11-29  8:13:42 140138363930368 [ERROR] WSREP: FSM: no such a transition ROLLED_BACK -> ROLLED_BACK
      2019-11-29T08:13:43.3299389Z Attempting backtrace. You can use the following information
      

      Attachments

        Activity

          People

            teemu.ollakka Teemu Ollakka
            jplindst Jan Lindström (Inactive)
            Votes:
            0 Vote for this issue
            Watchers:
            1 Start watching this issue

            Dates

              Created:
              Updated:

              Git Integration

                Error rendering 'com.xiplink.jira.git.jira_git_plugin:git-issue-webpanel'. Please contact your Jira administrators.