Description:
Hi Team,
We are currently maintaining a MySQL Flexible Server setup with High Availability enabled. After upgrading the database engine from MySQL 5.7 to MySQL 8.0.40, we have started experiencing frequent failovers — approximately 10 to 15 so far — triggered by health check failures indicating unplanned failovers due to repeated InnoDB engine crashes.
Each crash results in mysqld failing, followed by crash recovery on the failover server. We have not been able to identify the root cause behind these frequent MySQL crashes.
Kindly help us investigate and resolve this issue. The relevant error logs are attached for your reference.
How to repeat:
After upgrading the database engine from MySQL 5.7 to MySQL 8.0.40, we have started experiencing frequent InnoDB engine crashes.
2025-04-28T10:19:33.019559Z 0 [Warning] [MY-011070] [Server] '--sync-relay-log-info' is deprecated and will be removed in a future release.
2025-04-28T10:19:33.019605Z 0 [Warning] [MY-011069] [Server] The syntax '--transaction-write-set-extraction' is deprecated and will be removed in a future release.
2025-04-28T10:19:33.019752Z 0 [Note] [MY-000000] [Server] mount dir '/app/work2'
2025-04-28T10:19:33.019762Z 0 [Note] [MY-010098] [Server] --secure-file-priv is set to NULL. Operations related to importing and exporting data are disabled
2025-04-28T10:19:33.019870Z 0 [Warning] [MY-010918] [Server] 'default_authentication_plugin' is deprecated and will be removed in a future release. Please use authentication_policy instead.
2025-04-28T10:19:33.019881Z 0 [Note] [MY-013932] [Server] BuildID[sha1]=e8762d77ece164641baa64a5d84e69537b055377
2025-04-28T10:19:33.019889Z 0 [Note] [MY-010949] [Server] Basedir set to /mysql/.
2025-04-28T10:19:33.019900Z 0 [System] [MY-010116] [Server] /mysql/bin/mysqld (mysqld 8.0.40-azure) starting as process 194
2025-04-28T10:19:33.021518Z 0 [Note] [MY-000000] [Server] new coredump filter: 0x00000037
2025-04-28T10:19:33.074754Z 0 [Warning] [MY-000080] [Server] option 'innodb-open-files': signed value -1 adjusted to 0.
2025-04-28T10:19:33.075780Z 0 [Note] [MY-012366] [InnoDB] Using Linux native AIO
2025-04-28T10:19:33.075923Z 0 [Note] [MY-010747] [Server] Plugin 'ARCHIVE' is disabled.
2025-04-28T10:19:33.075930Z 0 [Note] [MY-010747] [Server] Plugin 'BLACKHOLE' is disabled.
2025-04-28T10:19:33.075934Z 0 [Note] [MY-010747] [Server] Plugin 'FEDERATED' is disabled.
2025-04-28T10:19:33.075966Z 0 [Note] [MY-010747] [Server] Plugin 'ndbcluster' is disabled.
2025-04-28T10:19:33.075973Z 0 [Note] [MY-010747] [Server] Plugin 'ndbinfo' is disabled.
2025-04-28T10:19:33.075976Z 0 [Note] [MY-010747] [Server] Plugin 'ndb_transid_mysql_connection_map' is disabled.
2025-04-28T10:19:33.076001Z 0 [Note] [MY-010747] [Server] Plugin 'mysqlx' is disabled.
2025-04-28T10:19:33.087254Z 1 [System] [MY-013576] [InnoDB] InnoDB initialization has started.
2025-04-28T10:19:33.087267Z 1 [Note] [MY-013547] [InnoDB] Atomic write disabled
2025-04-28T10:19:33.100238Z 1 [Note] [MY-012932] [InnoDB] PUNCH HOLE support available
2025-04-28T10:19:33.100247Z 1 [Note] [MY-012944] [InnoDB] Uses event mutexes
2025-04-28T10:19:33.100251Z 1 [Note] [MY-012945] [InnoDB] GCC builtin __atomic_thread_fence() is used for memory barrier
2025-04-28T10:19:33.100259Z 1 [Note] [MY-012948] [InnoDB] Compressed tables use zlib 1.2.13
2025-04-28T10:19:33.101463Z 1 [Note] [MY-012951] [InnoDB] Using hardware accelerated crc32 and polynomial multiplication.
2025-04-28T10:19:33.101918Z 1 [Note] [MY-012203] [InnoDB] Directories to scan './'
2025-04-28T10:19:33.110199Z 1 [Note] [MY-012204] [InnoDB] Scanning './'
2025-04-28T10:19:33.115718Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.binlogposclean' will not be scanned because it is a hidden directory.
2025-04-28T10:19:33.115727Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.build_number' will not be scanned because it is a hidden directory.
2025-04-28T10:19:33.115731Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.dataversion' will not be scanned because it is a hidden directory.
2025-04-28T10:19:33.115735Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.dataversionupgrade_8028' will not be scanned because it is a hidden directory.
2025-04-28T10:19:33.115738Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.enginecontainerstarttime' will not be scanned because it is a hidden directory.
2025-04-28T10:19:33.115742Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.myinitfile' will not be scanned because it is a hidden directory.
2025-04-28T10:19:33.115745Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.replay' will not be scanned because it is a hidden directory.
2025-04-28T10:19:33.115748Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.running' will not be scanned because it is a hidden directory.
2025-04-28T10:19:33.115751Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.setup' will not be scanned because it is a hidden directory.
2025-04-28T10:19:33.684854Z 1 [Note] [MY-012206] [InnoDB] Found 3207 '.ibd' and 2 undo files
2025-04-28T10:19:33.684875Z 1 [Note] [MY-012207] [InnoDB] Using 9 threads to scan 3207 tablespace files
2025-04-28T10:19:35.910487Z 1 [Note] [MY-012208] [InnoDB] Completed space ID check of 3209 files.
2025-04-28T10:19:35.911545Z 1 [Note] [MY-012955] [InnoDB] Initializing buffer pool, total size = 12.000000G, instances = 8, chunk size =128.000000M
2025-04-28T10:19:35.911584Z 1 [Note] [MY-011825] [InnoDB] HOTCACHE: Hot Cache is OFF
2025-04-28T10:19:36.064621Z 1 [Note] [MY-012957] [InnoDB] Completed initialization of buffer pool
2025-04-28T10:19:36.082011Z 1 [Note] [MY-011825] [InnoDB] delayed data sync enabled
2025-04-28T10:19:36.082026Z 1 [Note] [MY-011825] [InnoDB] delayed log write enabled
2025-04-28T10:19:36.083470Z 0 [Note] [MY-011825] [InnoDB] dynamic page cleaner priority enabled
2025-04-28T10:19:36.083485Z 0 [Note] [MY-011825] [InnoDB] page cleaner threads:
2025-04-28T10:19:36.083491Z 0 [Note] [MY-011825] [InnoDB] writer thread, id 811595328, uniqid 239
2025-04-28T10:19:36.083494Z 0 [Note] [MY-011825] [InnoDB] pgcleaner_coord thread, id 761247296, uniqid 240
2025-04-28T10:19:36.194278Z 1 [Note] [MY-011825] [InnoDB] HOTCACHE: restore(): Feature flag is off
2025-04-28T10:19:36.307583Z 1 [Note] [MY-013883] [InnoDB] The latest found checkpoint is at lsn = 4074541806417 in redo log file ./#innodb_redo/#ib_redo1829.
2025-04-28T10:19:36.308615Z 1 [Note] [MY-012560] [InnoDB] The log sequence number 4070442897044 in the system tablespace does not match the log sequence number 4074541806417 in the redo log files!
2025-04-28T10:19:36.308624Z 1 [Note] [MY-012551] [InnoDB] Database was not shutdown normally!
2025-04-28T10:19:36.308629Z 1 [Note] [MY-012552] [InnoDB] Starting crash recovery.
2025-04-28T10:19:36.312337Z 1 [Note] [MY-013086] [InnoDB] Starting to parse redo log at lsn = 4074541806151, whereas checkpoint_lsn = 4074541806417 and start_lsn = 4074541806080
2025-04-28T10:19:36.427152Z 1 [Note] [MY-012550] [InnoDB] Doing recovery: scanned up to log sequence number 4074544081973
2025-04-28T10:19:36.448956Z 1 [Note] [MY-013083] [InnoDB] Log background threads are being started...
2025-04-28T10:19:36.450405Z 1 [Note] [MY-012532] [InnoDB] Applying a batch of 778 redo log records ...
2025-04-28T10:19:36.489005Z 1 [Note] [MY-012533] [InnoDB] 10%
2025-04-28T10:19:36.502885Z 1 [Note] [MY-012533] [InnoDB] 20%
2025-04-28T10:19:36.536667Z 1 [Note] [MY-012533] [InnoDB] 30%
2025-04-28T10:19:36.572183Z 1 [Note] [MY-012533] [InnoDB] 40%
2025-04-28T10:19:36.614587Z 1 [Note] [MY-012533] [InnoDB] 50%
2025-04-28T10:19:36.620993Z 1 [Note] [MY-012533] [InnoDB] 60%
2025-04-28T10:19:36.640759Z 1 [Note] [MY-012533] [InnoDB] 70%
2025-04-28T10:19:36.663192Z 1 [Note] [MY-012533] [InnoDB] 80%
2025-04-28T10:19:36.676268Z 1 [Note] [MY-012533] [InnoDB] 90%
2025-04-28T10:19:36.700747Z 1 [Note] [MY-012533] [InnoDB] 100%
2025-04-28T10:19:46.220212Z 0 [Note] [MY-013667] [Server] Error-log destination "stderr" is not a file. Can not restore error log messages from previous run.
2025-04-28T10:19:46.059854Z 0 [Warning] [MY-010079] [Server] Invalid instrument name or value for performance_schema_instrument ''
2025-04-28T10:19:46.206371Z 0 [Warning] [MY-013245] [Server] The SSL library function CRYPTO_set_mem_functions failed. This is typically caused by the SSL library already being used. As a result the SSL memory allocation will not be instrumented.
2025-04-28T10:19:46.206949Z 0 [Warning] [MY-011069] [Server] The syntax 'avoid_temporal_upgrade' is deprecated and will be removed in a future release.
2025-04-28T10:19:46.206999Z 0 [Warning] [MY-011070] [Server] 'binlog_format' is deprecated and will be removed in a future release.
2025-04-28T10:19:46.207027Z 0 [Warning] [MY-011069] [Server] The syntax '--binlog-transaction-dependency-tracking' is deprecated and will be removed in a future release.
2025-04-28T10:19:46.207075Z 0 [Warning] [MY-011068] [Server] The syntax 'expire-logs-days' is deprecated and will be removed in a future release. Please use binlog_expire_logs_seconds instead.
2025-04-28T10:19:46.207339Z 0 [Warning] [MY-011069] [Server] The syntax '--log-bin-use-v1-row-events' is deprecated and will be removed in a future release.
2025-04-28T10:19:46.207355Z 0 [Warning] [MY-011068] [Server] The syntax 'log_slave_updates' is deprecated and will be removed in a future release. Please use log_replica_updates instead.
2025-04-28T10:19:46.207366Z 0 [Warning] [MY-011068] [Server] The syntax 'log_slow_slave_statements' is deprecated and will be removed in a future release. Please use log_slow_replica_statements instead.
2025-04-28T10:19:46.207381Z 0 [Warning] [MY-011069] [Server] The syntax '--master-info-repository' is deprecated and will be removed in a future release.
2025-04-28T10:19:46.207387Z 0 [Warning] [MY-011068] [Server] The syntax 'master_verify_checksum' is deprecated and will be removed in a future release. Please use source_verify_checksum instead.
2025-04-28T10:19:46.207474Z 0 [Warning] [MY-011069] [Server] The syntax '--relay-log-info-repository' is deprecated and will be removed in a future release.
2025-04-28T10:19:46.207486Z 0 [Warning] [MY-011068] [Server] The syntax 'rpl_stop_slave_timeout' is deprecated and will be removed in a future release. Please use rpl_stop_replica_timeout instead.
2025-04-28T10:19:46.207509Z 0 [Warning] [MY-011069] [Server] The syntax 'show_old_temporals' is deprecated and will be removed in a future release.
2025-04-28T10:19:46.207518Z 0 [Warning] [MY-011068] [Server] The syntax 'skip_slave_start' is deprecated and will be removed in a future release. Please use skip_replica_start instead.
2025-04-28T10:19:46.207523Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_checkpoint_group' is deprecated and will be removed in a future release. Please use replica_checkpoint_group instead.
2025-04-28T10:19:46.207526Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_checkpoint_period' is deprecated and will be removed in a future release. Please use replica_checkpoint_period instead.
2025-04-28T10:19:46.207530Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_compressed_protocol' is deprecated and will be removed in a future release. Please use replica_compressed_protocol instead.
2025-04-28T10:19:46.207535Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_exec_mode' is deprecated and will be removed in a future release. Please use replica_exec_mode instead.
2025-04-28T10:19:46.207539Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_load_tmpdir' is deprecated and will be removed in a future release. Please use replica_load_tmpdir instead.
2025-04-28T10:19:46.207542Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_max_allowed_packet' is deprecated and will be removed in a future release. Please use replica_max_allowed_packet instead.
2025-04-28T10:19:46.207547Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_net_timeout' is deprecated and will be removed in a future release. Please use replica_net_timeout instead.
2025-04-28T10:19:46.207550Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_parallel_type' is deprecated and will be removed in a future release. Please use replica_parallel_type instead.
2025-04-28T10:19:46.207553Z 0 [Warning] [MY-011069] [Server] The syntax '--replica-parallel-type' is deprecated and will be removed in a future release.
2025-04-28T10:19:46.207557Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_parallel_workers' is deprecated and will be removed in a future release. Please use replica_parallel_workers instead.
2025-04-28T10:19:46.207561Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_pending_jobs_size_max' is deprecated and will be removed in a future release. Please use replica_pending_jobs_size_max instead.
2025-04-28T10:19:46.207565Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_preserve_commit_order' is deprecated and will be removed in a future release. Please use replica_preserve_commit_order instead.
2025-04-28T10:19:46.207569Z 0 [Warning] [MY-011069] [Server] The syntax '--slave-rows-search-algorithms' is deprecated and will be removed in a future release.
2025-04-28T10:19:46.207574Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_skip_errors' is deprecated and will be removed in a future release. Please use replica_skip_errors instead.
2025-04-28T10:19:46.207577Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_sql_verify_checksum' is deprecated and will be removed in a future release. Please use replica_sql_verify_checksum instead.
2025-04-28T10:19:46.207581Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_transaction_retries' is deprecated and will be removed in a future release. Please use replica_transaction_retries instead.
2025-04-28T10:19:46.207587Z 0 [Warning] [MY-011068] [Server] The syntax 'slave_type_conversions' is deprecated and will be removed in a future release. Please use replica_type_conversions instead.
2025-04-28T10:19:46.207605Z 0 [Warning] [MY-014067] [Server] Value for option 'ssl-cipher' contains cipher 'ECDHE-RSA-AES128-SHA256' that is either blocked or deprecated (and will be removed in a future release). Please refer to the documentation for more details.
2025-04-28T10:19:46.207607Z 0 [Warning] [MY-014067] [Server] Value for option 'ssl-cipher' contains cipher 'ECDHE-RSA-AES256-SHA384' that is either blocked or deprecated (and will be removed in a future release). Please refer to the documentation for more details.
2025-04-28T10:19:46.207610Z 0 [Warning] [MY-014067] [Server] Value for option 'ssl-cipher' contains cipher 'DHE-RSA-AES128-SHA256' that is either blocked or deprecated (and will be removed in a future release). Please refer to the documentation for more details.
2025-04-28T10:19:46.207613Z 0 [Warning] [MY-014067] [Server] Value for option 'ssl-cipher' contains cipher 'DHE-RSA-AES256-SHA256' that is either blocked or deprecated (and will be removed in a future release). Please refer to the documentation for more details.
2025-04-28T10:19:46.207615Z 0 [Warning] [MY-014067] [Server] Value for option 'ssl-cipher' contains cipher 'DHE-RSA-AES128-CCM8' that is either blocked or deprecated (and will be removed in a future release). Please refer to the documentation for more details.
2025-04-28T10:19:46.207618Z 0 [Warning] [MY-014067] [Server] Value for option 'ssl-cipher' contains cipher 'DHE-RSA-AES256-CCM8' that is either blocked or deprecated (and will be removed in a future release). Please refer to the documentation for more details.
2025-04-28T10:19:46.207628Z 0 [Warning] [MY-011068] [Server] The syntax 'sync_master_info' is deprecated and will be removed in a future release. Please use sync_source_info instead.
2025-04-28T10:19:46.207634Z 0 [Warning] [MY-011070] [Server] '--sync-relay-log-info' is deprecated and will be removed in a future release.
2025-04-28T10:19:46.207678Z 0 [Warning] [MY-011069] [Server] The syntax '--transaction-write-set-extraction' is deprecated and will be removed in a future release.
2025-04-28T10:19:46.207821Z 0 [Note] [MY-000000] [Server] mount dir '/app/work2'
2025-04-28T10:19:46.207831Z 0 [Note] [MY-010098] [Server] --secure-file-priv is set to NULL. Operations related to importing and exporting data are disabled
2025-04-28T10:19:46.207924Z 0 [Warning] [MY-010918] [Server] 'default_authentication_plugin' is deprecated and will be removed in a future release. Please use authentication_policy instead.
2025-04-28T10:19:46.207929Z 0 [Note] [MY-013932] [Server] BuildID[sha1]=e8762d77ece164641baa64a5d84e69537b055377
2025-04-28T10:19:46.207935Z 0 [Note] [MY-010949] [Server] Basedir set to /mysql/.
2025-04-28T10:19:46.207946Z 0 [System] [MY-010116] [Server] /mysql/bin/mysqld (mysqld 8.0.40-azure) starting as process 194
2025-04-28T10:19:46.209602Z 0 [Note] [MY-000000] [Server] new coredump filter: 0x00000037
2025-04-28T10:19:46.267030Z 0 [Warning] [MY-000080] [Server] option 'innodb-open-files': signed value -1 adjusted to 0.
2025-04-28T10:19:46.268158Z 0 [Note] [MY-012366] [InnoDB] Using Linux native AIO
2025-04-28T10:19:46.268301Z 0 [Note] [MY-010747] [Server] Plugin 'ARCHIVE' is disabled.
2025-04-28T10:19:46.268307Z 0 [Note] [MY-010747] [Server] Plugin 'BLACKHOLE' is disabled.
2025-04-28T10:19:46.268311Z 0 [Note] [MY-010747] [Server] Plugin 'FEDERATED' is disabled.
2025-04-28T10:19:46.268340Z 0 [Note] [MY-010747] [Server] Plugin 'ndbcluster' is disabled.
2025-04-28T10:19:46.268348Z 0 [Note] [MY-010747] [Server] Plugin 'ndbinfo' is disabled.
2025-04-28T10:19:46.268352Z 0 [Note] [MY-010747] [Server] Plugin 'ndb_transid_mysql_connection_map' is disabled.
2025-04-28T10:19:46.268373Z 0 [Note] [MY-010747] [Server] Plugin 'mysqlx' is disabled.
2025-04-28T10:19:46.279488Z 1 [System] [MY-013576] [InnoDB] InnoDB initialization has started.
2025-04-28T10:19:46.279501Z 1 [Note] [MY-013547] [InnoDB] Atomic write disabled
2025-04-28T10:19:46.292174Z 1 [Note] [MY-012932] [InnoDB] PUNCH HOLE support available
2025-04-28T10:19:46.292182Z 1 [Note] [MY-012944] [InnoDB] Uses event mutexes
2025-04-28T10:19:46.292185Z 1 [Note] [MY-012945] [InnoDB] GCC builtin __atomic_thread_fence() is used for memory barrier
2025-04-28T10:19:46.292192Z 1 [Note] [MY-012948] [InnoDB] Compressed tables use zlib 1.2.13
2025-04-28T10:19:46.293303Z 1 [Note] [MY-012951] [InnoDB] Using hardware accelerated crc32 and polynomial multiplication.
2025-04-28T10:19:46.293751Z 1 [Note] [MY-012203] [InnoDB] Directories to scan './'
2025-04-28T10:19:46.301492Z 1 [Note] [MY-012204] [InnoDB] Scanning './'
2025-04-28T10:19:46.307061Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.binlogposclean' will not be scanned because it is a hidden directory.
2025-04-28T10:19:46.307070Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.build_number' will not be scanned because it is a hidden directory.
2025-04-28T10:19:46.307074Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.dataversion' will not be scanned because it is a hidden directory.
2025-04-28T10:19:46.307078Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.dataversionupgrade_8028' will not be scanned because it is a hidden directory.
2025-04-28T10:19:46.307082Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.enginecontainerstarttime' will not be scanned because it is a hidden directory.
2025-04-28T10:19:46.307085Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.myinitfile' will not be scanned because it is a hidden directory.
2025-04-28T10:19:46.307089Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.replay' will not be scanned because it is a hidden directory.
2025-04-28T10:19:46.307092Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.running' will not be scanned because it is a hidden directory.
2025-04-28T10:19:46.307095Z 1 [Note] [MY-013503] [InnoDB] Directory '/app/work2/data/.setup' will not be scanned because it is a hidden directory.
2025-04-28T10:19:46.869411Z 1 [Note] [MY-012206] [InnoDB] Found 3207 '.ibd' and 2 undo files
2025-04-28T10:19:46.869428Z 1 [Note] [MY-012207] [InnoDB] Using 9 threads to scan 3207 tablespace files
2025-04-28T10:19:48.938395Z 1 [Note] [MY-012208] [InnoDB] Completed space ID check of 3209 files.
2025-04-28T10:19:48.939385Z 1 [Note] [MY-012955] [InnoDB] Initializing buffer pool, total size = 12.000000G, instances = 8, chunk size =128.000000M
2025-04-28T10:19:48.939431Z 1 [Note] [MY-011825] [InnoDB] HOTCACHE: Hot Cache is OFF
2025-04-28T10:19:49.092300Z 1 [Note] [MY-012957] [InnoDB] Completed initialization of buffer pool
2025-04-28T10:19:49.109542Z 1 [Note] [MY-011825] [InnoDB] delayed data sync enabled
2025-04-28T10:19:49.109558Z 1 [Note] [MY-011825] [InnoDB] delayed log write enabled
2025-04-28T10:19:49.110799Z 0 [Note] [MY-011825] [InnoDB] dynamic page cleaner priority enabled
2025-04-28T10:19:49.110815Z 0 [Note] [MY-011825] [InnoDB] page cleaner threads:
2025-04-28T10:19:49.110822Z 0 [Note] [MY-011825] [InnoDB] writer thread, id 696251968, uniqid 239
2025-04-28T10:19:49.110825Z 0 [Note] [MY-011825] [InnoDB] pgcleaner_coord thread, id 677369408, uniqid 240
2025-04-28T10:19:49.225144Z 1 [Note] [MY-011825] [InnoDB] HOTCACHE: restore(): Feature flag is off
2025-04-28T10:19:49.227774Z 1 [Note] [MY-013883] [InnoDB] The latest found checkpoint is at lsn = 4074541806417 in redo log file ./#innodb_redo/#ib_redo1829.
2025-04-28T10:19:49.228879Z 1 [Note] [MY-012560] [InnoDB] The log sequence number 4070442897044 in the system tablespace does not match the log sequence number 4074541806417 in the redo log files!
2025-04-28T10:19:49.228885Z 1 [Note] [MY-012551] [InnoDB] Database was not shutdown normally!
2025-04-28T10:19:49.228889Z 1 [Note] [MY-012552] [InnoDB] Starting crash recovery.
2025-04-28T10:19:49.232349Z 1 [Note] [MY-013086] [InnoDB] Starting to parse redo log at lsn = 4074541806151, whereas checkpoint_lsn = 4074541806417 and start_lsn = 4074541806080
2025-04-28T10:19:49.321893Z 1 [Note] [MY-012550] [InnoDB] Doing recovery: scanned up to log sequence number 4074544081973
2025-04-28T10:19:49.340814Z 1 [Note] [MY-013083] [InnoDB] Log background threads are being started...
2025-04-28T10:19:49.341319Z 1 [Note] [MY-012532] [InnoDB] Applying a batch of 778 redo log records ...
2025-04-28T10:19:49.377882Z 1 [Note] [MY-012533] [InnoDB] 10%
2025-04-28T10:19:49.392257Z 1 [Note] [MY-012533] [InnoDB] 20%
2025-04-28T10:19:49.419190Z 1 [Note] [MY-012533] [InnoDB] 30%
2025-04-28T10:19:49.453839Z 1 [Note] [MY-012533] [InnoDB] 40%
2025-04-28T10:19:49.494992Z 1 [Note] [MY-012533] [InnoDB] 50%
2025-04-28T10:19:49.500990Z 1 [Note] [MY-012533] [InnoDB] 60%
2025-04-28T10:19:49.522347Z 1 [Note] [MY-012533] [InnoDB] 70%
2025-04-28T10:19:49.546092Z 1 [Note] [MY-012533] [InnoDB] 80%
2025-04-28T10:19:49.556602Z 1 [Note] [MY-012533] [InnoDB] 90%
2025-04-28T10:19:49.586892Z 1 [Note] [MY-012533] [InnoDB] 100%
2025-04-28T10:19:50.094169Z 1 [Note] [MY-012535] [InnoDB] Apply batch completed!
2025-04-28T10:19:50.202660Z 1 [Note] [MY-013252] [InnoDB] Using undo tablespace './undo_001'.
2025-04-28T10:19:50.222346Z 1 [Note] [MY-013252] [InnoDB] Using undo tablespace './undo_002'.
2025-04-28T10:19:50.422736Z 1 [Note] [MY-012910] [InnoDB] Opened 2 existing undo tablespaces.
2025-04-28T10:19:50.422824Z 1 [Note] [MY-011980] [InnoDB] GTID recovery trx_no: 302673409
2025-04-28T10:19:50.866760Z 1 [Note] [MY-013776] [InnoDB] Parallel initialization of rseg complete
2025-04-28T10:19:50.866781Z 1 [Note] [MY-013777] [InnoDB] Time taken to initialize rseg using 4 thread: 443963 ms.
2025-04-28T10:19:50.882022Z 1 [Note] [MY-012255] [InnoDB] Removed temporary tablespace data file: "ibtmp1"
2025-04-28T10:19:50.882030Z 1 [Note] [MY-012923] [InnoDB] Creating shared tablespace for temporary tables
2025-04-28T10:19:50.885894Z 1 [Note] [MY-012265] [InnoDB] Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
2025-04-28T10:19:50.955720Z 1 [Note] [MY-012266] [InnoDB] File './ibtmp1' size is now 12 MB.
2025-04-28T10:19:50.961974Z 1 [Note] [MY-013627] [InnoDB] Scanning temp tablespace dir:'/mnt/temp/'
2025-04-28T10:19:50.970470Z 1 [Note] [MY-013018] [InnoDB] Created 128 and tracked 128 new rollback segment(s) in the temporary tablespace. 128 are now active.
2025-04-28T10:19:50.970640Z 0 [Note] [MY-011825] [InnoDB] aggressive page cleaner enabled
2025-04-28T10:19:50.970656Z 0 [Note] [MY-011953] [InnoDB] Page cleaner took 1861ms to flush 0 and evict 0 pages
2025-04-28T10:19:50.971819Z 1 [Note] [MY-012976] [InnoDB] 8.0.40 started; log sequence number 4074544082804
2025-04-28T10:19:50.971872Z 1 [System] [MY-013577] [InnoDB] InnoDB initialization has ended.
2025-04-28T10:19:51.005098Z 1 [Note] [MY-011089] [Server] Data dictionary restarting version '80023'.
2025-04-28T10:19:51.864500Z 1 [Note] [MY-012357] [InnoDB] Reading DD tablespace files
2025-04-28T10:19:52.344568Z 1 [Note] [MY-012356] [InnoDB] Scanned 3211 tablespaces. Validated 1024. Skipped 2187.
2025-04-28T10:19:52.375768Z 1 [Note] [MY-010006] [Server] Using data dictionary with version '80023'.
2025-04-28T10:19:52.399882Z 0 [ERROR] [MY-013180] [Server] Function 'aad_auth' already exists.
2025-04-28T10:19:52.399892Z 0 [Warning] [MY-010736] [Server] Couldn't load plugin named 'aad_auth' with soname 'aad_auth.so'.
2025-04-28T10:19:52.400079Z 0 [Note] [MY-000000] [Server] BINLOG: THD sync lock/cond enabled.
2025-04-28T10:19:52.595626Z 0 [Note] [MY-010902] [Server] Thread priority attribute setting in Resource Group SQL shall be ignored due to unsupported platform or insufficient privilege.
2025-04-28T10:19:52.637359Z 0 [Note] [MY-010855] [Server] Recovering after a crash using /app/work2/binlogs/mysql-bin
2025-04-28T10:19:52.641027Z 0 [System] [MY-010229] [Server] Starting XA crash recovery...
2025-04-28T10:19:52.644473Z 0 [Note] [MY-013911] [Server] Crash recovery finished in binlog engine. No attempts to commit, rollback or prepare any transactions.
2025-04-28T10:19:52.644484Z 0 [Note] [MY-013911] [Server] Crash recovery finished in InnoDB engine. No attempts to commit, rollback or prepare any transactions.
2025-04-28T10:19:52.644489Z 0 [System] [MY-010232] [Server] XA crash recovery finished.
2025-04-28T10:19:52.676490Z 0 [Note] [MY-012487] [InnoDB] DDL log recovery : begin
2025-04-28T10:19:52.679954Z 0 [Note] [MY-012488] [InnoDB] DDL log recovery : end
2025-04-28T10:19:52.680872Z 0 [Note] [MY-011825] [InnoDB] allocated 524288 dump buffer
2025-04-28T10:19:52.688142Z 0 [Note] [MY-012922] [InnoDB] Waiting for purge to start
2025-04-28T10:19:52.882225Z 0 [Note] [MY-010306] [Server] Skipping generation of SSL certificates as --auto_generate_certs is set to OFF.
2025-04-28T10:19:52.954563Z 0 [Warning] [MY-010068] [Server] CA certificate /app/work2/ca.pem is self signed.
2025-04-28T10:19:52.957196Z 0 [System] [MY-013602] [Server] Channel mysql_main configured to support TLS. Encrypted connections are now supported for this channel.
2025-04-28T10:19:52.957332Z 0 [Warning] [MY-013595] [Server] Failed to initialize TLS for channel: mysql_admin. See below for the description of exact issue.
2025-04-28T10:19:52.957337Z 0 [Warning] [MY-010069] [Server] Failed to set up SSL because of the following SSL library error: Failed to set ciphers to use
2025-04-28T10:19:52.960029Z 0 [Note] [MY-010308] [Server] Skipping generation of RSA key pair through --sha256_password_auto_generate_rsa_keys as key files are present in data directory.
2025-04-28T10:19:52.960088Z 0 [Note] [MY-010308] [Server] Skipping generation of RSA key pair through --caching_sha2_password_auto_generate_rsa_keys as key files are present in data directory.
2025-04-28T10:19:53.003149Z 0 [Note] [MY-010252] [Server] Server hostname (bind-address): '127.0.0.X'; port: 33062
2025-04-28T10:19:53.003977Z 0 [Note] [MY-010264] [Server] - '127.0.0.X' resolves to '127.0.0.X';
2025-04-28T10:19:53.004382Z 0 [Note] [MY-010251] [Server] Server socket created on IP: '127.0.0.X'.
2025-04-28T10:19:53.004804Z 0 [Note] [MY-010252] [Server] Server hostname (bind-address): '68488'; port: 3306
2025-04-28T10:19:53.004829Z 0 [Note] [MY-010253] [Server] IPv6 is available.
2025-04-28T10:19:53.005579Z 0 [Note] [MY-010264] [Server] - '71546' resolves to '71546';
2025-04-28T10:19:53.005958Z 0 [Note] [MY-010251] [Server] Server socket created on IP: '71546'.
2025-04-28T10:19:53.038115Z 0 [Warning] [MY-000067] [Server] unknown variable 'fuse_dir=/app/work2/'.
2025-04-28T10:19:53.038123Z 0 [Warning] [MY-000067] [Server] unknown variable 'validate_password_check_user_name=OFF'.
2025-04-28T10:19:53.038127Z 0 [Warning] [MY-000067] [Server] unknown variable 'validate_password_dictionary_file='.
2025-04-28T10:19:53.038129Z 0 [Warning] [MY-000067] [Server] unknown variable 'validate_password_length=8'.
2025-04-28T10:19:53.038131Z 0 [Warning] [MY-000067] [Server] unknown variable 'validate_password_mixed_case_count=1'.
2025-04-28T10:19:53.038133Z 0 [Warning] [MY-000067] [Server] unknown variable 'validate_password_number_count=1'.
2025-04-28T10:19:53.038135Z 0 [Warning] [MY-000067] [Server] unknown variable 'validate_password_policy=MEDIUM'.
2025-04-28T10:19:53.038137Z 0 [Warning] [MY-000067] [Server] unknown variable 'validate_password_special_char_count=1'.
2025-04-28T10:19:53.038139Z 0 [Warning] [MY-000067] [Server] unknown variable 'verlaine_BINLOGOV_ALIGN=4096'.
2025-04-28T10:19:53.134657Z 0 [Note] [MY-020014] [Server] Firewall rule table does not exist, no rules loaded.
2025-04-28T10:19:53.152881Z 0 [Note] [MY-020026] [Server] Failed to read record from __az_replication_current_state__ table, skip cert and whitelist process
2025-04-28T10:19:53.154501Z 0 [ERROR] [MY-020029] [Server] Fail to delete the master_whilelist file.
2025-04-28T10:19:53.173550Z 0 [Note] [MY-020027] [Server] Successfully read 1 records from __az_replica_information__ table
2025-04-28T10:19:53.204774Z 0 [Note] [MY-000000] [Server] INIT QUERIES: SET sql_log_bin = OFF; GRANT ALL PRIVILEGES ON *.* TO `superuser`@`localhost` WITH GRANT OPTION; GRANT ALL PRIVILEGES ON *.* TO `azure_superuser`@`127.0.0.1` WITH GRANT OPTION; GRANT APPLICATION_PASSWORD_ADMIN, FLUSH_OPTIMIZER_COSTS, FLUSH_STATUS, FLUSH_TABLES, FLUSH_USER_RESOURCES, REPLICATION_APPLIER, ROLE_ADMIN, SESSION_VARIABLES_ADMIN, SET_USER_ID, SHOW_ROUTINE, XA_RECOVER_ADMIN ON *.* TO 'admin'@'%' WITH GRANT OPTION; FLUSH PRIVILEGES; GRANT UPDATE,DELETE ON performance_schema.* TO 'admin'@'%' WITH GRANT OPTION; FLUSH PRIVILEGES;