galera_3nodes.GCF-354 failed on BB 10.5: "query 'DROP TABLE test.t1' failed: 1047: WSREP has not yet prepared node for application use".
stdio.log:
10.5.6 97a4a3872e5037b8db1e8c27152740190330ab9c
|
galera_3nodes.GCF-354 'innodb' w1 [ fail ]
|
Test ended at 2020-08-26 15:20:24
|
|
CURRENT_TEST: galera_3nodes.GCF-354
|
mysqltest: At line 36: query 'DROP TABLE test.t1' failed: 1047: WSREP has not yet prepared node for application use
|
|
The result from queries just before the failure was:
|
< snip >
|
SET wsrep_on=OFF;
|
CREATE TABLE test.t1 (f1 INTEGER);
|
connection node_1;
|
CREATE TABLE test.t1 (f1 INTEGER);
|
Timeout in wait_condition.inc for SELECT VARIABLE_VALUE = 'Primary' FROM INFORMATION_SCHEMA.GLOBAL_STATUS WHERE VARIABLE_NAME = 'wsrep_cluster_status'
|
Id User Host db Command Time State Info Progress
|
2 system user NULL Sleep 42 wsrep aborter idle NULL 0.000
|
1 system user NULL Sleep 42 closing tables NULL 0.000
|
10 root localhost test Sleep 33 NULL 0.000
|
11 root localhost:59516 test Query 0 starting show full processlist 0.000
|
SHOW STATUS LIKE 'wsrep_cluster_status';
|
Variable_name Value
|
wsrep_cluster_status non-Primary
|
DROP TABLE test.t1;
|
{"report":{"fcp":856.2000000476837,"ttfb":195.20000004768372,"pageVisibility":"visible","entityId":91164,"key":"jira.project.issue.view-issue","isInitial":true,"threshold":1000,"elementTimings":{},"userDeviceMemory":8,"userDeviceProcessors":64,"apdex":1,"journeyId":"8ac9b347-9035-4f92-bf79-beb4cac5eb61","navigationType":0,"readyForUser":965.2000000476837,"redirectCount":0,"resourceLoadedEnd":587.1000001430511,"resourceLoadedStart":203.5,"resourceTiming":[{"duration":3.9000000953674316,"initiatorType":"link","name":"https://jira.mariadb.org/s/2c21342762a6a02add1c328bed317ffd-CDN/lu2bsh/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/css/_super/batch.css","startTime":203.5,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":203.5,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":207.40000009536743,"responseStart":0,"secureConnectionStart":0},{"duration":4.099999904632568,"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":203.90000009536743,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":203.90000009536743,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":208,"responseStart":0,"secureConnectionStart":0},{"duration":261.2999999523163,"initiatorType":"script","name":"https://jira.mariadb.org/s/b09d0d077992e4331b5f9ec0d3ec448c-CDN/lu2bsh/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/js/_super/batch.js?locale=en","startTime":204,"connectEnd":204,"connectStart":204,"domainLookupEnd":204,"domainLookupStart":204,"fetchStart":204,"redirectEnd":0,"redirectStart":0,"requestStart":209.70000004768372,"responseEnd":465.2999999523163,"responseStart":227.79999995231628,"secureConnectionStart":204},{"duration":382.7000000476837,"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":204.40000009536743,"connectEnd":204.40000009536743,"connectStart":204.40000009536743,"domainLookupEnd":204.40000009536743,"domainLookupStart":204.40000009536743,"fetchStart":204.40000009536743,"redirectEnd":0,"redirectStart":0,"requestStart":210.40000009536743,"responseEnd":587.1000001430511,"responseStart":237.60000014305115,"secureConnectionStart":204.40000009536743},{"duration":43.69999980926514,"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":204.60000014305115,"connectEnd":204.60000014305115,"connectStart":204.60000014305115,"domainLookupEnd":204.60000014305115,"domainLookupStart":204.60000014305115,"fetchStart":204.60000014305115,"redirectEnd":0,"redirectStart":0,"requestStart":214.29999995231628,"responseEnd":248.29999995231628,"responseStart":245.20000004768372,"secureConnectionStart":204.60000014305115},{"duration":47.19999980926514,"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":204.60000014305115,"connectEnd":204.60000014305115,"connectStart":204.60000014305115,"domainLookupEnd":204.60000014305115,"domainLookupStart":204.60000014305115,"fetchStart":204.60000014305115,"redirectEnd":0,"redirectStart":0,"requestStart":215.5,"responseEnd":251.79999995231628,"responseStart":246.70000004768372,"secureConnectionStart":204.60000014305115},{"duration":50.5,"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":204.79999995231628,"connectEnd":204.79999995231628,"connectStart":204.79999995231628,"domainLookupEnd":204.79999995231628,"domainLookupStart":204.79999995231628,"fetchStart":204.79999995231628,"redirectEnd":0,"redirectStart":0,"requestStart":216.20000004768372,"responseEnd":255.29999995231628,"responseStart":252.60000014305115,"secureConnectionStart":204.79999995231628},{"duration":9.200000047683716,"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":204.90000009536743,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":204.90000009536743,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":214.10000014305115,"responseStart":0,"secureConnectionStart":0},{"duration":50.700000047683716,"initiatorType":"script","name":"https://jira.mariadb.org/rest/api/1.0/shortcuts/820016/47140b6e0a9bc2e4913da06536125810/shortcuts.js?context=issuenavigation&context=issueaction","startTime":204.90000009536743,"connectEnd":204.90000009536743,"connectStart":204.90000009536743,"domainLookupEnd":204.90000009536743,"domainLookupStart":204.90000009536743,"fetchStart":204.90000009536743,"redirectEnd":0,"redirectStart":0,"requestStart":219.60000014305115,"responseEnd":255.60000014305115,"responseStart":253.60000014305115,"secureConnectionStart":204.90000009536743},{"duration":9.5,"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":205,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":205,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":214.5,"responseStart":0,"secureConnectionStart":0},{"duration":55.5,"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":205.10000014305115,"connectEnd":205.10000014305115,"connectStart":205.10000014305115,"domainLookupEnd":205.10000014305115,"domainLookupStart":205.10000014305115,"fetchStart":205.10000014305115,"redirectEnd":0,"redirectStart":0,"requestStart":220.79999995231628,"responseEnd":260.60000014305115,"responseStart":259.2000000476837,"secureConnectionStart":205.10000014305115},{"duration":362.5,"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":211.70000004768372,"connectEnd":211.70000004768372,"connectStart":211.70000004768372,"domainLookupEnd":211.70000004768372,"domainLookupStart":211.70000004768372,"fetchStart":211.70000004768372,"redirectEnd":0,"redirectStart":0,"requestStart":233.90000009536743,"responseEnd":574.2000000476837,"responseStart":572.7000000476837,"secureConnectionStart":211.70000004768372},{"duration":362.60000014305115,"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":211.79999995231628,"connectEnd":211.79999995231628,"connectStart":211.79999995231628,"domainLookupEnd":211.79999995231628,"domainLookupStart":211.79999995231628,"fetchStart":211.79999995231628,"redirectEnd":0,"redirectStart":0,"requestStart":248.60000014305115,"responseEnd":574.4000000953674,"responseStart":573.4000000953674,"secureConnectionStart":211.79999995231628},{"duration":63.80000019073486,"initiatorType":"xmlhttprequest","name":"https://jira.mariadb.org/rest/webResources/1.0/resources","startTime":616.2999999523163,"connectEnd":616.2999999523163,"connectStart":616.2999999523163,"domainLookupEnd":616.2999999523163,"domainLookupStart":616.2999999523163,"fetchStart":616.2999999523163,"redirectEnd":0,"redirectStart":0,"requestStart":641.2999999523163,"responseEnd":680.1000001430511,"responseStart":679.5,"secureConnectionStart":616.2999999523163}],"fetchStart":0,"domainLookupStart":0,"domainLookupEnd":0,"connectStart":0,"connectEnd":0,"requestStart":28,"responseStart":195,"responseEnd":212,"domLoading":198,"domInteractive":1029,"domContentLoadedEventStart":1029,"domContentLoadedEventEnd":1076,"domComplete":1413,"loadEventStart":1413,"loadEventEnd":1414,"userAgent":"Mozilla/5.0 AppleWebKit/537.36 (KHTML, like Gecko; compatible; ClaudeBot/1.0; +claudebot@anthropic.com)","marks":[{"name":"bigPipe.sidebar-id.start","time":1002.9000000953674},{"name":"bigPipe.sidebar-id.end","time":1003.6000001430511},{"name":"bigPipe.activity-panel-pipe-id.start","time":1003.7999999523163},{"name":"bigPipe.activity-panel-pipe-id.end","time":1006.2000000476837},{"name":"activityTabFullyLoaded","time":1095.5}],"measures":[],"correlationId":"6220c4e956e8a7","effectiveType":"4g","downlink":10,"rtt":0,"serverDuration":104,"dbReadsTimeInMs":15,"dbConnsTimeInMs":29,"applicationHash":"9d11dbea5f4be3d4cc21f03a88dd11d8c8687422","experiments":[]}}
galera_3nodes.GCF-354 'innodb' w1 [ fail ]
Test ended at 2020-09-13 11:40:42
CURRENT_TEST: galera_3nodes.GCF-354
mysqltest: At line 36: query 'DROP TABLE test.t1' failed: 1047: WSREP has not yet prepared node for application use
The result from queries just before the failure was:
< snip >
SET wsrep_on=OFF;
CREATE TABLE test.t1 (f1 INTEGER);
connection node_1;
CREATE TABLE test.t1 (f1 INTEGER);
Timeout in wait_condition.inc for SELECT VARIABLE_VALUE = 'Primary' FROM INFORMATION_SCHEMA.GLOBAL_STATUS WHERE VARIABLE_NAME = 'wsrep_cluster_status'
Id User Host db Command Time State Info Progress
1 system user NULL Sleep 54 closing tables NULL 0.000
2 system user NULL Sleep 54 wsrep aborter idle NULL 0.000
10 root localhost test Sleep 33 NULL 0.000
11 root localhost:37284 test Query 0 starting show full processlist 0.000
SHOW STATUS LIKE 'wsrep_cluster_status';
Variable_name Value
wsrep_cluster_status non-Primary
DROP TABLE test.t1;
More results from queries before failure can be found in /dev/shm/var/1/log/GCF-354.log
- saving '/dev/shm/var/1/log/galera_3nodes.GCF-354-innodb/' to '/dev/shm/var/log/galera_3nodes.GCF-354-innodb/'
Retrying test galera_3nodes.GCF-354, attempt(2/3)...
worker[1] > Restart - not started
worker[1] > Restart - not started
worker[1] > Restart - not started
***Warnings generated in error logs during shutdown after running tests: galera_3nodes.GCF-354
2020-09-13 11:40:11 2 [ERROR] WSREP: Inconsistency detected: Inconsistent by consensus on d3acd8c9-f5b5-11ea-a0b0-32133b7e7efe:4
2020-09-13 11:40:11 1 [ERROR] WSREP: Inconsistency detected: Inconsistent by consensus on d3acd8c9-f5b5-11ea-a0b0-32133b7e7efe:4
galera_3nodes.galera_safe_to_bootstrap 'innodb' w2 [ pass ] 36587
galera_3nodes.GCF-354 'innodb' w1 [ retry-fail ]
Test ended at 2020-09-13 11:41:21
CURRENT_TEST: galera_3nodes.GCF-354
mysqltest: At line 36: query 'DROP TABLE test.t1' failed: 1047: WSREP has not yet prepared node for application use
The result from queries just before the failure was:
< snip >
SET wsrep_on=OFF;
CREATE TABLE test.t1 (f1 INTEGER);
connection node_1;
CREATE TABLE test.t1 (f1 INTEGER);
Timeout in wait_condition.inc for SELECT VARIABLE_VALUE = 'Primary' FROM INFORMATION_SCHEMA.GLOBAL_STATUS WHERE VARIABLE_NAME = 'wsrep_cluster_status'
Id User Host db Command Time State Info Progress
1 system user NULL Sleep 38 wsrep aborter idle NULL 0.000
2 system user NULL Sleep 38 closing tables NULL 0.000
10 root localhost test Sleep 32 NULL 0.000
11 root localhost:37518 test Query 0 starting show full processlist 0.000
SHOW STATUS LIKE 'wsrep_cluster_status';
Variable_name Value
wsrep_cluster_status non-Primary
DROP TABLE test.t1;
More results from queries before failure can be found in /dev/shm/var/1/log/GCF-354.log