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

Add column in ALTER TABLE results in MDL BF-BF conflict and mysqld shutdown

    XMLWordPrintable

Details

    • Bug
    • Status: Closed (View Workflow)
    • Major
    • Resolution: Fixed
    • 10.2.19
    • 10.2.42
    • Galera
    • None
    • MariaDB-server-10.2.19-1.el7.centos.x86_64
      galera-25.3.24-1.rhel7.el7.centos.x86_64
      Linux 3.10.0-957.1.3.el7.x86_64 #1 SMP Thu Nov 29 14:49:43 UTC 2018 x86_64 x86_64 x86_64 GNU/Linux

    Description

      Schema change on MariaDB 10.2 Galera cluster done via pt-online-schema-change on master1 results in MDL BF-BF conflict and mysqld shutdown on master2.

      Logs on master1:

      2019-02-11 17:18:06 139920911415040 [Note] WSREP: MDL conflict db=redacteddbname table=_email_channel_new ticket=7 solved by abort
      2019-02-11 17:18:07 139906639951616 [Note] WSREP: MDL conflict db=redacteddbname table=email_channel ticket=9 solved by abort

      Logs for master2:

      2019-02-11 17:18:06 140455700174592 [Note] WSREP: MDL BF-BF conflict
      schema:  redacteddbname
      request: (10 	seqno 17904291 	wsrep (1, 1, 0) cmd 0 147 	update `channel` set `last_activity_at` = '2019-02-11 17:18:06', `updated_at` = '2019-02-11 17:18:06' where `id` = 2632>�a\)
      granted: (11 	seqno 17904290 	wsrep (1, 1, 0) cmd 0 3 	ALTER TABLE `redacteddbname`.`_email_channel_new` add email_theme_id int unsigned null after branding, add constraint email_channel_email_theme_id_foreign foreign key (email_theme_id) references email_theme (id) on delete set null on update cascade)
      2019-02-11 17:18:07 140455699560192 [Warning] WSREP: BF applier failed to open_and_lock_tables: 1146, fatal: 0 wsrep = (exec_mode: 1 conflict_state: 0 seqno: 17904299)
      2019-02-11 17:18:07 140455699560192 [ERROR] Slave SQL: Error executing row event: 'Table 'redacteddbname._email_channel_old' doesn't exist', Internal MariaDB error code: 1146
      2019-02-11 17:18:07 140455699560192 [Warning] WSREP: RBR event 59 Update_rows_v1 apply warning: 1146, 17904299
      2019-02-11 17:18:07 140455699560192 [Warning] WSREP: Failed to apply app buffer: seqno: 17904299, status: 1
      	 at galera/src/trx_handle.cpp:apply():353
      Retrying 2th time
      2019-02-11 17:18:07 140455699560192 [Warning] WSREP: BF applier failed to open_and_lock_tables: 1146, fatal: 0 wsrep = (exec_mode: 1 conflict_state: 0 seqno: 17904299)
      2019-02-11 17:18:07 140455699560192 [ERROR] Slave SQL: Error executing row event: 'Table 'redacteddbname._email_channel_old' doesn't exist', Internal MariaDB error code: 1146
      2019-02-11 17:18:07 140455699560192 [Warning] WSREP: RBR event 59 Update_rows_v1 apply warning: 1146, 17904299
      2019-02-11 17:18:07 140455699560192 [Warning] WSREP: Failed to apply app buffer: seqno: 17904299, status: 1
      	 at galera/src/trx_handle.cpp:apply():353
      Retrying 3th time
      2019-02-11 17:18:07 140455699560192 [Warning] WSREP: BF applier failed to open_and_lock_tables: 1146, fatal: 0 wsrep = (exec_mode: 1 conflict_state: 0 seqno: 17904299)
      2019-02-11 17:18:07 140455699560192 [ERROR] Slave SQL: Error executing row event: 'Table 'redacteddbname._email_channel_old' doesn't exist', Internal MariaDB error code: 1146
      2019-02-11 17:18:07 140455699560192 [Warning] WSREP: RBR event 59 Update_rows_v1 apply warning: 1146, 17904299
      2019-02-11 17:18:07 140455699560192 [Warning] WSREP: Failed to apply app buffer: seqno: 17904299, status: 1
      	 at galera/src/trx_handle.cpp:apply():353
      Retrying 4th time
      2019-02-11 17:18:07 140455699560192 [Warning] WSREP: BF applier failed to open_and_lock_tables: 1146, fatal: 0 wsrep = (exec_mode: 1 conflict_state: 0 seqno: 17904299)
      2019-02-11 17:18:07 140455699560192 [ERROR] Slave SQL: Error executing row event: 'Table 'redacteddbname._email_channel_old' doesn't exist', Internal MariaDB error code: 1146
      2019-02-11 17:18:07 140455699560192 [Warning] WSREP: RBR event 59 Update_rows_v1 apply warning: 1146, 17904299
      2019-02-11 17:18:07 140455699560192 [ERROR] WSREP: Failed to apply trx: source: 27c270fe-1a82-11e9-a225-87b513ed78e3 version: 4 local: 0 state: APPLYING flags: 1 conn_id: 62712540 trx_id: 582056665 seqnos (l: 17904759, g: 17904299, s: 17904298, d: 17904092, ts: 4733595338897186)
      2019-02-11 17:18:07 140455699560192 [ERROR] WSREP: Failed to apply trx 17904299 4 times
      2019-02-11 17:18:07 140455699560192 [ERROR] WSREP: Node consistency compromised, aborting...
      2019-02-11 17:18:07 140455699560192 [Note] WSREP: Closing send monitor...
      2019-02-11 17:18:07 140455699560192 [Note] WSREP: Closed send monitor.
      2019-02-11 17:18:07 140455699560192 [Note] WSREP: gcomm: terminating thread
      2019-02-11 17:18:07 140455699560192 [Note] WSREP: gcomm: joining thread
      2019-02-11 17:18:07 140455699560192 [Note] WSREP: gcomm: closing backend
      2019-02-11 17:18:07 140455699560192 [Note] WSREP: view(view_id(NON_PRIM,27c270fe,77) memb {
      	aebcc706,0
      } joined {
      } left {
      } partitioned {
      	27c270fe,0
      	cf17ce0a,0
      })
      2019-02-11 17:18:07 140455699560192 [Note] WSREP: view((empty))
      2019-02-11 17:18:07 140455699560192 [Note] WSREP: gcomm: closed
      2019-02-11 17:18:07 140456000202496 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
      2019-02-11 17:18:07 140456000202496 [Note] WSREP: Flow-control interval: [16, 16]
      2019-02-11 17:18:07 140456000202496 [Note] WSREP: Trying to continue unpaused monitor
      2019-02-11 17:18:07 140456000202496 [Note] WSREP: Received NON-PRIMARY.
      2019-02-11 17:18:07 140456000202496 [Note] WSREP: Shifting SYNCED -> OPEN (TO: 17904300)
      2019-02-11 17:18:07 140456000202496 [Note] WSREP: Received self-leave message.
      2019-02-11 17:18:07 140456000202496 [Note] WSREP: Flow-control interval: [0, 0]
      2019-02-11 17:18:07 140456000202496 [Note] WSREP: Trying to continue unpaused monitor
      2019-02-11 17:18:07 140456000202496 [Note] WSREP: Received SELF-LEAVE. Closing connection.
      2019-02-11 17:18:07 140456000202496 [Note] WSREP: Shifting OPEN -> CLOSED (TO: 17904300)
      2019-02-11 17:18:07 140456000202496 [Note] WSREP: RECV thread exiting 0: Success
      2019-02-11 17:18:07 140455699560192 [Note] WSREP: recv_thread() joined.
      2019-02-11 17:18:07 140455699560192 [Note] WSREP: Closing replication queue.
      2019-02-11 17:18:07 140455699560192 [Note] WSREP: Closing slave action queue.
      2019-02-11 17:18:07 140455699560192 [Note] WSREP: /usr/sbin/mysqld: Terminated.

      Attachments

        Activity

          People

            jplindst Jan Lindström (Inactive)
            prupert Pim Rupert
            Votes:
            1 Vote for this issue
            Watchers:
            5 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.