Type:
Bug
Priority:
Major
Resolution:
Fixed
Affects Version/s:
10.0(EOL) , 10.1(EOL) , 10.2(EOL) , 10.3(EOL) , 10.4(EOL)
Note: this JIRA was formerly titled rpl.rpl_parallel, binlog_encryption.rpl_parallel fails in buildbot with timeout in include .
A replication parallel worker thread can deadlock with another
connection running SHOW SLAVE STATUS. That is, if the replication
worker thread is in do_gco_wait() and is killed, it will already
hold the LOCK_parallel_entry, and during error reporting, try to
grab the err_lock. SHOW SLAVE STATUS, however, grabs these locks in
reverse order. It will initially grab the err_lock, and then try to
grab LOCK_parallel_entry. This leads to a deadlock when both threads
have grabbed their first lock without the second.
This lead to test errors in rpl.rpl_parallel and binlog_encryption.rpl_parallel.
http://buildbot.askmonty.org/buildbot/builders/work-amd64-valgrind/builds/9240/steps/test/logs/stdio
rpl.rpl_parallel 'mix,xtradb' w2 [ fail ]
Test ended at 2016-08-23 22:06:29
CURRENT_TEST: rpl.rpl_parallel
mysqltest: In included file "./include/wait_for_slave_param.inc":
included from ./include/wait_for_slave_sql_to_start.inc at line 32:
included from ./include/wait_for_slave_to_start.inc at line 27:
included from ./include/start_slave.inc at line 35:
included from /mnt/data/buildot/maria-slave/work-opensuse-amd64/build/mysql-test/suite/rpl/t/rpl_parallel.test at line 355:
At line 115: Timeout in include/wait_for_slave_param.inc
The result from queries just before the failure was:
< snip >
'group_commit_waiting_for_prior SIGNAL slave_queued3',
''))
master-bin.000002 1417 Xid 1 1444 COMMIT /* xid=370 */
master-bin.000002 1444 Gtid 1 1482 BEGIN GTID 0-1-15
master-bin.000002 1482 Query 1 1571 use `test`; INSERT INTO t2 VALUES (20)
master-bin.000002 1571 Query 1 1660 use `test`; INSERT INTO t1 VALUES (20)
master-bin.000002 1660 Query 1 1749 use `test`; INSERT INTO t2 VALUES (21)
master-bin.000002 1749 Query 1 1842 use `test`; INSERT INTO t3 VALUES (20, 20)
master-bin.000002 1842 Xid 1 1869 COMMIT /* xid=433 */
master-bin.000002 1869 Gtid 1 1907 BEGIN GTID 0-1-16
master-bin.000002 1907 Query 1 1999 use `test`; INSERT INTO t3 VALUES(21, 21)
master-bin.000002 1999 Xid 1 2026 COMMIT /* xid=438 */
master-bin.000002 2026 Gtid 1 2064 BEGIN GTID 0-1-17
master-bin.000002 2064 Query 1 2156 use `test`; INSERT INTO t3 VALUES(22, 22)
master-bin.000002 2156 Xid 1 2183 COMMIT /* xid=439 */
**** 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
More results from queries before failure can be found in /mnt/data/buildot/maria-slave/work-opensuse-amd64/build/mysql-test/var/2/log/rpl_parallel.log
Happens not very often, but quite regularly.
{"report":{"fcp":828.1000001430511,"ttfb":181.29999995231628,"pageVisibility":"visible","entityId":57774,"key":"jira.project.issue.view-issue","isInitial":true,"threshold":1000,"elementTimings":{},"userDeviceMemory":8,"userDeviceProcessors":64,"apdex":1,"journeyId":"7cf13ce2-a4d0-469c-8137-bea92ae0973c","navigationType":0,"readyForUser":907.7999999523163,"redirectCount":0,"resourceLoadedEnd":571.2999999523163,"resourceLoadedStart":189.10000014305115,"resourceTiming":[{"duration":9.099999904632568,"initiatorType":"link","name":"https://jira.mariadb.org/s/2c21342762a6a02add1c328bed317ffd-CDN/lu2bu7/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/css/_super/batch.css","startTime":189.10000014305115,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":189.10000014305115,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":198.20000004768372,"responseStart":0,"secureConnectionStart":0},{"duration":9.200000047683716,"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":189.40000009536743,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":189.40000009536743,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":198.60000014305115,"responseStart":0,"secureConnectionStart":0},{"duration":222.29999995231628,"initiatorType":"script","name":"https://jira.mariadb.org/s/fbf975c0cce4b1abf04784eeae9ba1f4-CDN/lu2bu7/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/js/_super/batch.js?locale=en","startTime":189.5,"connectEnd":189.5,"connectStart":189.5,"domainLookupEnd":189.5,"domainLookupStart":189.5,"fetchStart":189.5,"redirectEnd":0,"redirectStart":0,"requestStart":200.90000009536743,"responseEnd":411.7999999523163,"responseStart":251.90000009536743,"secureConnectionStart":189.5},{"duration":381.69999980926514,"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":189.60000014305115,"connectEnd":189.60000014305115,"connectStart":189.60000014305115,"domainLookupEnd":189.60000014305115,"domainLookupStart":189.60000014305115,"fetchStart":189.60000014305115,"redirectEnd":0,"redirectStart":0,"requestStart":201.5,"responseEnd":571.2999999523163,"responseStart":252.5,"secureConnectionStart":189.60000014305115},{"duration":66,"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":189.70000004768372,"connectEnd":189.70000004768372,"connectStart":189.70000004768372,"domainLookupEnd":189.70000004768372,"domainLookupStart":189.70000004768372,"fetchStart":189.70000004768372,"redirectEnd":0,"redirectStart":0,"requestStart":205.60000014305115,"responseEnd":255.70000004768372,"responseStart":253.5,"secureConnectionStart":189.70000004768372},{"duration":66.10000014305115,"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":189.79999995231628,"connectEnd":189.79999995231628,"connectStart":189.79999995231628,"domainLookupEnd":189.79999995231628,"domainLookupStart":189.79999995231628,"fetchStart":189.79999995231628,"redirectEnd":0,"redirectStart":0,"requestStart":205.79999995231628,"responseEnd":255.90000009536743,"responseStart":254.10000014305115,"secureConnectionStart":189.79999995231628},{"duration":66.40000009536743,"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":189.79999995231628,"connectEnd":189.79999995231628,"connectStart":189.79999995231628,"domainLookupEnd":189.79999995231628,"domainLookupStart":189.79999995231628,"fetchStart":189.79999995231628,"redirectEnd":0,"redirectStart":0,"requestStart":207.90000009536743,"responseEnd":256.2000000476837,"responseStart":254.70000004768372,"secureConnectionStart":189.79999995231628},{"duration":14.700000047683716,"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":190,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":190,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":204.70000004768372,"responseStart":0,"secureConnectionStart":0},{"duration":133,"initiatorType":"script","name":"https://jira.mariadb.org/rest/api/1.0/shortcuts/820016/47140b6e0a9bc2e4913da06536125810/shortcuts.js?context=issuenavigation&context=issueaction","startTime":190.10000014305115,"connectEnd":190.10000014305115,"connectStart":190.10000014305115,"domainLookupEnd":190.10000014305115,"domainLookupStart":190.10000014305115,"fetchStart":190.10000014305115,"redirectEnd":0,"redirectStart":0,"requestStart":208.10000014305115,"responseEnd":323.10000014305115,"responseStart":321.90000009536743,"secureConnectionStart":190.10000014305115},{"duration":15.299999952316284,"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":190.20000004768372,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":190.20000004768372,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":205.5,"responseStart":0,"secureConnectionStart":0},{"duration":78.20000004768372,"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":190.29999995231628,"connectEnd":190.29999995231628,"connectStart":190.29999995231628,"domainLookupEnd":190.29999995231628,"domainLookupStart":190.29999995231628,"fetchStart":190.29999995231628,"redirectEnd":0,"redirectStart":0,"requestStart":208.5,"responseEnd":268.5,"responseStart":267.5,"secureConnectionStart":190.29999995231628},{"duration":271.7000000476837,"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":191.29999995231628,"connectEnd":191.29999995231628,"connectStart":191.29999995231628,"domainLookupEnd":191.29999995231628,"domainLookupStart":191.29999995231628,"fetchStart":191.29999995231628,"redirectEnd":0,"redirectStart":0,"requestStart":225,"responseEnd":463,"responseStart":459.5,"secureConnectionStart":191.29999995231628},{"duration":269.2999999523163,"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":193.5,"connectEnd":193.5,"connectStart":193.5,"domainLookupEnd":193.5,"domainLookupStart":193.5,"fetchStart":193.5,"redirectEnd":0,"redirectStart":0,"requestStart":224.70000004768372,"responseEnd":462.7999999523163,"responseStart":459,"secureConnectionStart":193.5},{"duration":172.79999995231628,"initiatorType":"xmlhttprequest","name":"https://jira.mariadb.org/rest/webResources/1.0/resources","startTime":553.1000001430511,"connectEnd":553.1000001430511,"connectStart":553.1000001430511,"domainLookupEnd":553.1000001430511,"domainLookupStart":553.1000001430511,"fetchStart":553.1000001430511,"redirectEnd":0,"redirectStart":0,"requestStart":699,"responseEnd":725.9000000953674,"responseStart":725.2999999523163,"secureConnectionStart":553.1000001430511}],"fetchStart":0,"domainLookupStart":0,"domainLookupEnd":0,"connectStart":0,"connectEnd":0,"requestStart":27,"responseStart":181,"responseEnd":194,"domLoading":184,"domInteractive":970,"domContentLoadedEventStart":970,"domContentLoadedEventEnd":1019,"domComplete":1686,"loadEventStart":1686,"loadEventEnd":1687,"userAgent":"Mozilla/5.0 AppleWebKit/537.36 (KHTML, like Gecko; compatible; ClaudeBot/1.0; +claudebot@anthropic.com)","marks":[{"name":"bigPipe.sidebar-id.start","time":947.4000000953674},{"name":"bigPipe.sidebar-id.end","time":948.1000001430511},{"name":"bigPipe.activity-panel-pipe-id.start","time":948.2999999523163},{"name":"bigPipe.activity-panel-pipe-id.end","time":949.9000000953674},{"name":"activityTabFullyLoaded","time":1040.1000001430511}],"measures":[],"correlationId":"d3a48588b3f5b3","effectiveType":"4g","downlink":10,"rtt":0,"serverDuration":83,"dbReadsTimeInMs":16,"dbConnsTimeInMs":23,"applicationHash":"9d11dbea5f4be3d4cc21f03a88dd11d8c8687422","experiments":[]}}
bnestere, that sounds good, will you take this bug then?