Type:
Bug
Priority:
Critical
Resolution:
Fixed
Affects Version/s:
10.5 , 10.6 , 10.8(EOL) , 10.9(EOL) , 10.10(EOL) , 10.11 , 11.0(EOL)
From knielsen :
There is a small window between when the SQL thread reports itself running, and when it clears any error set by a previous error stop. Thus a race exists where include/rpl_end.inc can see the previous error being set, causing it to fail the test.
This can be observed by the following test failure with rpl.rpl_xa_prepare_gtid_fail:
https://buildbot.mariadb.org/#/builders/208/builds/12453
10.6 fe89df426
rpl.rpl_xa_prepare_gtid_fail 'innodb,row' w17 [ fail ]
Test ended at 2023-05-02 10:11:23
CURRENT_TEST: rpl.rpl_xa_prepare_gtid_fail
mysqltest: In included file "./include/check_slave_param.inc":
included from ./include/check_slave_no_error.inc at line 24:
included from ./include/rpl_end.inc at line 74:
included from /home/buildbot/amd64-ubuntu-1804-bigtest/build/mysql-test/suite/rpl/t/rpl_xa_prepare_gtid_fail.test at line 106:
At line 31: Wrong value for slave parameter Last_SQL_Errno
The result from queries just before the failure was:
< snip >
master-bin.000001 590 Table_map 1 636 table_id: 32 (test.t1)
master-bin.000001 636 Write_rows_v1 1 678 table_id: 32 flags: STMT_END_F
master-bin.000001 678 Xid 1 709 COMMIT /* xid=154 */
master-bin.000001 709 Gtid 1 754 XA START X'31',X'',1 GTID 0-1-100
master-bin.000001 754 Annotate_rows 1 807 update t1 set b=b+10 where a=1
master-bin.000001 807 Table_map 1 853 table_id: 32 (test.t1)
master-bin.000001 853 Update_rows_v1 1 905 table_id: 32 flags: STMT_END_F
master-bin.000001 905 Query 1 990 XA END X'31',X'',1
master-bin.000001 990 XA_prepare 1 1027 XA PREPARE X'31',X'',1
master-bin.000001 1027 Gtid 1 1070 GTID 0-1-101
master-bin.000001 1070 Query 1 1158 XA COMMIT X'31',X'',1
master-bin.000001 1158 Gtid 1 1200 GTID 0-1-102
master-bin.000001 1200 Query 1 1317 use `test`; DROP TABLE `t1` /* generated by server */
**** SHOW RELAYLOG EVENTS on server_1 ****
relaylog_name = 'No such row'
SHOW RELAYLOG EVENTS IN 'No such row';
Log_name Pos Event_type Server_id End_log_pos Info
connection server_2;
Wrong value for Last_SQL_Errno. Expected '0', got '1942'
The slave error log shows an abnormal server shutdown with "initiated by: unknown":
2023-05-02 10:11:23 0 [Note] /home/buildbot/amd64-ubuntu-1804-bigtest/build/sql/mariadbd (initiated by: unknown): Normal shutdown
2023-05-02 10:11:23 24 [Note] Error reading relay log event: slave SQL thread was killed
2023-05-02 10:11:23 24 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 1317; GTID position '0-1-102', master: 127.0.0.1:16300
2023-05-02 10:11:23 23 [Note] Slave I/O thread killed during or after a reconnect done to recover from failed read
2023-05-02 10:11:23 23 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 1317; GTID position 0-1-102, master 127.0.0.1:16300
2023-05-02 10:11:23 0 [Note] InnoDB: FTS optimize thread exiting.
2023-05-02 10:11:23 0 [Note] InnoDB: Starting shutdown...
causes
MDEV-32651
Lost Debug_sync signal in rpl_sql_thd_start_errno_cleared
Closed
{"report":{"fcp":866,"ttfb":141.39999985694885,"pageVisibility":"visible","entityId":121540,"key":"jira.project.issue.view-issue","isInitial":true,"threshold":1000,"elementTimings":{},"userDeviceMemory":8,"userDeviceProcessors":64,"apdex":1,"journeyId":"908987b2-e875-483b-99bd-3edbc1a98068","navigationType":0,"readyForUser":937.8999998569489,"redirectCount":0,"resourceLoadedEnd":1200.2000000476837,"resourceLoadedStart":146.79999995231628,"resourceTiming":[{"duration":277.2999999523163,"initiatorType":"link","name":"https://jira.mariadb.org/s/2c21342762a6a02add1c328bed317ffd-CDN/lu2bu7/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/css/_super/batch.css","startTime":146.79999995231628,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":146.79999995231628,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":424.09999990463257,"responseStart":0,"secureConnectionStart":0},{"duration":277,"initiatorType":"link","name":"https://jira.mariadb.org/s/7ebd35e77e471bc30ff0eba799ebc151-CDN/lu2bu7/820016/12ta74/8679b4946efa1a0bb029a3a22206fb5d/_/download/contextbatch/css/jira.browse.project,project.issue.navigator,jira.view.issue,jira.general,jira.global,atl.general,-_super/batch.css?agile_global_admin_condition=true&jag=true&jira.create.linked.issue=true&slack-enabled=true","startTime":147.09999990463257,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":147.09999990463257,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":424.09999990463257,"responseStart":0,"secureConnectionStart":0},{"duration":285.89999985694885,"initiatorType":"script","name":"https://jira.mariadb.org/s/fbf975c0cce4b1abf04784eeae9ba1f4-CDN/lu2bu7/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/js/_super/batch.js?locale=en","startTime":147.20000004768372,"connectEnd":147.20000004768372,"connectStart":147.20000004768372,"domainLookupEnd":147.20000004768372,"domainLookupStart":147.20000004768372,"fetchStart":147.20000004768372,"redirectEnd":0,"redirectStart":0,"requestStart":147.20000004768372,"responseEnd":433.09999990463257,"responseStart":433.09999990463257,"secureConnectionStart":147.20000004768372},{"duration":310.90000009536743,"initiatorType":"script","name":"https://jira.mariadb.org/s/099b33461394b8015fc36c0a4b96e19f-CDN/lu2bu7/820016/12ta74/8679b4946efa1a0bb029a3a22206fb5d/_/download/contextbatch/js/jira.browse.project,project.issue.navigator,jira.view.issue,jira.general,jira.global,atl.general,-_super/batch.js?agile_global_admin_condition=true&jag=true&jira.create.linked.issue=true&locale=en&slack-enabled=true","startTime":147.29999995231628,"connectEnd":147.29999995231628,"connectStart":147.29999995231628,"domainLookupEnd":147.29999995231628,"domainLookupStart":147.29999995231628,"fetchStart":147.29999995231628,"redirectEnd":0,"redirectStart":0,"requestStart":147.29999995231628,"responseEnd":458.2000000476837,"responseStart":458.2000000476837,"secureConnectionStart":147.29999995231628},{"duration":314.60000014305115,"initiatorType":"script","name":"https://jira.mariadb.org/s/94c15bff32baef80f4096a08aceae8bc-CDN/lu2bu7/820016/12ta74/c92c0caa9a024ae85b0ebdbed7fb4bd7/_/download/contextbatch/js/atl.global,-_super/batch.js?locale=en","startTime":147.39999985694885,"connectEnd":147.39999985694885,"connectStart":147.39999985694885,"domainLookupEnd":147.39999985694885,"domainLookupStart":147.39999985694885,"fetchStart":147.39999985694885,"redirectEnd":0,"redirectStart":0,"requestStart":147.39999985694885,"responseEnd":462,"responseStart":462,"secureConnectionStart":147.39999985694885},{"duration":315.09999990463257,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bu7/820016/12ta74/1.0/_/download/batch/jira.webresources:calendar-en/jira.webresources:calendar-en.js","startTime":147.5,"connectEnd":147.5,"connectStart":147.5,"domainLookupEnd":147.5,"domainLookupStart":147.5,"fetchStart":147.5,"redirectEnd":0,"redirectStart":0,"requestStart":147.5,"responseEnd":462.59999990463257,"responseStart":462.59999990463257,"secureConnectionStart":147.5},{"duration":315.2999999523163,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bu7/820016/12ta74/1.0/_/download/batch/jira.webresources:calendar-localisation-moment/jira.webresources:calendar-localisation-moment.js","startTime":147.59999990463257,"connectEnd":147.59999990463257,"connectStart":147.59999990463257,"domainLookupEnd":147.59999990463257,"domainLookupStart":147.59999990463257,"fetchStart":147.59999990463257,"redirectEnd":0,"redirectStart":0,"requestStart":147.59999990463257,"responseEnd":462.89999985694885,"responseStart":462.89999985694885,"secureConnectionStart":147.59999990463257},{"duration":316,"initiatorType":"link","name":"https://jira.mariadb.org/s/b04b06a02d1959df322d9cded3aeecc1-CDN/lu2bu7/820016/12ta74/a2ff6aa845ffc9a1d22fe23d9ee791fc/_/download/contextbatch/css/jira.global.look-and-feel,-_super/batch.css","startTime":147.70000004768372,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":147.70000004768372,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":463.7000000476837,"responseStart":0,"secureConnectionStart":0},{"duration":315.7000000476837,"initiatorType":"script","name":"https://jira.mariadb.org/rest/api/1.0/shortcuts/820016/47140b6e0a9bc2e4913da06536125810/shortcuts.js?context=issuenavigation&context=issueaction","startTime":147.79999995231628,"connectEnd":147.79999995231628,"connectStart":147.79999995231628,"domainLookupEnd":147.79999995231628,"domainLookupStart":147.79999995231628,"fetchStart":147.79999995231628,"redirectEnd":0,"redirectStart":0,"requestStart":147.79999995231628,"responseEnd":463.5,"responseStart":463.5,"secureConnectionStart":147.79999995231628},{"duration":316,"initiatorType":"link","name":"https://jira.mariadb.org/s/3ac36323ba5e4eb0af2aa7ac7211b4bb-CDN/lu2bu7/820016/12ta74/d176f0986478cc64f24226b3d20c140d/_/download/contextbatch/css/com.atlassian.jira.projects.sidebar.init,-_super,-project.issue.navigator,-jira.view.issue/batch.css?jira.create.linked.issue=true","startTime":148,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":148,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":464,"responseStart":0,"secureConnectionStart":0},{"duration":316.10000014305115,"initiatorType":"script","name":"https://jira.mariadb.org/s/3339d87fa2538a859872f2df449bf8d0-CDN/lu2bu7/820016/12ta74/d176f0986478cc64f24226b3d20c140d/_/download/contextbatch/js/com.atlassian.jira.projects.sidebar.init,-_super,-project.issue.navigator,-jira.view.issue/batch.js?jira.create.linked.issue=true&locale=en","startTime":148.09999990463257,"connectEnd":148.09999990463257,"connectStart":148.09999990463257,"domainLookupEnd":148.09999990463257,"domainLookupStart":148.09999990463257,"fetchStart":148.09999990463257,"redirectEnd":0,"redirectStart":0,"requestStart":148.09999990463257,"responseEnd":464.2000000476837,"responseStart":464.2000000476837,"secureConnectionStart":148.09999990463257},{"duration":1045.6000001430511,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bu7/820016/12ta74/1.0/_/download/batch/jira.webresources:bigpipe-js/jira.webresources:bigpipe-js.js","startTime":153.59999990463257,"connectEnd":153.59999990463257,"connectStart":153.59999990463257,"domainLookupEnd":153.59999990463257,"domainLookupStart":153.59999990463257,"fetchStart":153.59999990463257,"redirectEnd":0,"redirectStart":0,"requestStart":153.59999990463257,"responseEnd":1199.2000000476837,"responseStart":1199.2000000476837,"secureConnectionStart":153.59999990463257},{"duration":1046.6000001430511,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bu7/820016/12ta74/1.0/_/download/batch/jira.webresources:bigpipe-init/jira.webresources:bigpipe-init.js","startTime":153.59999990463257,"connectEnd":153.59999990463257,"connectStart":153.59999990463257,"domainLookupEnd":153.59999990463257,"domainLookupStart":153.59999990463257,"fetchStart":153.59999990463257,"redirectEnd":0,"redirectStart":0,"requestStart":153.59999990463257,"responseEnd":1200.2000000476837,"responseStart":1200.2000000476837,"secureConnectionStart":153.59999990463257},{"duration":418.7999999523163,"initiatorType":"xmlhttprequest","name":"https://jira.mariadb.org/rest/webResources/1.0/resources","startTime":666.2999999523163,"connectEnd":666.2999999523163,"connectStart":666.2999999523163,"domainLookupEnd":666.2999999523163,"domainLookupStart":666.2999999523163,"fetchStart":666.2999999523163,"redirectEnd":0,"redirectStart":0,"requestStart":666.2999999523163,"responseEnd":1085.0999999046326,"responseStart":1085.0999999046326,"secureConnectionStart":666.2999999523163}],"fetchStart":0,"domainLookupStart":0,"domainLookupEnd":0,"connectStart":0,"connectEnd":0,"requestStart":15,"responseStart":142,"responseEnd":148,"domLoading":145,"domInteractive":1219,"domContentLoadedEventStart":1219,"domContentLoadedEventEnd":1254,"domComplete":1951,"loadEventStart":1951,"loadEventEnd":1953,"userAgent":"Mozilla/5.0 AppleWebKit/537.36 (KHTML, like Gecko; compatible; ClaudeBot/1.0; +claudebot@anthropic.com)","marks":[{"name":"bigPipe.sidebar-id.start","time":1202.5},{"name":"bigPipe.sidebar-id.end","time":1203.2999999523163},{"name":"bigPipe.activity-panel-pipe-id.start","time":1203.3999998569489},{"name":"bigPipe.activity-panel-pipe-id.end","time":1205.8999998569489},{"name":"activityTabFullyLoaded","time":1262.8999998569489}],"measures":[],"correlationId":"49943b97bf5bad","effectiveType":"4g","downlink":9.4,"rtt":0,"serverDuration":69,"dbReadsTimeInMs":11,"dbConnsTimeInMs":19,"applicationHash":"9d11dbea5f4be3d4cc21f03a88dd11d8c8687422","experiments":[]}}