Hi all, After upgrading *MariaDB from 10.2.33 to 10.6.19*, the *SQL Slave Thread* stops roughly every 10 minutes. This only started occurring *after the upgrade*. If I perform a *switchover*, the issue starts happening on the new standby as well. We've mined the *binary log * and found no pattern in the statements where it stops. There are *no errors shown* in slave status. When we run START SLAVE;, everything resumes normally. Currently, you're using a *cron job* to restart the SQL thread regularly. - What could be causing this? - What deeper analysis can be done? 2025-06-25 8:59:25 3152832 [Note] Slave SQL thread exiting, replication
stopped in log 'binlog.001765' at position 657303910, master: xxxx:3306 2025-06-25 9:10:23 3157451 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001765' at position 988146286, master: xxxx:3306 2025-06-25 9:20:29 3162364 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001766' at position 220961201, master: xxxx:3306 2025-06-25 9:30:44 3166935 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001766' at position 529729081, master: xxxx:3306 2025-06-25 9:41:26 3171556 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001766' at position 848593645, master: xxxx:3306 2025-06-25 10:02:46 3176393 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001767' at position 420380054, master: xxxx:3306 2025-06-25 10:13:56 3186023 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001767' at position 753631615, master: xxxx:3306 2025-06-25 10:24:32 3191029 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001767' at position 1072243011, master: xxxx:3306 2025-06-25 10:36:14 3195944 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001768' at position 345337292, master: xxxx:3306 2025-06-25 11:17:57 3201245 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001769' at position 481728557, master: xxxx:3306 2025-06-25 11:49:04 3219634 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001770' at position 277881467, master: xxxx:3306 2025-06-25 11:59:55 3233322 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001770' at position 562687566, master: xxxx:3306 2025-06-25 12:30:41 3237753 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001771' at position 278373954, master: xxxx:3306 2025-06-25 12:51:30 3250513 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001771' at position 796578679, master: xxxx:3306 2025-06-25 13:02:19 3259002 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001771' at position 1052723773, master: xxxx:3306 2025-06-25 13:55:51 3263370 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001773' at position 98331358, master: xxxx:3306 2025-06-25 14:39:13 3283845 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001773' at position 968704509, master: xxxx:3306 2025-06-25 14:49:38 3299620 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001774' at position 93970604, master: xxxx:3306 2025-06-25 15:01:35 3303181 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001774' at position 313622321, master: xxxx:3306 2025-06-25 15:33:48 3307316 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001774' at position 895518570, master: xxxx:3306 2025-06-25 16:26:06 3318376 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001775' at position 770087908, master: xxxx:3306 2025-06-25 17:08:48 3336364 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001776' at position 459626350, master: xxxx:3306 2025-06-25 17:29:58 3350747 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001776' at position 839271624, master: xxxx:3306 2025-06-25 18:02:42 3357922 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001777' at position 349932886, master: xxxx:3306 2025-06-25 18:23:19 3369124 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001777' at position 694190140, master: xxxx:3306 2025-06-25 18:54:53 3375957 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001778' at position 93981370, master: xxxx:3306 2025-06-25 19:15:51 3385736 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001778' at position 366703217, master: xxxx:3306
Thanks in advance
Mário Cova via discuss <discuss@lists.mariadb.org> writes:
After upgrading *MariaDB from 10.2.33 to 10.6.19*, the *SQL Slave Thread* stops roughly every 10 minutes. This only started occurring *after the
2025-06-25 8:59:25 3152832 [Note] Slave SQL thread exiting, replication
stopped in log 'binlog.001765' at position 657303910, master: xxxx:3306 2025-06-25 9:10:23 3157451 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001765' at position 988146286, master: xxxx:3306
This looks like an extract from the server error log. But there must be more lines in the log about the SQL thread exiting. There should at least be matching lines everytime the SQL thread was restarted (eg. by the cron job). What is the full contents of the error log covering a couple of these occurrences? - Kristian.
You can find below an occurrence of exiting and starting (in this case via cron). No errors in show slave. 2025-06-26 9:52:38 3608192 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:39 3608198 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:40 3603689 [Note] Slave SQL thread exiting, replication stopped in log 'binlog.001785' at position 192319795, master: 172.17.18.51:3306 2025-06-26 9:52:42 3608213 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:43 3608215 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:43 3608216 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:44 3608218 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:47 3608222 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:47 3608223 [Warning] Access denied for user 'cmonexporter'@'127.0.0.1' (using password: YES) 2025-06-26 9:52:47 3608224 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:48 3608226 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:48 3608228 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:49 3608229 [Warning] Aborted connection 3608229 to db: 'unconnected' user: 'unauthenticated' host: 'xxxxxxxxxxx' (This connection closed normally without authentication) 2025-06-26 9:52:49 3608230 [Warning] Aborted connection 3608230 to db: 'unconnected' user: 'unauthenticated' host: 'xxxxxxxxxxx' (This connection closed normally without authentication) 2025-06-26 9:52:49 3608231 [Warning] Aborted connection 3608231 to db: 'unconnected' user: 'unauthenticated' host: 'xxxxxxxxxxx' (This connection closed normally without authentication) 2025-06-26 9:52:49 3608232 [Warning] Aborted connection 3608232 to db: 'unconnected' user: 'unauthenticated' host: 'xxxxxxxxxxx' (This connection closed normally without authentication) 2025-06-26 9:52:49 3608233 [Warning] Aborted connection 3608233 to db: 'unconnected' user: 'unauthenticated' host: 'xxxxxxxxxxx' (This connection closed normally without authentication) 2025-06-26 9:52:49 3608234 [Warning] Aborted connection 3608234 to db: 'unconnected' user: 'unauthenticated' host: 'xxxxxxxxxxx' (This connection closed normally without authentication) 2025-06-26 9:52:49 3608235 [Warning] Aborted connection 3608235 to db: 'unconnected' user: 'unauthenticated' host: 'xxxxxxxxxxx' (This connection closed normally without authentication) 2025-06-26 9:52:49 3608236 [Warning] Aborted connection 3608236 to db: 'unconnected' user: 'unauthenticated' host: 'xxxxxxxxxxx' (This connection closed normally without authentication) 2025-06-26 9:52:49 3608237 [Warning] Aborted connection 3608237 to db: 'unconnected' user: 'unauthenticated' host: 'xxxxxxxxxxx' (This connection closed normally without authentication) 2025-06-26 9:52:49 3608238 [Warning] Aborted connection 3608238 to db: 'unconnected' user: 'unauthenticated' host: 'xxxxxxxxxxx' (This connection closed normally without authentication) 2025-06-26 9:52:52 3608242 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:53 3608244 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:53 3608245 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:53 3608246 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:57 3608251 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:57 3608252 [Warning] Access denied for user 'cmonexporter'@'127.0.0.1' (using password: YES) 2025-06-26 9:52:58 3608254 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:58 3608255 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:52:59 3608257 [Warning] Access denied for user 's9smysqlchk'@'::1' (using password: YES) 2025-06-26 9:53:01 3608261 [Note] Slave SQL thread initialized, starting replication in log 'binlog.001785' at position 192319795, relay log './relay-bin.000490' position: 192320091 2025-06-26 9:53:01 3608261 [Note] WSREP: ready state reached
participants (3)
-
Kristian Nielsen -
mario.cova＠gmail.com -
Mário Cova