Workflow of RQG test
|
|
1. Create DB server and start it
|
2. One session starts to run some SQL stream against this server
|
3. At some point of time and not related to the state (waiting for result, sending statement, ...) of the ongoing 2. the server process gets killed (KILL and not TERM).
|
4. Make some copy of the data content+logs etc. of the killed server.
|
5. Try to restart the killed server.
|
|
5. fails with
|
2020-03-31 16:17:25 0 [Note] /home/mleich/10.5/bld_debug/sql/mysqld (mysqld 10.5.2-MariaDB-debug-log) starting as process 111337 ...
|
...
|
2020-03-31 16:17:25 0 [Note] InnoDB: Starting crash recovery from checkpoint LSN=174187931
|
2020-03-31 16:17:25 0 [ERROR] InnoDB: Malformed log record; set innodb_force_recovery=1 to ignore.
|
2020-03-31 16:17:25 0 [Note] InnoDB: Dump from the start of the mini-transaction (LSN=173906840) to 100 bytes after the record:
|
<some data>
|
2020-03-31 16:17:27 0 [ERROR] InnoDB: Plugin initialization aborted at srv0start.cc[1537] with error Generic error
|
...
|
2020-03-31 16:17:27 0 [ERROR] Plugin 'InnoDB' registration as a STORAGE ENGINE failed.
|
|
RQG
|
git clone https://github.com/mleich1/rqg --branch experimental RQG_mleich1
|
origin/experimental d417497b476e263428422b4640cf63b8e9d16afe 2020-03-30T17:17:54+02:00
|
|
MariaDB
|
origin/10.5 718f18599a9bcf1e7c2d3f18416fca4f7124d00d 2020-03-26T16:05:25+02:00
|
build with debug
|
|
perl rqg.pl \
|
--duration=120 \
|
--queries=10000000 \
|
--threads=1 \
|
--no_mask \
|
--seed=random \
|
--gendata=conf/engines/many_indexes.zz \
|
--rpl_mode=none \
|
--engine=InnoDB \
|
--mysqld=--innodb_stats_persistent=off \
|
--mysqld=--lock-wait-timeout=86400 \
|
--mysqld=--log-output=none \
|
--mysqld=--slave_net_timeout=60 \
|
--mysqld=--loose-debug_assert_on_not_freed_memory=0 \
|
--mysqld=--loose-table_lock_wait_timeout=50 \
|
--mysqld=--net_write_timeout=60 \
|
--mysqld=--connect_timeout=60 \
|
--mysqld=--loose_innodb_lock_schedule_algorithm=fcfs \
|
--mysqld=--log_bin_trust_function_creators=1 \
|
--mysqld=--loose-idle_transaction_timeout=0 \
|
--mysqld=--loose-idle_readonly_transaction_timeout=0 \
|
--mysqld=--interactive_timeout=28800 \
|
--mysqld=--innodb_page_size=32K \
|
--mysqld=--wait_timeout=28800 \
|
--mysqld=--innodb-lock-wait-timeout=50 \
|
--mysqld=--loose-idle_write_transaction_timeout=0 \
|
--mysqld=--loose_innodb_use_native_aio=1 \
|
--mysqld=--log-bin \
|
--mysqld=--net_read_timeout=30 \
|
--reporters=CrashRecovery1,Deadlock1,ErrorLog,None,ServerDead \
|
--validators=None \
|
--grammar=c00000.yy \
|
--workdir=<local settings> \
|
--vardir=<local settings> \
|
--mtr-build-thread=<local settings> \
|
--basedir1=<path to MariaDB binaries> \
|
--script_debug=_nix
|
There might be several replay attempts required.
|
- is caused by
-
MDEV-12353
Efficient InnoDB redo log record format
-
-
Closed
{"report":{"fcp":1861.6999998092651,"ttfb":818,"pageVisibility":"visible","entityId":84946,"key":"jira.project.issue.view-issue","isInitial":true,"threshold":1000,"elementTimings":{},"userDeviceMemory":8,"userDeviceProcessors":64,"apdex":0.5,"journeyId":"da73392d-ed67-405f-9b7a-902b1c045b15","navigationType":0,"readyForUser":1954.7999997138977,"redirectCount":0,"resourceLoadedEnd":1436.6999998092651,"resourceLoadedStart":835.6999998092651,"resourceTiming":[{"duration":94.2000002861023,"initiatorType":"link","name":"https://jira.mariadb.org/s/2c21342762a6a02add1c328bed317ffd-CDN/lu2cib/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/css/_super/batch.css","startTime":835.6999998092651,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":835.6999998092651,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":929.9000000953674,"responseStart":0,"secureConnectionStart":0},{"duration":94.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":835.9000000953674,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":835.9000000953674,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":930.1999998092651,"responseStart":0,"secureConnectionStart":0},{"duration":290.40000009536743,"initiatorType":"script","name":"https://jira.mariadb.org/s/0917945aaa57108d00c5076fea35e069-CDN/lu2cib/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/js/_super/batch.js?locale=en","startTime":836.0999999046326,"connectEnd":836.0999999046326,"connectStart":836.0999999046326,"domainLookupEnd":836.0999999046326,"domainLookupStart":836.0999999046326,"fetchStart":836.0999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":932.5,"responseEnd":1126.5,"responseStart":954.5,"secureConnectionStart":836.0999999046326},{"duration":600.5,"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":836.1999998092651,"connectEnd":836.1999998092651,"connectStart":836.1999998092651,"domainLookupEnd":836.1999998092651,"domainLookupStart":836.1999998092651,"fetchStart":836.1999998092651,"redirectEnd":0,"redirectStart":0,"requestStart":932.6999998092651,"responseEnd":1436.6999998092651,"responseStart":980.5,"secureConnectionStart":836.1999998092651},{"duration":122,"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":836.5,"connectEnd":836.5,"connectStart":836.5,"domainLookupEnd":836.5,"domainLookupStart":836.5,"fetchStart":836.5,"redirectEnd":0,"redirectStart":0,"requestStart":932.6999998092651,"responseEnd":958.5,"responseStart":956.2999997138977,"secureConnectionStart":836.5},{"duration":127.59999990463257,"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":836.5999999046326,"connectEnd":836.5999999046326,"connectStart":836.5999999046326,"domainLookupEnd":836.5999999046326,"domainLookupStart":836.5999999046326,"fetchStart":836.5999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":935,"responseEnd":964.1999998092651,"responseStart":962.6999998092651,"secureConnectionStart":836.5999999046326},{"duration":129.69999980926514,"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":836.9000000953674,"connectEnd":836.9000000953674,"connectStart":836.9000000953674,"domainLookupEnd":836.9000000953674,"domainLookupStart":836.9000000953674,"fetchStart":836.9000000953674,"redirectEnd":0,"redirectStart":0,"requestStart":935.2999997138977,"responseEnd":966.5999999046326,"responseStart":964.4000000953674,"secureConnectionStart":836.9000000953674},{"duration":97.40000009536743,"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":837.0999999046326,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":837.0999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":934.5,"responseStart":0,"secureConnectionStart":0},{"duration":132.30000019073486,"initiatorType":"script","name":"https://jira.mariadb.org/rest/api/1.0/shortcuts/820016/47140b6e0a9bc2e4913da06536125810/shortcuts.js?context=issuenavigation&context=issueaction","startTime":837.1999998092651,"connectEnd":837.1999998092651,"connectStart":837.1999998092651,"domainLookupEnd":837.1999998092651,"domainLookupStart":837.1999998092651,"fetchStart":837.1999998092651,"redirectEnd":0,"redirectStart":0,"requestStart":937.2999997138977,"responseEnd":969.5,"responseStart":967.2999997138977,"secureConnectionStart":837.1999998092651},{"duration":98.19999980926514,"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":837.4000000953674,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":837.4000000953674,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":935.5999999046326,"responseStart":0,"secureConnectionStart":0},{"duration":132.80000019073486,"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":837.5999999046326,"connectEnd":837.5999999046326,"connectStart":837.5999999046326,"domainLookupEnd":837.5999999046326,"domainLookupStart":837.5999999046326,"fetchStart":837.5999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":940.7999997138977,"responseEnd":970.4000000953674,"responseStart":968.1999998092651,"secureConnectionStart":837.5999999046326},{"duration":532.1999998092651,"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":838.5999999046326,"connectEnd":838.5999999046326,"connectStart":838.5999999046326,"domainLookupEnd":838.5999999046326,"domainLookupStart":838.5999999046326,"fetchStart":838.5999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":987,"responseEnd":1370.7999997138977,"responseStart":1362.1999998092651,"secureConnectionStart":838.5999999046326},{"duration":532.9000000953674,"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":838.5999999046326,"connectEnd":838.5999999046326,"connectStart":838.5999999046326,"domainLookupEnd":838.5999999046326,"domainLookupStart":838.5999999046326,"fetchStart":838.5999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":1062.7999997138977,"responseEnd":1371.5,"responseStart":1364.4000000953674,"secureConnectionStart":838.5999999046326},{"duration":360.80000019073486,"initiatorType":"xmlhttprequest","name":"https://jira.mariadb.org/rest/webResources/1.0/resources","startTime":1283.5999999046326,"connectEnd":1283.5999999046326,"connectStart":1283.5999999046326,"domainLookupEnd":1283.5999999046326,"domainLookupStart":1283.5999999046326,"fetchStart":1283.5999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":1601.0999999046326,"responseEnd":1644.4000000953674,"responseStart":1632.7999997138977,"secureConnectionStart":1283.5999999046326}],"fetchStart":0,"domainLookupStart":0,"domainLookupEnd":0,"connectStart":0,"connectEnd":0,"requestStart":143,"responseStart":818,"responseEnd":823,"domLoading":833,"domInteractive":2047,"domContentLoadedEventStart":2047,"domContentLoadedEventEnd":2099,"domComplete":3513,"loadEventStart":3513,"loadEventEnd":3513,"userAgent":"Mozilla/5.0 AppleWebKit/537.36 (KHTML, like Gecko; compatible; ClaudeBot/1.0; +claudebot@anthropic.com)","marks":[{"name":"bigPipe.sidebar-id.start","time":2022.5},{"name":"bigPipe.sidebar-id.end","time":2023.2999997138977},{"name":"bigPipe.activity-panel-pipe-id.start","time":2023.4000000953674},{"name":"bigPipe.activity-panel-pipe-id.end","time":2027.5999999046326},{"name":"activityTabFullyLoaded","time":2104}],"measures":[],"correlationId":"4be29b5c558cc9","effectiveType":"4g","downlink":9.9,"rtt":0,"serverDuration":548,"dbReadsTimeInMs":11,"dbConnsTimeInMs":23,"applicationHash":"9d11dbea5f4be3d4cc21f03a88dd11d8c8687422","experiments":[]}}