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

Assertion `!"purge was not shut down"' in logs_empty_and_mark_files_at_shutdown during bootstrap

    XMLWordPrintable

Details

    Description

      origin/bb-10.2-MDEV-26131 eac954ccea83b42653acdffce8aab36125f7c513 2021-07-30T11:31:47+05:30
      origin/bb-10.3-MDEV-26206-impl-gap-1 43da05ebff34b447618ea884d0506609ffc30903 2021-07-30T14:14:15+03:00
       
      Bootstrap fails with
      # 2021-08-09T12:43:22 [920403] | mysqld: /data/Server/bb-10.2-MDEV-26131/storage/innobase/log/log0log.cc:1912: void logs_empty_and_mark_files_at_shutdown(): Assertion `!"purge was not shut down"' failed.
      # 2021-08-09T12:43:22 [920403] | 210809 12:42:45 [ERROR] mysqld got signal 6 ;
       
      pluto:/data/Results/1628503850/TBR-1162/dev/shm/vardir/1628503850/63/1/rr
      _RR_TRACE_DIR="." rr replay --mark-stdio
       
      (rr) bt
      #0  __GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:50
      #1  0x000038354b779859 in __GI_abort () at abort.c:79
      #2  0x000038354b779729 in __assert_fail_base (fmt=0x38354b90f588 "%s%s%s:%u: %s%sAssertion `%s' failed.\n%n", assertion=0x5642e6ab2840 "!\"purge was not shut down\"", 
          file=0x5642e6ab04a0 "/data/Server/bb-10.2-MDEV-26131/storage/innobase/log/log0log.cc", line=1912, function=<optimized out>) at assert.c:92
      #3  0x000038354b78af36 in __GI___assert_fail (assertion=0x5642e6ab2840 "!\"purge was not shut down\"", file=0x5642e6ab04a0 "/data/Server/bb-10.2-MDEV-26131/storage/innobase/log/log0log.cc", line=1912, 
          function=0x5642e6ab2380 "void logs_empty_and_mark_files_at_shutdown()") at assert.c:101
      #4  0x00005642e5b932f8 in logs_empty_and_mark_files_at_shutdown () at /data/Server/bb-10.2-MDEV-26131/storage/innobase/log/log0log.cc:1912
      #5  0x00005642e5de7010 in innodb_shutdown () at /data/Server/bb-10.2-MDEV-26131/storage/innobase/srv/srv0start.cc:2795
      #6  0x00005642e5a433dc in innobase_end () at /data/Server/bb-10.2-MDEV-26131/storage/innobase/handler/ha_innodb.cc:4478
      #7  0x00005642e558eca8 in ha_finalize_handlerton (plugin=0x62100002c3e8) at /data/Server/bb-10.2-MDEV-26131/sql/handler.cc:494
      #8  0x00005642e501069f in plugin_deinitialize (plugin=0x62100002c3e8, ref_check=true) at /data/Server/bb-10.2-MDEV-26131/sql/sql_plugin.cc:1220
      #9  0x00005642e50110f9 in reap_plugins () at /data/Server/bb-10.2-MDEV-26131/sql/sql_plugin.cc:1296
      #10 0x00005642e5015280 in plugin_shutdown () at /data/Server/bb-10.2-MDEV-26131/sql/sql_plugin.cc:1957
      #11 0x00005642e4dcf58c in clean_up (print_message=false) at /data/Server/bb-10.2-MDEV-26131/sql/mysqld.cc:2223
      #12 0x00005642e4dcf322 in unireg_abort (exit_code=0) at /data/Server/bb-10.2-MDEV-26131/sql/mysqld.cc:2142
      #13 0x00005642e4ddad87 in mysqld_main (argc=<error reading variable: Cannot access memory at address 0xfffffffffffffee0>, argv=<error reading variable: Cannot access memory at address 0xfffffffffffffef0>)
          at /data/Server/bb-10.2-MDEV-26131/sql/mysqld.cc:6115
      #14 0x00005642e4dc9aad in main (argc=42, argv=0x7fffccc914d8) at /data/Server/bb-10.2-MDEV-26131/sql/main.cc:25
      (rr)
       
      Per RQG output the bootstrap command was
      ulimit -c 0; cat "/dev/shm/vardir/1628503850/63/1/boot.sql" |  rr record --chaos --wait --mark-stdio "/data/Server_bin/bb-10.2-MDEV-26131_asan/bin/mysqld" "--no-defaults" "--basedir=/data/Server_bin/bb-10.2-MDEV-26131_asan" "--lc-messages-dir=/data/Server_bin/bb-10.2-MDEV-26131_asan/share" "--character-sets-dir=/data/Server_bin/bb-10.2-MDEV-26131_asan/share/charsets" "--tmpdir=/dev/shm/vardir/1628503850/63/1/tmp" "--datadir=/dev/shm/vardir/1628503850/63/1/data" "--loose-innodb_lock_schedule_algorithm=fcfs" "--loose-idle_write_transaction_timeout=0" "--loose-idle_transaction_timeout=0" "--loose-idle_readonly_transaction_timeout=0" "--connect_timeout=60" "--interactive_timeout=28800" "--slave_net_timeout=60" "--net_read_timeout=30" "--net_write_timeout=60" "--loose-table_lock_wait_timeout=50" "--wait_timeout=28800" "--lock-wait-timeout=86400" "--innodb-lock-wait-timeout=50" "--log_output=none" "--log_bin_trust_function_creators=1" "--loose-debug_assert_on_not_freed_memory=0" "--plugin-load-add=file_key_management.so" "--loose-file-key-management-filename=/home/mleich/RQG_O/conf/mariadb/encryption_keys.txt" "--loose-innodb_fatal_semaphore_wait_threshold=300" "--loose-innodb-sync-debug" "--innodb_stats_persistent=on" "--innodb_adaptive_hash_index=off" "--log-bin" "--sync-binlog=1" "--loose-innodb_evict_tables_on_commit_debug=off" "--loose-max-statement-time=30" "--innodb-use-native-aio=0" "--innodb_page_size=4K" "--innodb-buffer-pool-size=256M" "--sql-mode=no_engine_substitution" "--skip-log-bin" "--loose-innodb-encrypt-tables=OFF" "--loose-innodb-encrypt-log=OFF" "--log_error=/dev/shm/vardir/1628503850/63/1/boot.err" "--bootstrap" > "/dev/shm/vardir/1628503850/63/1/boot.log" 2>&1
       
      The failure is quite rare because a few hundred tests used the same settings
      during bootstrap and only two failed with the effect above.
      
      

      Attachments

        Issue Links

          Activity

            People

              thiru Thirunarayanan Balathandayuthapani
              mleich Matthias Leich
              Votes:
              0 Vote for this issue
              Watchers:
              2 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.