2017-08-10 17:48:57 140405466861632 [Note] InnoDB: Completed initialization of buffer pool
|
2017-08-10 17:48:57 140404724037376 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
|
2017-08-10 17:48:57 140405466861632 [Note] InnoDB: 1 transaction(s) which must be rolled back or cleaned up in total 1 row operations to undo
|
2017-08-10 17:48:57 140405466861632 [Note] InnoDB: Trx id counter is 7424
|
2017-08-10 17:48:57 140405466861632 [Note] InnoDB: Upgrading redo log: 2*50331648 bytes; LSN=9779797
|
2017-08-10 17:48:57 140405466861632 [Note] InnoDB: Starting to delete and rewrite log files.
|
2017-08-10 17:48:57 140405466861632 [Note] InnoDB: Setting log file ./ib_logfile101 size to 50331648 bytes
|
2017-08-10 17:48:57 140405466861632 [Note] InnoDB: Setting log file ./ib_logfile1 size to 50331648 bytes
|
2017-08-10 17:48:58 140405466861632 [Note] InnoDB: Renaming log file ./ib_logfile101 to ./ib_logfile0
|
2017-08-10 17:48:58 140405466861632 [Note] InnoDB: New log files created, LSN=9779797
|
2017-08-10 17:48:58 140404715644672 [Note] InnoDB: Starting in background the rollback of recovered transactions
|
2017-08-10 17:48:58 140405466861632 [Note] InnoDB: 128 out of 128 rollback segments are active.
|
2017-08-10 17:48:58 140404715644672 [Note] InnoDB: Rolling back trx with id 6568, 1 rows to undo
|
2017-08-10 17:48:58 140405466861632 [Note] InnoDB: Creating shared tablespace for temporary tables
|
2017-08-10 17:48:58 140405466861632 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
|
mysqld: /data/src/10.3/storage/innobase/trx/trx0trx.cc:1918: void trx_commit_low(trx_t*, mtr_t*): Assertion `!mtr == !trx->has_logged()' failed.
|
170810 17:48:58 [ERROR] mysqld got signal 6 ;
|
|
10.3 73297f532fba89e33785460448e93f87478c2505
|
#3 0x00007f3ff87f7ee2 in __assert_fail () from /lib/x86_64-linux-gnu/libc.so.6
|
#4 0x0000565165cfad75 in trx_commit_low (trx=0x7f3ff5406878, mtr=0x7f3fce337470) at /data/src/10.3/storage/innobase/trx/trx0trx.cc:1918
|
#5 0x0000565165cfafcc in trx_commit (trx=0x7f3ff5406878) at /data/src/10.3/storage/innobase/trx/trx0trx.cc:2018
|
#6 0x0000565165cee5c2 in trx_rollback_finish (trx=0x7f3ff5406878) at /data/src/10.3/storage/innobase/trx/trx0roll.cc:1147
|
#7 0x0000565165cecf5b in trx_rollback_active (trx=0x7f3ff5406878) at /data/src/10.3/storage/innobase/trx/trx0roll.cc:689
|
#8 0x0000565165ced427 in trx_rollback_resurrected (trx=0x7f3ff5406878, all=1) at /data/src/10.3/storage/innobase/trx/trx0roll.cc:773
|
#9 0x0000565165ced6d6 in trx_rollback_or_clean_recovered (all=1) at /data/src/10.3/storage/innobase/trx/trx0roll.cc:841
|
#10 0x0000565165ced889 in trx_rollback_or_clean_all_recovered (arg=0x0) at /data/src/10.3/storage/innobase/trx/trx0roll.cc:881
|
#11 0x00007f3ffa73c494 in start_thread (arg=0x7f3fce338700) at pthread_create.c:333
|
#12 0x00007f3ff88b493f in clone () from /lib/x86_64-linux-gnu/libc.so.6
|
The attached datadir was created as a part of MDEV-13269 workflow.
- 10.2 server (86f9b7714791) was started with --innodb-change-buffering=none --innodb-page-size=8K --innodb-compression-algorithm=zlib, otherwise defaults;
- a number of tables was created and concurrent DML was executed in 4 threads for about a minute;
- the server was SIGKILL-ed;
- the server was started again with the same options plus --innodb-force-recovery=3;
- the server was shut down normally.
Now, to reproduce the reported assertion failure, start 10.3 server on the provided datadir with --innodb-change-buffering=none --innodb-page-size=8K --innodb-compression-algorithm=zlib, the failure happens upon startup.
10.2 starts all right on this datadir.
Note: in the initial scenario, there was an intermediate step when the 10.3 server is started on the datadir with --innodb-read-only and then gets shut down normally. It starts all right, but the step does not change the outcome when the server is finally restarted in a normal mode, so it's omitted above.
{"report":{"fcp":1827.2999997138977,"ttfb":636.7999997138977,"pageVisibility":"visible","entityId":62585,"key":"jira.project.issue.view-issue","isInitial":true,"threshold":1000,"elementTimings":{},"userDeviceMemory":8,"userDeviceProcessors":64,"apdex":0.5,"journeyId":"13e52e43-6778-496b-adcd-c9cb68dbb9be","navigationType":0,"readyForUser":1840.5,"redirectCount":0,"resourceLoadedEnd":2248.2999997138977,"resourceLoadedStart":642.1999998092651,"resourceTiming":[{"duration":576.3000001907349,"initiatorType":"link","name":"https://jira.mariadb.org/s/2c21342762a6a02add1c328bed317ffd-CDN/lu2cib/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/css/_super/batch.css","startTime":642.1999998092651,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":642.1999998092651,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":1218.5,"responseStart":0,"secureConnectionStart":0},{"duration":576.2999997138977,"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":642.5,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":642.5,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":1218.7999997138977,"responseStart":0,"secureConnectionStart":0},{"duration":585.0999999046326,"initiatorType":"script","name":"https://jira.mariadb.org/s/0917945aaa57108d00c5076fea35e069-CDN/lu2cib/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/js/_super/batch.js?locale=en","startTime":642.5999999046326,"connectEnd":642.5999999046326,"connectStart":642.5999999046326,"domainLookupEnd":642.5999999046326,"domainLookupStart":642.5999999046326,"fetchStart":642.5999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":642.5999999046326,"responseEnd":1227.6999998092651,"responseStart":1227.6999998092651,"secureConnectionStart":642.5999999046326},{"duration":731.3999996185303,"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":642.9000000953674,"connectEnd":642.9000000953674,"connectStart":642.9000000953674,"domainLookupEnd":642.9000000953674,"domainLookupStart":642.9000000953674,"fetchStart":642.9000000953674,"redirectEnd":0,"redirectStart":0,"requestStart":642.9000000953674,"responseEnd":1374.2999997138977,"responseStart":1374.1999998092651,"secureConnectionStart":642.9000000953674},{"duration":738.8000001907349,"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":643.0999999046326,"connectEnd":643.0999999046326,"connectStart":643.0999999046326,"domainLookupEnd":643.0999999046326,"domainLookupStart":643.0999999046326,"fetchStart":643.0999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":643.0999999046326,"responseEnd":1381.9000000953674,"responseStart":1381.9000000953674,"secureConnectionStart":643.0999999046326},{"duration":739,"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":643.2999997138977,"connectEnd":643.2999997138977,"connectStart":643.2999997138977,"domainLookupEnd":643.2999997138977,"domainLookupStart":643.2999997138977,"fetchStart":643.2999997138977,"redirectEnd":0,"redirectStart":0,"requestStart":643.2999997138977,"responseEnd":1382.2999997138977,"responseStart":1382.2999997138977,"secureConnectionStart":643.2999997138977},{"duration":739.1999998092651,"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":643.5,"connectEnd":643.5,"connectStart":643.5,"domainLookupEnd":643.5,"domainLookupStart":643.5,"fetchStart":643.5,"redirectEnd":0,"redirectStart":0,"requestStart":643.5,"responseEnd":1382.6999998092651,"responseStart":1382.6999998092651,"secureConnectionStart":643.5},{"duration":739.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":643.5999999046326,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":643.5999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":1383.4000000953674,"responseStart":0,"secureConnectionStart":0},{"duration":739.5,"initiatorType":"script","name":"https://jira.mariadb.org/rest/api/1.0/shortcuts/820016/47140b6e0a9bc2e4913da06536125810/shortcuts.js?context=issuenavigation&context=issueaction","startTime":643.7999997138977,"connectEnd":643.7999997138977,"connectStart":643.7999997138977,"domainLookupEnd":643.7999997138977,"domainLookupStart":643.7999997138977,"fetchStart":643.7999997138977,"redirectEnd":0,"redirectStart":0,"requestStart":643.7999997138977,"responseEnd":1383.2999997138977,"responseStart":1383.2999997138977,"secureConnectionStart":643.7999997138977},{"duration":740,"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":643.9000000953674,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":643.9000000953674,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":1383.9000000953674,"responseStart":0,"secureConnectionStart":0},{"duration":739.9000000953674,"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":644,"connectEnd":644,"connectStart":644,"domainLookupEnd":644,"domainLookupStart":644,"fetchStart":644,"redirectEnd":0,"redirectStart":0,"requestStart":644,"responseEnd":1383.9000000953674,"responseStart":1383.9000000953674,"secureConnectionStart":644},{"duration":1261.5,"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":649.5,"connectEnd":649.5,"connectStart":649.5,"domainLookupEnd":649.5,"domainLookupStart":649.5,"fetchStart":649.5,"redirectEnd":0,"redirectStart":0,"requestStart":649.5,"responseEnd":1911,"responseStart":1911,"secureConnectionStart":649.5},{"duration":1598.6999998092651,"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":649.5999999046326,"connectEnd":649.5999999046326,"connectStart":649.5999999046326,"domainLookupEnd":649.5999999046326,"domainLookupStart":649.5999999046326,"fetchStart":649.5999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":649.5999999046326,"responseEnd":2248.2999997138977,"responseStart":2248.2999997138977,"secureConnectionStart":649.5999999046326},{"duration":514.3999996185303,"initiatorType":"xmlhttprequest","name":"https://jira.mariadb.org/rest/webResources/1.0/resources","startTime":1377.9000000953674,"connectEnd":1377.9000000953674,"connectStart":1377.9000000953674,"domainLookupEnd":1377.9000000953674,"domainLookupStart":1377.9000000953674,"fetchStart":1377.9000000953674,"redirectEnd":0,"redirectStart":0,"requestStart":1377.9000000953674,"responseEnd":1892.2999997138977,"responseStart":1892.2999997138977,"secureConnectionStart":1377.9000000953674}],"fetchStart":0,"domainLookupStart":0,"domainLookupEnd":0,"connectStart":0,"connectEnd":0,"requestStart":478,"responseStart":637,"responseEnd":641,"domLoading":640,"domInteractive":2275,"domContentLoadedEventStart":2275,"domContentLoadedEventEnd":2319,"domComplete":3423,"loadEventStart":3423,"loadEventEnd":3425,"userAgent":"Mozilla/5.0 AppleWebKit/537.36 (KHTML, like Gecko; compatible; ClaudeBot/1.0; +claudebot@anthropic.com)","marks":[{"name":"bigPipe.sidebar-id.start","time":2253.699999809265},{"name":"bigPipe.sidebar-id.end","time":2254.5999999046326},{"name":"bigPipe.activity-panel-pipe-id.start","time":2254.7999997138977},{"name":"bigPipe.activity-panel-pipe-id.end","time":2257.4000000953674},{"name":"activityTabFullyLoaded","time":2324.2999997138977}],"measures":[],"correlationId":"7bdd0aaeb1131a","effectiveType":"4g","downlink":10,"rtt":0,"serverDuration":95,"dbReadsTimeInMs":12,"dbConnsTimeInMs":21,"applicationHash":"9d11dbea5f4be3d4cc21f03a88dd11d8c8687422","experiments":[]}}
Bug
Major
MDEV-12288 Reset DB_TRX_ID when the history is removed, to speed up MVCC