1. Start the server, create one table and fill it with 100 rows.
2. Session 1 runs in a loop some update like
UPDATE table100_innodb_int_autoinc SET `col_varchar_255_ucs2_key` = CONVERT( 'degsotrsfannidwyvkuvlkeslrryhpkeevqmbksdrzadzpyisznignsytihyjixyalxfxpnafjwzgnkbbayklurufrsajtzohanbuvcfyykvtmesobixwipkoihhqykvoejckythjnjshxgohmecmklxryubdexjgxehdiqqui' USING ASCII )
Session 2 runs in a loop
CHECK TABLE table100_innodb_int_autoinc EXTENDED
After short time the CHECK TABLE harvests a
test.table100_innodb_int_autoinc check Warning InnoDB: Index 'col_varchar_255_ucs2_key' contains 98 entries, should be 100.
Currently it looks like we are constructing wrong old_vers with (pk=63,DB_TRX_ID=0x3c,(update)) and apparently empty string. It is as if CHECK TABLE is using a newer read view for accessing the clustered index.
Marko Mäkelä
added a comment - I will have to debug the trace further (around when 61095) to check why exactly we are assigning clust_rec=NULL here:
if (clust_rec
&& (old_vers
|| trx->isolation_level <= TRX_ISO_READ_UNCOMMITTED
|| dict_index_is_spatial(sec_index)
|| rec_get_deleted_flag(rec, dict_table_is_comp(
sec_index->table)))) {
err = row_sel_sec_rec_is_for_clust_rec(rec, sec_index,
clust_rec, clust_index, thr);
switch (err) {
case DB_SUCCESS:
clust_rec = NULL;
break ;
Currently it looks like we are constructing wrong old_vers with (pk=63,DB_TRX_ID=0x3c,(update)) and apparently empty string. It is as if CHECK TABLE is using a newer read view for accessing the clustered index.
For the clustered index scan in the failing CHECK TABLE, row_sel_clust_sees() will not hold for the single record
(pk,DB_TRX_ID,DB_ROLL_PTR,col_varchar_255_ucs2_key,…)=
(63,0x3e,(update),'degsotrsfann'…,…)
so we constructed old_vers that contains a BLOB reference for that column:
(pk,DB_TRX_ID,DB_ROLL_PTR,col_varchar_255_ucs2_key,…)=
(63,0x3c,(update),(space=8, page=5, offset=0x26, length=0x1f0),…)
The payload of the BLOB page is the following UTF-16BE encoded 248-char ASCII string:
The prefix of this seems to match the delete-marked record in the secondary index page that I posted earlier.
So, nothing seems to be really corrupted, but the secondary index MVCC code probably fails to read the BLOB, and instead treats the 20-byte BLOB pointer as the actual string. I will post more, once I have debugged that part of the code.
Marko Mäkelä
added a comment - For the clustered index scan in the failing CHECK TABLE , row_sel_clust_sees() will not hold for the single record
(pk,DB_TRX_ID,DB_ROLL_PTR,col_varchar_255_ucs2_key,…)=
(63,0x3e,(update),'degsotrsfann'…,…)
so we constructed old_vers that contains a BLOB reference for that column:
(pk,DB_TRX_ID,DB_ROLL_PTR,col_varchar_255_ucs2_key,…)=
(63,0x3c,(update),(space=8, page=5, offset=0x26, length=0x1f0),…)
The payload of the BLOB page is the following UTF-16BE encoded 248-char ASCII string:
qemleuzymtgopfikwzloyibtgehtjhlablwaewqzuglpeoqnnoxsqeyzbocilomtnpaxihztdrtqahffxekdhrwdvtdvmlshvdhrgfkmuwonkyqzwelujpeyggixymdugzhiqlmnrlpxzrytoatxolflxdzknhkgyttnjqwqcutogtwviuoqkbzxlbzkzdupmxeeifroaweulyyetwdnnrvxrtoksrgcplpyubzpyntedwlgnvzehakg
The prefix of this seems to match the delete-marked record in the secondary index page that I posted earlier.
So, nothing seems to be really corrupted, but the secondary index MVCC code probably fails to read the BLOB, and instead treats the 20-byte BLOB pointer as the actual string. I will post more, once I have debugged that part of the code.
We have this code in row_sel_sec_rec_is_for_clust_rec():
if (ifield->prefix_len > 0 && len != UNIV_SQL_NULL
&& sec_len != UNIV_SQL_NULL && !is_virtual) {
if (rec_offs_nth_extern(clust_offs, clust_pos)) {
len -= BTR_EXTERN_FIELD_REF_SIZE;
}
len = dtype_get_at_most_n_mbchars(
col->prtype, col->mbminlen, col->mbmaxlen,
ifield->prefix_len, len, (char*) clust_field);
if (rec_offs_nth_extern(clust_offs, clust_pos)
&& len < sec_len) {
if (!row_sel_sec_rec_is_for_blob(
Because the secondary index does not comprise a column prefix, but in fact the full column col_varchar_255_ucs2_key, we fail to invoke the check for BLOB (really, off-page column, in this case VARCHAR).
This should mean that MVCC is broken for full-column secondary indexes in ROW_FORMAT=DYNAMIC and ROW_FORMAT=COMPRESSED InnoDB tables if the column happened to become chosen for external storage in the clustered index. In ROW_FORMAT=REDUNDANT (the default and only format until MySQL 5.0.3) and ROW_FORMAT=COMPACT (the default between MySQL 5.0.3 and 5.7, or MariaDB Server before 10.2.2), we would always store the entire column in the clustered index.
I will have to check if something similar is broken in the implicit locking of secondary indexes, in row_vers_impl_x_locked_low(). If the call to row_build() is not fetching the externally stored VARCHAR column, locking for secondary index records could be broken. I will try to verify that on a copy of the data directory and possibly a patched server.
Marko Mäkelä
added a comment - We have this code in row_sel_sec_rec_is_for_clust_rec() :
if (ifield->prefix_len > 0 && len != UNIV_SQL_NULL
&& sec_len != UNIV_SQL_NULL && !is_virtual) {
if (rec_offs_nth_extern(clust_offs, clust_pos)) {
len -= BTR_EXTERN_FIELD_REF_SIZE;
}
len = dtype_get_at_most_n_mbchars(
col->prtype, col->mbminlen, col->mbmaxlen,
ifield->prefix_len, len, ( char *) clust_field);
if (rec_offs_nth_extern(clust_offs, clust_pos)
&& len < sec_len) {
if (!row_sel_sec_rec_is_for_blob(
Because the secondary index does not comprise a column prefix, but in fact the full column col_varchar_255_ucs2_key , we fail to invoke the check for BLOB (really, off-page column, in this case VARCHAR ).
This should mean that MVCC is broken for full-column secondary indexes in ROW_FORMAT=DYNAMIC and ROW_FORMAT=COMPRESSED InnoDB tables if the column happened to become chosen for external storage in the clustered index. In ROW_FORMAT=REDUNDANT (the default and only format until MySQL 5.0.3) and ROW_FORMAT=COMPACT (the default between MySQL 5.0.3 and 5.7, or MariaDB Server before 10.2.2), we would always store the entire column in the clustered index.
I will have to check if something similar is broken in the implicit locking of secondary indexes, in row_vers_impl_x_locked_low() . If the call to row_build() is not fetching the externally stored VARCHAR column, locking for secondary index records could be broken. I will try to verify that on a copy of the data directory and possibly a patched server.
I believe that the bug affects also earlier versions, but I did not test it, because MariaDB 5.5, 10.0, 10.1 have already reached their end of life.
Also, this test case only repeats the problem for innodb_page_size=4k, it should be repeatable with any page size when using appropriately sized records.
Marko Mäkelä
added a comment - I can repeat the problem with the following:
--source include/innodb_page_size_small.inc
CREATE TABLE t1 (
pk int PRIMARY KEY , c varchar (255) UNIQUE ,
d char (255), e varchar (255), f char (255), g char (255)
) ENGINE=InnoDB ROW_FORMAT= DYNAMIC DEFAULT CHARACTER SET ucs2;
INSERT INTO t1 VALUES
(1,REPEAT( 'c' ,248),REPEAT( 'a' ,106),REPEAT( 'b' ,220),REPEAT( 'x' ,14), '' );
BEGIN ;
UPDATE t1 SET c=REPEAT( 'd' ,170);
connect (con1,localhost,root,,);
SELECT pk FROM t1 FORCE INDEX (c);
connection default ;
COMMIT ;
connection con1;
SELECT pk FROM t1 FORCE INDEX (c);
disconnect con1;
connection default ;
DROP TABLE t1;
10.2 922e676b43c7b5cb0f20ca67c6d2222e2fc5ec03
innodb.mvcc_secondary '16k,innodb' w1 [ pass ] 6
innodb.mvcc_secondary '8k,innodb' w3 [ pass ] 5
innodb.mvcc_secondary '4k,innodb' w2 [ fail ]
Test ended at 2021-04-23 14:06:40
CURRENT_TEST: innodb.mvcc_secondary
--- /mariadb/10.2o/mysql-test/suite/innodb/r/mvcc_secondary.result 2021-04-23 14:06:25.841488727 +0300
+++ /mariadb/10.2o/mysql-test/suite/innodb/r/mvcc_secondary.reject 2021-04-23 14:06:40.565659501 +0300
@@ -9,7 +9,6 @@
connect con1,localhost,root,,;
SELECT pk FROM t1 FORCE INDEX (c);
pk
-1
connection default;
COMMIT;
connection con1;
mysqltest: Result length mismatch
I believe that the bug affects also earlier versions, but I did not test it, because MariaDB 5.5, 10.0, 10.1 have already reached their end of life.
Also, this test case only repeats the problem for innodb_page_size=4k , it should be repeatable with any page size when using appropriately sized records.
If I append FOR UPDATE or LOCK IN SHARE MODE to the first SELECT, a locking conflict will occur:
10.2 922e676b43c7b5cb0f20ca67c6d2222e2fc5ec03
mysqltest: At line 15: query 'SELECT pk FROM t1 FORCE INDEX (c) LOCK IN SHARE MODE' failed: 1205: Lock wait timeout exceeded; try restarting transaction
This suggests that no change for row_vers_impl_x_locked_low() is needed, and only row_sel_sec_rec_is_for_clust_rec() is wrong.
Marko Mäkelä
added a comment - If I append FOR UPDATE or LOCK IN SHARE MODE to the first SELECT , a locking conflict will occur:
10.2 922e676b43c7b5cb0f20ca67c6d2222e2fc5ec03
mysqltest: At line 15: query 'SELECT pk FROM t1 FORCE INDEX (c) LOCK IN SHARE MODE' failed: 1205: Lock wait timeout exceeded; try restarting transaction
This suggests that no change for row_vers_impl_x_locked_low() is needed, and only row_sel_sec_rec_is_for_clust_rec() is wrong.
People
Marko Mäkelä
Matthias Leich
Votes:
0Vote for this issue
Watchers:
4Start watching this issue
Dates
Created:
Updated:
Resolved:
Git Integration
Error rendering 'com.xiplink.jira.git.jira_git_plugin:git-issue-webpanel'. Please contact your Jira administrators.
{"report":{"fcp":1464.9000000953674,"ttfb":471.80000019073486,"pageVisibility":"visible","entityId":98961,"key":"jira.project.issue.view-issue","isInitial":true,"threshold":1000,"elementTimings":{},"userDeviceMemory":8,"userDeviceProcessors":64,"apdex":0.5,"journeyId":"6c211472-dcdf-48d7-b009-203e1709b3a7","navigationType":0,"readyForUser":1558.5,"redirectCount":0,"resourceLoadedEnd":1903.8000001907349,"resourceLoadedStart":479.90000009536743,"resourceTiming":[{"duration":405.69999980926514,"initiatorType":"link","name":"https://jira.mariadb.org/s/2c21342762a6a02add1c328bed317ffd-CDN/lu2cib/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/css/_super/batch.css","startTime":479.90000009536743,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":479.90000009536743,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":885.5999999046326,"responseStart":0,"secureConnectionStart":0},{"duration":405.69999980926514,"initiatorType":"link","name":"https://jira.mariadb.org/s/7ebd35e77e471bc30ff0eba799ebc151-CDN/lu2cib/820016/12ta74/494e4c556ecbb29f90a3d3b4f09cb99c/_/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&whisper-enabled=true","startTime":480.2000002861023,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":480.2000002861023,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":885.9000000953674,"responseStart":0,"secureConnectionStart":0},{"duration":475.80000019073486,"initiatorType":"script","name":"https://jira.mariadb.org/s/0917945aaa57108d00c5076fea35e069-CDN/lu2cib/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/js/_super/batch.js?locale=en","startTime":480.5,"connectEnd":480.5,"connectStart":480.5,"domainLookupEnd":480.5,"domainLookupStart":480.5,"fetchStart":480.5,"redirectEnd":0,"redirectStart":0,"requestStart":480.5,"responseEnd":956.3000001907349,"responseStart":956.3000001907349,"secureConnectionStart":480.5},{"duration":539.8999996185303,"initiatorType":"script","name":"https://jira.mariadb.org/s/2d8175ec2fa4c816e8023260bd8c1786-CDN/lu2cib/820016/12ta74/494e4c556ecbb29f90a3d3b4f09cb99c/_/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&whisper-enabled=true","startTime":480.7000002861023,"connectEnd":480.7000002861023,"connectStart":480.7000002861023,"domainLookupEnd":480.7000002861023,"domainLookupStart":480.7000002861023,"fetchStart":480.7000002861023,"redirectEnd":0,"redirectStart":0,"requestStart":480.7000002861023,"responseEnd":1020.5999999046326,"responseStart":1020.5999999046326,"secureConnectionStart":480.7000002861023},{"duration":544,"initiatorType":"script","name":"https://jira.mariadb.org/s/a9324d6758d385eb45c462685ad88f1d-CDN/lu2cib/820016/12ta74/c92c0caa9a024ae85b0ebdbed7fb4bd7/_/download/contextbatch/js/atl.global,-_super/batch.js?locale=en","startTime":480.90000009536743,"connectEnd":480.90000009536743,"connectStart":480.90000009536743,"domainLookupEnd":480.90000009536743,"domainLookupStart":480.90000009536743,"fetchStart":480.90000009536743,"redirectEnd":0,"redirectStart":0,"requestStart":480.90000009536743,"responseEnd":1024.9000000953674,"responseStart":1024.9000000953674,"secureConnectionStart":480.90000009536743},{"duration":544.3000001907349,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2cib/820016/12ta74/1.0/_/download/batch/jira.webresources:calendar-en/jira.webresources:calendar-en.js","startTime":481.09999990463257,"connectEnd":481.09999990463257,"connectStart":481.09999990463257,"domainLookupEnd":481.09999990463257,"domainLookupStart":481.09999990463257,"fetchStart":481.09999990463257,"redirectEnd":0,"redirectStart":0,"requestStart":481.09999990463257,"responseEnd":1025.4000000953674,"responseStart":1025.4000000953674,"secureConnectionStart":481.09999990463257},{"duration":544.4000000953674,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2cib/820016/12ta74/1.0/_/download/batch/jira.webresources:calendar-localisation-moment/jira.webresources:calendar-localisation-moment.js","startTime":481.30000019073486,"connectEnd":481.30000019073486,"connectStart":481.30000019073486,"domainLookupEnd":481.30000019073486,"domainLookupStart":481.30000019073486,"fetchStart":481.30000019073486,"redirectEnd":0,"redirectStart":0,"requestStart":481.30000019073486,"responseEnd":1025.7000002861023,"responseStart":1025.7000002861023,"secureConnectionStart":481.30000019073486},{"duration":627.8000001907349,"initiatorType":"link","name":"https://jira.mariadb.org/s/b04b06a02d1959df322d9cded3aeecc1-CDN/lu2cib/820016/12ta74/a2ff6aa845ffc9a1d22fe23d9ee791fc/_/download/contextbatch/css/jira.global.look-and-feel,-_super/batch.css","startTime":481.40000009536743,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":481.40000009536743,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":1109.2000002861023,"responseStart":0,"secureConnectionStart":0},{"duration":538.1000003814697,"initiatorType":"script","name":"https://jira.mariadb.org/rest/api/1.0/shortcuts/820016/47140b6e0a9bc2e4913da06536125810/shortcuts.js?context=issuenavigation&context=issueaction","startTime":488.09999990463257,"connectEnd":488.09999990463257,"connectStart":488.09999990463257,"domainLookupEnd":488.09999990463257,"domainLookupStart":488.09999990463257,"fetchStart":488.09999990463257,"redirectEnd":0,"redirectStart":0,"requestStart":488.09999990463257,"responseEnd":1026.2000002861023,"responseStart":1026.2000002861023,"secureConnectionStart":488.09999990463257},{"duration":621.0999999046326,"initiatorType":"link","name":"https://jira.mariadb.org/s/3ac36323ba5e4eb0af2aa7ac7211b4bb-CDN/lu2cib/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":488.30000019073486,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":488.30000019073486,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":1109.4000000953674,"responseStart":0,"secureConnectionStart":0},{"duration":538.2000002861023,"initiatorType":"script","name":"https://jira.mariadb.org/s/5d5e8fe91fbc506585e83ea3b62ccc4b-CDN/lu2cib/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":488.5,"connectEnd":488.5,"connectStart":488.5,"domainLookupEnd":488.5,"domainLookupStart":488.5,"fetchStart":488.5,"redirectEnd":0,"redirectStart":0,"requestStart":488.5,"responseEnd":1026.7000002861023,"responseStart":1026.7000002861023,"secureConnectionStart":488.5},{"duration":904.3000001907349,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2cib/820016/12ta74/1.0/_/download/batch/jira.webresources:bigpipe-js/jira.webresources:bigpipe-js.js","startTime":489.40000009536743,"connectEnd":489.40000009536743,"connectStart":489.40000009536743,"domainLookupEnd":489.40000009536743,"domainLookupStart":489.40000009536743,"fetchStart":489.40000009536743,"redirectEnd":0,"redirectStart":0,"requestStart":489.40000009536743,"responseEnd":1393.7000002861023,"responseStart":1393.7000002861023,"secureConnectionStart":489.40000009536743},{"duration":1414.3000001907349,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2cib/820016/12ta74/1.0/_/download/batch/jira.webresources:bigpipe-init/jira.webresources:bigpipe-init.js","startTime":489.5,"connectEnd":489.5,"connectStart":489.5,"domainLookupEnd":489.5,"domainLookupStart":489.5,"fetchStart":489.5,"redirectEnd":0,"redirectStart":0,"requestStart":489.5,"responseEnd":1903.8000001907349,"responseStart":1903.8000001907349,"secureConnectionStart":489.5},{"duration":295.2999997138977,"initiatorType":"xmlhttprequest","name":"https://jira.mariadb.org/rest/webResources/1.0/resources","startTime":1128.8000001907349,"connectEnd":1128.8000001907349,"connectStart":1128.8000001907349,"domainLookupEnd":1128.8000001907349,"domainLookupStart":1128.8000001907349,"fetchStart":1128.8000001907349,"redirectEnd":0,"redirectStart":0,"requestStart":1128.8000001907349,"responseEnd":1424.0999999046326,"responseStart":1424.0999999046326,"secureConnectionStart":1128.8000001907349},{"duration":538,"initiatorType":"script","name":"https://www.google-analytics.com/analytics.js","startTime":1458.2000002861023,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":1458.2000002861023,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":1996.2000002861023,"responseStart":0,"secureConnectionStart":0},{"duration":513.4000000953674,"initiatorType":"link","name":"https://jira.mariadb.org/s/d5715adaadd168a9002b108b2b039b50-CDN/lu2cib/820016/12ta74/be4b45e9cec53099498fa61c8b7acba4/_/download/contextbatch/css/jira.project.sidebar,-_super,-project.issue.navigator,-jira.general,-jira.browse.project,-jira.view.issue,-jira.global,-atl.general,-com.atlassian.jira.projects.sidebar.init/batch.css?agile_global_admin_condition=true&jag=true&jira.create.linked.issue=true&slack-enabled=true&whisper-enabled=true","startTime":1482.5999999046326,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":1482.5999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":1996,"responseStart":0,"secureConnectionStart":0},{"duration":477,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2cib/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&whisper-enabled=true","startTime":1483.5999999046326,"connectEnd":1483.5999999046326,"connectStart":1483.5999999046326,"domainLookupEnd":1483.5999999046326,"domainLookupStart":1483.5999999046326,"fetchStart":1483.5999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":1483.5999999046326,"responseEnd":1960.5999999046326,"responseStart":1960.5999999046326,"secureConnectionStart":1483.5999999046326},{"duration":481.8999996185303,"initiatorType":"script","name":"https://jira.mariadb.org/s/097ae97cb8fbec7d6ea4bbb1f26955b9-CDN/lu2cib/820016/12ta74/be4b45e9cec53099498fa61c8b7acba4/_/download/contextbatch/js/jira.project.sidebar,-_super,-project.issue.navigator,-jira.general,-jira.browse.project,-jira.view.issue,-jira.global,-atl.general,-com.atlassian.jira.projects.sidebar.init/batch.js?agile_global_admin_condition=true&jag=true&jira.create.linked.issue=true&locale=en&slack-enabled=true&whisper-enabled=true","startTime":1484.2000002861023,"connectEnd":1484.2000002861023,"connectStart":1484.2000002861023,"domainLookupEnd":1484.2000002861023,"domainLookupStart":1484.2000002861023,"fetchStart":1484.2000002861023,"redirectEnd":0,"redirectStart":0,"requestStart":1484.2000002861023,"responseEnd":1966.0999999046326,"responseStart":1966.0999999046326,"secureConnectionStart":1484.2000002861023}],"fetchStart":0,"domainLookupStart":0,"domainLookupEnd":0,"connectStart":0,"connectEnd":0,"requestStart":292,"responseStart":472,"responseEnd":479,"domLoading":476,"domInteractive":1945,"domContentLoadedEventStart":1945,"domContentLoadedEventEnd":1996,"domComplete":2335,"loadEventStart":2335,"loadEventEnd":2336,"userAgent":"Mozilla/5.0 AppleWebKit/537.36 (KHTML, like Gecko; compatible; ClaudeBot/1.0; +claudebot@anthropic.com)","marks":[{"name":"bigPipe.sidebar-id.start","time":1905.5999999046326},{"name":"bigPipe.sidebar-id.end","time":1906.4000000953674},{"name":"bigPipe.activity-panel-pipe-id.start","time":1906.5999999046326},{"name":"bigPipe.activity-panel-pipe-id.end","time":1911.0999999046326},{"name":"activityTabFullyLoaded","time":2014.7000002861023}],"measures":[],"correlationId":"596bd7ba100f46","effectiveType":"4g","downlink":10,"rtt":0,"serverDuration":118,"dbReadsTimeInMs":15,"dbConnsTimeInMs":24,"applicationHash":"9d11dbea5f4be3d4cc21f03a88dd11d8c8687422","experiments":[]}}
I will have to debug the trace further (around when 61095) to check why exactly we are assigning clust_rec=NULL here:
&& (old_vers
|| trx->isolation_level <= TRX_ISO_READ_UNCOMMITTED
|| dict_index_is_spatial(sec_index)
|| rec_get_deleted_flag(rec, dict_table_is_comp(
sec_index->table)))) {
err = row_sel_sec_rec_is_for_clust_rec(rec, sec_index,
clust_rec, clust_index, thr);
clust_rec = NULL;
Currently it looks like we are constructing wrong old_vers with (pk=63,DB_TRX_ID=0x3c,(update)) and apparently empty string. It is as if CHECK TABLE is using a newer read view for accessing the clustered index.