The test innodb.innodb_wl6326_big often fails on 10.5 with a timeout like this:
10.5 bf1f9b59c7d0b619d8bf350b96436970c6edc118
|
CURRENT_TEST: innodb.innodb_wl6326_big
|
--- /mariadb/10.5m/mysql-test/suite/innodb/r/innodb_wl6326_big.result 2020-11-18 09:12:22.901175040 +0200
|
+++ /mariadb/10.5m/mysql-test/suite/innodb/r/innodb_wl6326_big.reject 2021-01-23 17:50:07.760902099 +0200
|
@@ -365,6 +365,22 @@
|
COMMIT;
|
SHOW ENGINE INNODB STATUS;
|
# pass
|
+Timeout in wait_condition.inc for SELECT COUNT(*) = @sx_count
|
+FROM information_schema.innodb_metrics t_after
|
+JOIN my_metrics t_before
|
+ON t_after.COUNT_RESET > t_before.COUNT_RESET AND t_after.NAME = t_before.NAME
|
+Id User Host db Command Time State Info Progress
|
+7 root localhost my_schema Query 0 starting show full processlist 0.000
|
+8 root localhost my_schema Sleep 142 NULL 0.000
|
+9 root localhost my_schema Sleep 142 NULL 0.000
|
+10 root localhost my_schema Sleep 142 NULL 0.000
|
+11 root localhost my_schema Sleep 142 NULL 0.000
|
+12 root localhost my_schema Sleep 142 NULL 0.000
|
+13 root localhost my_schema Sleep 142 NULL 0.000
|
+14 root localhost my_schema Sleep 142 NULL 0.000
|
+15 root localhost my_schema Sleep 142 NULL 0.000
|
+16 root localhost my_schema Sleep 142 NULL 0.000
|
+17 root localhost my_schema Sleep 142 NULL 0.000
|
INSERT INTO my_metrics
|
SELECT NAME, COUNT, MAX_COUNT, MIN_COUNT, AVG_COUNT,
|
COUNT_RESET, MAX_COUNT_RESET, MIN_COUNT_RESET, AVG_COUNT_RESET,
|
@@ -379,71 +395,18 @@
|
# - One UPDATE statement modifying a huge slice of t1.
|
# Any of them causes heavy use of SX lock and therefore COUNT_RESET
|
# must have grown for ALL = @sx_count entries.
|
-# pass
|
-# TC-09 Heavy activity after reset.
|
-# COUNT_RESET = MAX_COUNT_RESET for ALL = @sx_count entries
|
-# needs to stay valid though he counters will have grown.
|
-# pass
|
-DELETE FROM my_metrics;
|
-INSERT INTO my_metrics
|
-SELECT NAME, COUNT, MAX_COUNT, MIN_COUNT, AVG_COUNT,
|
-COUNT_RESET, MAX_COUNT_RESET, MIN_COUNT_RESET, AVG_COUNT_RESET,
|
-TIME_ENABLED, TIME_DISABLED, TIME_ELAPSED, TIME_RESET,
|
-ENABLED, 'before'
|
-FROM information_schema.innodb_metrics
|
-WHERE NAME LIKE 'innodb_rwlock_sx_%';
|
-SET GLOBAL innodb_monitor_reset = "innodb_rwlock_sx_%";
|
-INSERT INTO my_metrics
|
-SELECT NAME, COUNT, MAX_COUNT, MIN_COUNT, AVG_COUNT,
|
-COUNT_RESET, MAX_COUNT_RESET, MIN_COUNT_RESET, AVG_COUNT_RESET,
|
-TIME_ENABLED, TIME_DISABLED, TIME_ELAPSED, TIME_RESET,
|
-ENABLED, 'after'
|
-FROM information_schema.innodb_metrics
|
-WHERE NAME LIKE 'innodb_rwlock_sx_%';
|
-# TC-08 There was a reset. COUNT_RESET = MAX_COUNT_RESET for ALL
|
-# = @sx_count entries.
|
-# pass
|
-# TC-17 We had heavy activity causing big counters and after that a reset.
|
-# Reset causes COUNT > COUNT_RESET AND MAX_COUNT > MAX_COUNT_RESET
|
-# for ALL @sx_count entries.
|
-# pass
|
-# TC-18 We had some reset but this must not decrease COUNT or MAX_COUNT
|
-# after.COUNT >= before.COUNT AND
|
-# after.MAX_COUNT >= before.MAX_COUNT for ALL @sx_count entries.
|
-# pass
|
-# TC-19 We had some reset after heavy activity and this must cause
|
-# after.COUNT_RESET < before.COUNT_RESET
|
-# AND after.MAX_COUNT_RESET < before.MAX_COUNT_RESET AND
|
-# for ALL @sx_count entries.
|
-# pass
|
-connection con10;
|
-disconnect con10;
|
-connection con9;
|
-disconnect con9;
|
-connection con8;
|
-disconnect con8;
|
-connection con7;
|
-disconnect con7;
|
-connection con6;
|
-disconnect con6;
|
-connection con5;
|
-disconnect con5;
|
-connection con4;
|
-disconnect con4;
|
-connection con3;
|
-disconnect con3;
|
-connection con2;
|
-disconnect con2;
|
-connection con1;
|
-disconnect con1;
|
-connection default;
|
-USE test;
|
-DROP SCHEMA my_schema;
|
-SET GLOBAL innodb_monitor_disable = all;
|
-SET GLOBAL innodb_monitor_reset_all = all;
|
-SET GLOBAL innodb_monitor_enable = default;
|
-SET GLOBAL innodb_monitor_disable = default;
|
-SET GLOBAL innodb_monitor_reset = default;
|
-SET GLOBAL innodb_monitor_reset_all = default;
|
-SET GLOBAL innodb_monitor_disable = "innodb_rwlock_sx_%";
|
-SET GLOBAL innodb_monitor_reset = "innodb_rwlock_sx_%";
|
+# fail
|
+SELECT COUNT(*) <> @sx_count FROM my_metrics t_after JOIN my_metrics t_before
|
+ON t_after.COUNT_RESET > t_before.COUNT_RESET AND t_after.NAME = t_before.NAME
|
+WHERE t_after.phase = 'after' AND t_before.phase = 'before';
|
+COUNT(*) <> @sx_count
|
+1
|
+SELECT * FROM my_metrics
|
+ORDER BY NAME, phase;
|
+NAME COUNT MAX_COUNT MIN_COUNT AVG_COUNT COUNT_RESET MAX_COUNT_RESET MIN_COUNT_RESET AVG_COUNT_RESET TIME_ENABLED TIME_DISABLED TIME_ELAPSED TIME_RESET ENABLED phase
|
+innodb_rwlock_sx_os_waits 0 0 NULL 0 0 0 NULL 0 2021-01-23 17:46:33 NULL 214 2021-01-23 17:46:34 1after
|
+innodb_rwlock_sx_os_waits 0 0 NULL 0 0 0 NULL NULL 2021-01-23 17:46:33 NULL 1 2021-01-23 17:46:34 1before
|
+innodb_rwlock_sx_spin_rounds 0 0 NULL 0 0 0 NULL 0 2021-01-23 17:46:33 NULL 214 2021-01-23 17:46:34 1after
|
+innodb_rwlock_sx_spin_rounds 0 0 NULL 0 0 0 NULL NULL 2021-01-23 17:46:33 NULL 1 2021-01-23 17:46:34 1before
|
+innodb_rwlock_sx_spin_waits 0 0 NULL 0 0 0 NULL 0 2021-01-23 17:46:33 NULL 214 2021-01-23 17:46:34 1after
|
+innodb_rwlock_sx_spin_waits 0 0 NULL 0 0 0 NULL NULL 2021-01-23 17:46:33 NULL 1 2021-01-23 17:46:34 1before
|
|
mysqltest: Result length mismatch
|
In 10.6, the test depends on instrumentation that was refactored or removed in MDEV-24142.
{"report":{"fcp":1118.6999988555908,"ttfb":488,"pageVisibility":"visible","entityId":96219,"key":"jira.project.issue.view-issue","isInitial":true,"threshold":1000,"elementTimings":{},"userDeviceMemory":8,"userDeviceProcessors":64,"apdex":0.5,"journeyId":"40f0af42-fb23-461e-b17c-022589520555","navigationType":0,"readyForUser":1271.599998474121,"redirectCount":0,"resourceLoadedEnd":1138.6999988555908,"resourceLoadedStart":493.8999996185303,"resourceTiming":[{"duration":149.5,"initiatorType":"link","name":"https://jira.mariadb.org/s/2c21342762a6a02add1c328bed317ffd-CDN/lu2bsh/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/css/_super/batch.css","startTime":493.8999996185303,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":493.8999996185303,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":643.3999996185303,"responseStart":0,"secureConnectionStart":0},{"duration":149.60000038146973,"initiatorType":"link","name":"https://jira.mariadb.org/s/7ebd35e77e471bc30ff0eba799ebc151-CDN/lu2bsh/820016/12ta74/eb142f92e4bd16bd1ef8b08c1b9d5d56/_/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":494.1999988555908,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":494.1999988555908,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":643.7999992370605,"responseStart":0,"secureConnectionStart":0},{"duration":210,"initiatorType":"script","name":"https://jira.mariadb.org/s/b09d0d077992e4331b5f9ec0d3ec448c-CDN/lu2bsh/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/js/_super/batch.js?locale=en","startTime":494.29999923706055,"connectEnd":494.29999923706055,"connectStart":494.29999923706055,"domainLookupEnd":494.29999923706055,"domainLookupStart":494.29999923706055,"fetchStart":494.29999923706055,"redirectEnd":0,"redirectStart":0,"requestStart":494.29999923706055,"responseEnd":704.2999992370605,"responseStart":704.2999992370605,"secureConnectionStart":494.29999923706055},{"duration":309.70000076293945,"initiatorType":"script","name":"https://jira.mariadb.org/s/b47ab3df14096803b180217eb8482517-CDN/lu2bsh/820016/12ta74/eb142f92e4bd16bd1ef8b08c1b9d5d56/_/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":494.29999923706055,"connectEnd":494.29999923706055,"connectStart":494.29999923706055,"domainLookupEnd":494.29999923706055,"domainLookupStart":494.29999923706055,"fetchStart":494.29999923706055,"redirectEnd":0,"redirectStart":0,"requestStart":494.29999923706055,"responseEnd":804,"responseStart":804,"secureConnectionStart":494.29999923706055},{"duration":313.6999988555908,"initiatorType":"script","name":"https://jira.mariadb.org/s/6c569cbf8087ab04e40d0bef98627457-CDN/lu2bsh/820016/12ta74/c92c0caa9a024ae85b0ebdbed7fb4bd7/_/download/contextbatch/js/atl.global,-_super/batch.js?locale=en","startTime":494.5,"connectEnd":494.5,"connectStart":494.5,"domainLookupEnd":494.5,"domainLookupStart":494.5,"fetchStart":494.5,"redirectEnd":0,"redirectStart":0,"requestStart":494.5,"responseEnd":808.1999988555908,"responseStart":808.1999988555908,"secureConnectionStart":494.5},{"duration":314.20000076293945,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bsh/820016/12ta74/1.0/_/download/batch/jira.webresources:calendar-en/jira.webresources:calendar-en.js","startTime":494.5999984741211,"connectEnd":494.5999984741211,"connectStart":494.5999984741211,"domainLookupEnd":494.5999984741211,"domainLookupStart":494.5999984741211,"fetchStart":494.5999984741211,"redirectEnd":0,"redirectStart":0,"requestStart":494.5999984741211,"responseEnd":808.7999992370605,"responseStart":808.7999992370605,"secureConnectionStart":494.5999984741211},{"duration":314.6000003814697,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bsh/820016/12ta74/1.0/_/download/batch/jira.webresources:calendar-localisation-moment/jira.webresources:calendar-localisation-moment.js","startTime":494.6999988555908,"connectEnd":494.6999988555908,"connectStart":494.6999988555908,"domainLookupEnd":494.6999988555908,"domainLookupStart":494.6999988555908,"fetchStart":494.6999988555908,"redirectEnd":0,"redirectStart":0,"requestStart":494.6999988555908,"responseEnd":809.2999992370605,"responseStart":809.2999992370605,"secureConnectionStart":494.6999988555908},{"duration":315,"initiatorType":"link","name":"https://jira.mariadb.org/s/b04b06a02d1959df322d9cded3aeecc1-CDN/lu2bsh/820016/12ta74/a2ff6aa845ffc9a1d22fe23d9ee791fc/_/download/contextbatch/css/jira.global.look-and-feel,-_super/batch.css","startTime":494.79999923706055,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":494.79999923706055,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":809.7999992370605,"responseStart":0,"secureConnectionStart":0},{"duration":314.79999923706055,"initiatorType":"script","name":"https://jira.mariadb.org/rest/api/1.0/shortcuts/820016/47140b6e0a9bc2e4913da06536125810/shortcuts.js?context=issuenavigation&context=issueaction","startTime":494.8999996185303,"connectEnd":494.8999996185303,"connectStart":494.8999996185303,"domainLookupEnd":494.8999996185303,"domainLookupStart":494.8999996185303,"fetchStart":494.8999996185303,"redirectEnd":0,"redirectStart":0,"requestStart":494.8999996185303,"responseEnd":809.6999988555908,"responseStart":809.6999988555908,"secureConnectionStart":494.8999996185303},{"duration":315.20000076293945,"initiatorType":"link","name":"https://jira.mariadb.org/s/3ac36323ba5e4eb0af2aa7ac7211b4bb-CDN/lu2bsh/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":495.0999984741211,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":495.0999984741211,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":810.2999992370605,"responseStart":0,"secureConnectionStart":0},{"duration":315.3000011444092,"initiatorType":"script","name":"https://jira.mariadb.org/s/81b5d7c27af3ebc078cc4a36383678ba-CDN/lu2bsh/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":495.1999988555908,"connectEnd":495.1999988555908,"connectStart":495.1999988555908,"domainLookupEnd":495.1999988555908,"domainLookupStart":495.1999988555908,"fetchStart":495.1999988555908,"redirectEnd":0,"redirectStart":0,"requestStart":495.1999988555908,"responseEnd":810.5,"responseStart":810.5,"secureConnectionStart":495.1999988555908},{"duration":584,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bsh/820016/12ta74/1.0/_/download/batch/jira.webresources:bigpipe-js/jira.webresources:bigpipe-js.js","startTime":496,"connectEnd":496,"connectStart":496,"domainLookupEnd":496,"domainLookupStart":496,"fetchStart":496,"redirectEnd":0,"redirectStart":0,"requestStart":496,"responseEnd":1080,"responseStart":1080,"secureConnectionStart":496},{"duration":606.6999988555908,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bsh/820016/12ta74/1.0/_/download/batch/jira.webresources:bigpipe-init/jira.webresources:bigpipe-init.js","startTime":496,"connectEnd":496,"connectStart":496,"domainLookupEnd":496,"domainLookupStart":496,"fetchStart":496,"redirectEnd":0,"redirectStart":0,"requestStart":496,"responseEnd":1102.6999988555908,"responseStart":1102.6999988555908,"secureConnectionStart":496},{"duration":222,"initiatorType":"xmlhttprequest","name":"https://jira.mariadb.org/rest/webResources/1.0/resources","startTime":858.5,"connectEnd":858.5,"connectStart":858.5,"domainLookupEnd":858.5,"domainLookupStart":858.5,"fetchStart":858.5,"redirectEnd":0,"redirectStart":0,"requestStart":858.5,"responseEnd":1080.5,"responseStart":1080.5,"secureConnectionStart":858.5},{"duration":9.899999618530273,"initiatorType":"script","name":"https://www.google-analytics.com/analytics.js","startTime":1111.1999988555908,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":1111.1999988555908,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":1121.099998474121,"responseStart":0,"secureConnectionStart":0},{"duration":3.299999237060547,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bsh/820016/12ta74/e65b778d185daf5aee24936755b43da6/_/download/contextbatch/js/browser-metrics-plugin.contrib,-_super,-project.issue.navigator,-jira.view.issue,-atl.general/batch.js?agile_global_admin_condition=true&jag=true&jira.create.linked.issue=true&slack-enabled=true","startTime":1135.3999996185303,"connectEnd":1135.3999996185303,"connectStart":1135.3999996185303,"domainLookupEnd":1135.3999996185303,"domainLookupStart":1135.3999996185303,"fetchStart":1135.3999996185303,"redirectEnd":0,"redirectStart":0,"requestStart":1135.3999996185303,"responseEnd":1138.6999988555908,"responseStart":1138.6999988555908,"secureConnectionStart":1135.3999996185303}],"fetchStart":0,"domainLookupStart":0,"domainLookupEnd":0,"connectStart":0,"connectEnd":0,"requestStart":341,"responseStart":488,"responseEnd":489,"domLoading":491,"domInteractive":1346,"domContentLoadedEventStart":1346,"domContentLoadedEventEnd":1403,"domComplete":2186,"loadEventStart":2186,"loadEventEnd":2186,"userAgent":"Mozilla/5.0 AppleWebKit/537.36 (KHTML, like Gecko; compatible; ClaudeBot/1.0; +claudebot@anthropic.com)","marks":[{"name":"bigPipe.sidebar-id.start","time":1322.599998474121},{"name":"bigPipe.sidebar-id.end","time":1323.3999996185303},{"name":"bigPipe.activity-panel-pipe-id.start","time":1323.5},{"name":"bigPipe.activity-panel-pipe-id.end","time":1326},{"name":"activityTabFullyLoaded","time":1411.2999992370605}],"measures":[],"correlationId":"44c00bef6f448c","effectiveType":"4g","downlink":10,"rtt":0,"serverDuration":78,"dbReadsTimeInMs":13,"dbConnsTimeInMs":21,"applicationHash":"9d11dbea5f4be3d4cc21f03a88dd11d8c8687422","experiments":[]}}