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

Assertion `! thd->transaction_rollback_request' failed in rows_event_stmt_cleanup

Details

    Description

      ./mtr rpl.rpl_temporary_error2,row --mysqld=--slave-skip-errors=all

      10.2 3fb3acf58e029203ec04c21a6

      		 
      2022-01-14 17:14:03 140033009788672 [Warning] Slave SQL: Could not execute Update_rows_v1 event on table test.t1; Deadlock found when trying to get lock; try restarting transaction, Error_code: 1213; handler error HA_ERR_LOCK_DEADLOCK; the event's master log master-bin.000001, end_log_pos 1823, Gtid 0-1-5, Internal MariaDB error code: 1213
      		 
      mysqld: 10.2/src/sql/log_event.cc:11289: int rows_event_stmt_cleanup(rpl_group_info*, THD*): Assertion `! thd->transaction_rollback_request' failed.
      		 
      220114 17:14:03 [ERROR] mysqld got signal 6 ;
      		 
       
      		 
      Server version: 10.2.42-MariaDB-debug-log
      		 
      key_buffer_size=1048576
      		 
       
      		 
      mysys/stacktrace.c:172(my_print_stacktrace)[0x5597e78d8649]
      		 
      sql/signal_handler.cc:221(handle_fatal_signal)[0x5597e66fd999]
      		 
      sigaction.c:0(__restore_rt)[0x7f5c10dca3c0]
      		 
      sql/log_event.cc:11290(rows_event_stmt_cleanup(rpl_group_info*, THD*))[0x5597e6a12d8f]
      		 
      sql/log_event.cc:11213(Rows_log_event::do_apply_event(rpl_group_info*))[0x5597e6a12640]
      		 
      sql/log_event.h:1462(Log_event::apply_event(rpl_group_info*))[0x5597e5ef356b]
      		 
      sql/slave.cc:3469(apply_event_and_update_pos_apply(Log_event*, THD*, rpl_group_info*, int))[0x5597e5ed910c]
      		 
      sql/slave.cc:3637(apply_event_and_update_pos(Log_event*, THD*, rpl_group_info*))[0x5597e5ed9bdb]
      		 
      sql/slave.cc:3936(exec_relay_log_event(THD*, Relay_log_info*, rpl_group_info*))[0x5597e5edae60]
      		 
      sql/slave.cc:5096(handle_slave_sql)[0x5597e5ee249a]
      		 
      perfschema/pfs.cc:1871(pfs_spawn_thread)[0x5597e77dcd84]
      		 
      nptl/pthread_create.c:478(start_thread)[0x7f5c10dbe609]
      		 
      /lib/x86_64-linux-gnu/libc.so.6(clone+0x43)[0x7f5c10997293]
      		 
       
      		 
       
      		 
      Query (0x61200002f7c3): UPDATE t1 SET b=1 WHERE a=4

      Attachments

        Issue Links

          blocks

          Bug - A problem which impairs or prevents the functions of the product. MDEV-33668 Adapt parallel slave's round-robin scheduling to XA events

          • Critical - Crashes, loss of data, severe memory leak.
          • Closed
          relates to

          Bug - A problem which impairs or prevents the functions of the product. MDEV-33954 --slave-skip-errors=all Incompatible with Optimistic Parallel Replication

          • Major - Major loss of function.
          • Confirmed

          Bug - A problem which impairs or prevents the functions of the product. MDEV-32469 MDEV-31949: MTR outcome difference: MTR testcase from MDEV-27512 crashes in BASE but not in PATCH

          • Major - Major loss of function.
          • Closed

          Activity

            Ascending order - Click to sort in descending order
            View 4 older comments
            Roel Roel Van de Paar added a comment -

            Seen again during MDEV-33668 testing.

            MySQL 88b557ce3cad59f0c3667e7def4fc1bdab99cd25 (Debug)

            		 
            mariadbd: /test/10.6.17-12-TODO-4632_dbg/sql/log_event_server.cc:5992: int rows_event_stmt_cleanup(rpl_group_info*, THD*): Assertion `! thd->transaction_rollback_request' failed.

            MySQL 88b557ce3cad59f0c3667e7def4fc1bdab99cd25 (Debug)

            		 
            Core was generated by `/test/TODO-4632_EMD260324-mariadb-10.6.17-12-linux-x86_64-dbg/bin/mariadbd --no'.
            		 
            Program terminated with signal SIGABRT, Aborted.
            		 
            #0  __pthread_kill_implementation (no_tid=0, signo=6, threadid=<optimized out>)at ./nptl/pthread_kill.c:44
            		 
            [Current thread is 1 (LWP 3073855)]
            		 
            (gdb) bt
            		 
            #0  __pthread_kill_implementation (no_tid=0, signo=6, threadid=<optimized out>)at ./nptl/pthread_kill.c:44
            		 
            #1  __pthread_kill_internal (signo=6, threadid=<optimized out>)at ./nptl/pthread_kill.c:78
            		 
            #2  __GI___pthread_kill (threadid=<optimized out>, signo=signo@entry=6)at ./nptl/pthread_kill.c:89
            		 
            #3  0x00001528c223c406 in __GI_raise (sig=sig@entry=6)at ../sysdeps/posix/raise.c:26
            		 
            #4  0x00001528c222287c in __GI_abort () at ./stdlib/abort.c:79
            		 
            #5  0x00001528c222279b in __assert_fail_base (fmt=0x1528c23b9f68 "%s%s%s:%u: %s%sAssertion `%s' failed.\n%n", assertion=assertion@entry=0x56421e1e2f90 "! thd->transaction_rollback_request", file=file@entry=0x56421e3a45f8 "/test/10.6.17-12-TODO-4632_dbg/sql/log_event_server.cc", line=line@entry=5992, function=function@entry=0x56421e3a5090 "int rows_event_stmt_cleanup(rpl_group_info*, THD*)") at ./assert/assert.c:92
            		 
            #6  0x00001528c2233b86 in __assert_fail (assertion=0x56421e1e2f90 "! thd->transaction_rollback_request", file=0x56421e3a45f8 "/test/10.6.17-12-TODO-4632_dbg/sql/log_event_server.cc", line=5992, function=0x56421e3a5090 "int rows_event_stmt_cleanup(rpl_group_info*, THD*)") at ./assert/assert.c:101
            		 
            #7  0x000056421da1ffbd in rows_event_stmt_cleanup (thd=0x1525100cb848, rgi=0x15246c01dae0)at /test/10.6.17-12-TODO-4632_dbg/sql/log_event_server.cc:5992
            		 
            #8  Rows_log_event::do_apply_event (this=0x15246c01f3a8, rgi=0x15246c01dae0)at /test/10.6.17-12-TODO-4632_dbg/sql/log_event_server.cc:5915
            		 
            #9  0x000056421d501605 in Log_event::apply_event (rgi=0x15246c01dae0, this=0x15246c01f3a8) at /test/10.6.17-12-TODO-4632_dbg/sql/log_event.h:1509
            		 
            #10 apply_event_and_update_pos_apply (ev=ev@entry=0x15246c01f3a8, thd=thd@entry=0x1525100cb848, rgi=rgi@entry=0x15246c01dae0, reason=reason@entry=0) at /test/10.6.17-12-TODO-4632_dbg/sql/slave.cc:3906
            		 
            #11 0x000056421d50b87a in apply_event_and_update_pos_for_parallel (ev=ev@entry=0x15246c01f3a8, thd=thd@entry=0x1525100cb848, rgi=rgi@entry=0x15246c01dae0)at /test/10.6.17-12-TODO-4632_dbg/sql/slave.cc:4102
            		 
            #12 0x000056421d7c9518 in rpt_handle_event (qev=qev@entry=0x15246c01f798, rpt=rpt@entry=0x15286c4ed3b0)at /test/10.6.17-12-TODO-4632_dbg/sql/rpl_parallel.cc:64
            		 
            #13 0x000056421d7ce152 in handle_rpl_parallel_thread (arg=arg@entry=0x15286c4ed3b0)at /test/10.6.17-12-TODO-4632_dbg/sql/rpl_parallel.cc:1508
            		 
            #14 0x000056421db88c8a in pfs_spawn_thread (arg=0x15286c90bb38)at /test/10.6.17-12-TODO-4632_dbg/storage/perfschema/pfs.cc:2201
            		 
            #15 0x00001528c228f18a in start_thread (arg=<optimized out>)at ./nptl/pthread_create.c:444
            		 
            #16 0x00001528c231dbd0 in clone3 ()at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

            NTS: seen on slave during sysbench_lua_2 / replication_xa_sysbench_2.lua runs

            Roel Roel Van de Paar added a comment - Seen again during MDEV-33668 testing. MySQL 88b557ce3cad59f0c3667e7def4fc1bdab99cd25 (Debug) mariadbd: /test/10.6.17-12-TODO-4632_dbg/sql/log_event_server.cc:5992: int rows_event_stmt_cleanup(rpl_group_info*, THD*): Assertion `! thd->transaction_rollback_request' failed. MySQL 88b557ce3cad59f0c3667e7def4fc1bdab99cd25 (Debug) Core was generated by `/test/TODO-4632_EMD260324-mariadb-10.6.17-12-linux-x86_64-dbg/bin/mariadbd --no'. Program terminated with signal SIGABRT, Aborted. #0 __pthread_kill_implementation (no_tid=0, signo=6, threadid=<optimized out>)at ./nptl/pthread_kill.c:44 [Current thread is 1 (LWP 3073855)] (gdb) bt #0 __pthread_kill_implementation (no_tid=0, signo=6, threadid=<optimized out>)at ./nptl/pthread_kill.c:44 #1 __pthread_kill_internal (signo=6, threadid=<optimized out>)at ./nptl/pthread_kill.c:78 #2 __GI___pthread_kill (threadid=<optimized out>, signo=signo@entry=6)at ./nptl/pthread_kill.c:89 #3 0x00001528c223c406 in __GI_raise (sig=sig@entry=6)at ../sysdeps/posix/raise.c:26 #4 0x00001528c222287c in __GI_abort () at ./stdlib/abort.c:79 #5 0x00001528c222279b in __assert_fail_base (fmt=0x1528c23b9f68 "%s%s%s:%u: %s%sAssertion `%s' failed.\n%n", assertion=assertion@entry=0x56421e1e2f90 "! thd->transaction_rollback_request", file=file@entry=0x56421e3a45f8 "/test/10.6.17-12-TODO-4632_dbg/sql/log_event_server.cc", line=line@entry=5992, function=function@entry=0x56421e3a5090 "int rows_event_stmt_cleanup(rpl_group_info*, THD*)") at ./assert/assert.c:92 #6 0x00001528c2233b86 in __assert_fail (assertion=0x56421e1e2f90 "! thd->transaction_rollback_request", file=0x56421e3a45f8 "/test/10.6.17-12-TODO-4632_dbg/sql/log_event_server.cc", line=5992, function=0x56421e3a5090 "int rows_event_stmt_cleanup(rpl_group_info*, THD*)") at ./assert/assert.c:101 #7 0x000056421da1ffbd in rows_event_stmt_cleanup (thd=0x1525100cb848, rgi=0x15246c01dae0)at /test/10.6.17-12-TODO-4632_dbg/sql/log_event_server.cc:5992 #8 Rows_log_event::do_apply_event (this=0x15246c01f3a8, rgi=0x15246c01dae0)at /test/10.6.17-12-TODO-4632_dbg/sql/log_event_server.cc:5915 #9 0x000056421d501605 in Log_event::apply_event (rgi=0x15246c01dae0, this=0x15246c01f3a8) at /test/10.6.17-12-TODO-4632_dbg/sql/log_event.h:1509 #10 apply_event_and_update_pos_apply (ev=ev@entry=0x15246c01f3a8, thd=thd@entry=0x1525100cb848, rgi=rgi@entry=0x15246c01dae0, reason=reason@entry=0) at /test/10.6.17-12-TODO-4632_dbg/sql/slave.cc:3906 #11 0x000056421d50b87a in apply_event_and_update_pos_for_parallel (ev=ev@entry=0x15246c01f3a8, thd=thd@entry=0x1525100cb848, rgi=rgi@entry=0x15246c01dae0)at /test/10.6.17-12-TODO-4632_dbg/sql/slave.cc:4102 #12 0x000056421d7c9518 in rpt_handle_event (qev=qev@entry=0x15246c01f798, rpt=rpt@entry=0x15286c4ed3b0)at /test/10.6.17-12-TODO-4632_dbg/sql/rpl_parallel.cc:64 #13 0x000056421d7ce152 in handle_rpl_parallel_thread (arg=arg@entry=0x15286c4ed3b0)at /test/10.6.17-12-TODO-4632_dbg/sql/rpl_parallel.cc:1508 #14 0x000056421db88c8a in pfs_spawn_thread (arg=0x15286c90bb38)at /test/10.6.17-12-TODO-4632_dbg/storage/perfschema/pfs.cc:2201 #15 0x00001528c228f18a in start_thread (arg=<optimized out>)at ./nptl/pthread_create.c:444 #16 0x00001528c231dbd0 in clone3 ()at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81 NTS: seen on slave during sysbench_lua_2 / replication_xa_sysbench_2.lua runs
            Roel Roel Van de Paar added a comment - - edited

            Elkin bnestere Can we have a fix for this bug please? Thank you

            Roel Roel Van de Paar added a comment - - edited Elkin bnestere Can we have a fix for this bug please? Thank you
            bnestere Brandon Nesterenko added a comment -

            Hi Elkin, knielsen!

            This is ready for review: PR-3191.

            bnestere Brandon Nesterenko added a comment - Hi Elkin , knielsen ! This is ready for review: PR-3191 .
            Roel Roel Van de Paar added a comment -

            Thank you team

            Roel Roel Van de Paar added a comment - Thank you team
            bnestere Brandon Nesterenko added a comment -

            Pushed into 10.5 as 0ad52e4d6aa

            No merge conflicts observed through manual cherry picking into 11.4.

            bnestere Brandon Nesterenko added a comment - Pushed into 10.5 as 0ad52e4d6aa No merge conflicts observed through manual cherry picking into 11.4.

            People

              bnestere Brandon Nesterenko
              alice Alice Sherepa
              Votes:
              0 Vote for this issue
              Watchers:
              6 Start watching this issue

              Dates

                Created:
                Updated:
                Resolved:

                Git Integration

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