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

innodb protection against dual processes accessing data insufficient

    XMLWordPrintable

Details

    Description

      MDEV-28495 protection insufficient

      steps:

      1. start
      2. insert some data
      3. start new instance on same datadir and it attempts crash recovery:

      second instance

      $  sql/mysqld --no-defaults --skip-networking --datadir=/tmp/build-mariadb-server-10.6-datadir --socket=/tmp/build-mariadb-server-10.6.sock --plugin-dir=/home/dan/repos/build-mariadb-server-10.6/mysql-test/var/plugins/ --verbose 
      2023-06-28 17:56:59 0 [Note] Starting MariaDB 10.6.15-MariaDB source revision 694ce0d08e64238e1e2228a05a19c1cd7a20e39c as process 305981
      2023-06-28 17:56:59 0 [ERROR] mysqld: Can't lock aria control file '/tmp/build-mariadb-server-10.6-datadir/aria_log_control' for exclusive use, error: 11. Will retry for 30 seconds
      2023-06-28 17:57:29 0 [ERROR] mysqld: Got error 'Could not get an exclusive lock; file is probably in use by another process' when trying to use aria control file '/tmp/build-mariadb-server-10.6-datadir/aria_log_control'
      2023-06-28 17:57:29 0 [ERROR] Plugin 'Aria' init function returned error.
      2023-06-28 17:57:29 0 [ERROR] Plugin 'Aria' registration as a STORAGE ENGINE failed.
      2023-06-28 17:57:29 0 [Note] InnoDB: Compressed tables use zlib 1.2.13
      2023-06-28 17:57:29 0 [Note] InnoDB: Number of pools: 1
      2023-06-28 17:57:29 0 [Note] InnoDB: Using crc32 + pclmulqdq instructions
      2023-06-28 17:57:29 0 [Note] InnoDB: Using liburing
      2023-06-28 17:57:29 0 [Note] InnoDB: Initializing buffer pool, total size = 134217728, chunk size = 134217728
      2023-06-28 17:57:29 0 [Note] InnoDB: Completed initialization of buffer pool
      2023-06-28 17:57:29 0 [Note] InnoDB: Setting O_DIRECT on file ./ibdata1 failed
      2023-06-28 17:57:29 0 [Note] InnoDB: Starting crash recovery from checkpoint LSN=41302,41302
      2023-06-28 17:57:29 0 [Note] InnoDB: To recover: 6 pages
      2023-06-28 17:57:29 0 [Note] InnoDB: 128 rollback segments are active.
      2023-06-28 17:57:29 0 [Note] InnoDB: Removed temporary tablespace data file: "./ibtmp1"
      2023-06-28 17:57:29 0 [Note] InnoDB: Creating shared tablespace for temporary tables
      2023-06-28 17:57:29 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
      2023-06-28 17:57:29 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
      2023-06-28 17:57:29 0 [Note] InnoDB: 10.6.15 started; log sequence number 54816; transaction id 23
      2023-06-28 17:57:29 0 [Note] InnoDB: Loading buffer pool(s) from /tmp/build-mariadb-server-10.6-datadir/ib_buffer_pool
      2023-06-28 17:57:29 0 [Note] Plugin 'FEEDBACK' is disabled.
      2023-06-28 17:57:29 0 [ERROR] Could not open mysql.plugin table: "Unknown storage engine 'Aria'". Some plugins may be not loaded
      2023-06-28 17:57:29 0 [ERROR] Failed to initialize plugins.
      2023-06-28 17:57:29 0 [ERROR] Aborting
      

      Not 10.4

      $ sql/mysqld --no-defaults --skip-networking --datadir=/tmp/build-mariadb-server-10.4-datadir --socket=/tmp/build-mariadb-server-10.4.sock --plugin-dir=/home/dan/repos/build-mariadb-server-10.4/mysql-test/var/plugins/ --verbose
      2023-06-28 17:59:14 0 [Note] Starting MariaDB 10.4.31-MariaDB source revision f5dceafd0ba211405e04be4c778d69e8a7533d8d as process 307636
      2023-06-28 17:59:14 0 [ERROR] mysqld: Can't lock aria control file '/tmp/build-mariadb-server-10.4-datadir/aria_log_control' for exclusive use, error: 11. Will retry for 30 seconds
      2023-06-28 17:59:45 0 [ERROR] mysqld: Got error 'Could not get an exclusive lock; file is probably in use by another process' when trying to use aria control file '/tmp/build-mariadb-server-10.4-datadir/aria_log_control'
      2023-06-28 17:59:45 0 [ERROR] Plugin 'Aria' init function returned error.
      2023-06-28 17:59:45 0 [ERROR] Plugin 'Aria' registration as a STORAGE ENGINE failed.
      2023-06-28 17:59:45 0 [Note] InnoDB: Using Linux native AIO
      2023-06-28 17:59:45 0 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
      2023-06-28 17:59:45 0 [Note] InnoDB: Uses event mutexes
      2023-06-28 17:59:45 0 [Note] InnoDB: Compressed tables use zlib 1.2.13
      2023-06-28 17:59:45 0 [Note] InnoDB: Number of pools: 1
      2023-06-28 17:59:45 0 [Note] InnoDB: Using SSE2 crc32 instructions
      2023-06-28 17:59:45 0 [Note] InnoDB: Initializing buffer pool, total size = 128M, instances = 1, chunk size = 128M
      2023-06-28 17:59:45 0 [Note] InnoDB: Completed initialization of buffer pool
      2023-06-28 17:59:45 0 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
      2023-06-28 17:59:45 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11
      2023-06-28 17:59:45 0 [Note] InnoDB: Check that you do not already have another mysqld process using the same InnoDB data or log files.
      2023-06-28 17:59:45 0 [ERROR] InnoDB: Plugin initialization aborted with error Generic error
      2023-06-28 17:59:46 0 [Note] InnoDB: Starting shutdown...
      2023-06-28 17:59:46 0 [ERROR] Plugin 'InnoDB' init function returned error.
      2023-06-28 17:59:46 0 [ERROR] Plugin 'InnoDB' registration as a STORAGE ENGINE failed.
      2023-06-28 17:59:46 0 [Note] Plugin 'FEEDBACK' is disabled.
      2023-06-28 17:59:46 0 [ERROR] Could not open mysql.plugin table. Some plugins may be not loaded
      2023-06-28 17:59:46 0 [ERROR] Failed to initialize plugins.
      2023-06-28 17:59:46 0 [ERROR] Aborting
      

      affects 10.5

      $ sql/mysqld --no-defaults --skip-networking --datadir=/tmp/build-mariadb-server-10.5-datadir --socket=/tmp/build-mariadb-server-10.5.sock --plugin-dir=/home/dan/repos/build-mariadb-server-10.5/mysql-test/var/plugins/ --verbose
      2023-06-28 18:04:53 0 [Note] Starting MariaDB 10.5.22-MariaDB source revision 24faa5de16c980fa5575cfc4a89618e48e9a3305 as process 315186
      2023-06-28 18:04:53 0 [ERROR] mysqld: Can't lock aria control file '/tmp/build-mariadb-server-10.5-datadir/aria_log_control' for exclusive use, error: 11. Will retry for 30 seconds
      2023-06-28 18:05:23 0 [ERROR] mysqld: Got error 'Could not get an exclusive lock; file is probably in use by another process' when trying to use aria control file '/tmp/build-mariadb-server-10.5-datadir/aria_log_control'
      2023-06-28 18:05:23 0 [ERROR] Plugin 'Aria' init function returned error.
      2023-06-28 18:05:23 0 [ERROR] Plugin 'Aria' registration as a STORAGE ENGINE failed.
      2023-06-28 18:05:23 0 [Note] InnoDB: Uses event mutexes
      2023-06-28 18:05:23 0 [Note] InnoDB: Compressed tables use zlib 1.2.13
      2023-06-28 18:05:23 0 [Note] InnoDB: Number of pools: 1
      2023-06-28 18:05:23 0 [Note] InnoDB: Using crc32 + pclmulqdq instructions
      2023-06-28 18:05:23 0 [Note] InnoDB: Using Linux native AIO
      2023-06-28 18:05:23 0 [Note] InnoDB: Initializing buffer pool, total size = 134217728, chunk size = 134217728
      2023-06-28 18:05:23 0 [Note] InnoDB: Completed initialization of buffer pool
      2023-06-28 18:05:23 0 [Note] InnoDB: Starting crash recovery from checkpoint LSN=45103,45103
      2023-06-28 18:05:23 0 [Note] InnoDB: 128 rollback segments are active.
      2023-06-28 18:05:23 0 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1"
      2023-06-28 18:05:23 0 [Note] InnoDB: Creating shared tablespace for temporary tables
      2023-06-28 18:05:23 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
      2023-06-28 18:05:23 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
      2023-06-28 18:05:23 0 [Note] InnoDB: 10.5.22 started; log sequence number 45115; transaction id 20
      2023-06-28 18:05:23 0 [Note] Plugin 'FEEDBACK' is disabled.
      2023-06-28 18:05:23 0 [Note] InnoDB: Loading buffer pool(s) from /tmp/build-mariadb-server-10.5-datadir/ib_buffer_pool
      2023-06-28 18:05:23 0 [ERROR] Could not open mysql.plugin table: "Unknown storage engine 'Aria'". Some plugins may be not loaded
      2023-06-28 18:05:23 0 [ERROR] Failed to initialize plugins.
      2023-06-28 18:05:23 0 [ERROR] Aborting
      

      Attachments

        Issue Links

          Activity

            People

              marko Marko Mäkelä
              danblack Daniel Black
              Votes:
              0 Vote for this issue
              Watchers:
              3 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.