http://buildbot.askmonty.org/buildbot/builders/p8-trusty-bintar-debug/builds/95/steps/test/logs/stdio
rpl.rpl_parallel 'innodb_plugin,mix' w1 [ fail ]
|
Test ended at 2016-08-14 05:19:15
|
|
CURRENT_TEST: rpl.rpl_parallel
|
mysqltest: In included file "./include/sync_with_master_gtid.inc":
|
included from /var/lib/buildbot/maria-slave/p8-trusty-bintar-debug/build/mysql-test/suite/rpl/t/rpl_parallel.test at line 2371:
|
At line 44: Failed to sync with master
|
|
The result from queries just before the failure was:
|
< snip >
|
SET @old_dbug= @@SESSION.debug_dbug;
|
SET @commit_id= 20000;
|
SET SESSION debug_dbug="+d,binlog_force_commit_id";
|
SET SESSION debug_dbug=@old_dbug;
|
SELECT * FROM t7 ORDER BY a;
|
a b
|
1 1
|
2 2
|
3 86
|
4 4
|
5 5
|
100 5
|
101 1
|
102 2
|
103 3
|
104 4
|
include/save_master_gtid.inc
|
include/start_slave.inc
|
include/sync_with_master_gtid.inc
|
Timeout in master_gtid_wait('1-1-3,0-1-1454,3-1-1,2-1-2', 120), current slave GTID position is: 1-1-3,0-1-1254,3-1-1,2-1-2.
|
{"report":{"fcp":1001,"ttfb":215.09999990463257,"pageVisibility":"visible","entityId":57744,"key":"jira.project.issue.view-issue","isInitial":true,"threshold":1000,"elementTimings":{},"userDeviceMemory":8,"userDeviceProcessors":64,"apdex":0.5,"journeyId":"4e71e109-f713-49c3-abb9-11d36e1e262a","navigationType":0,"readyForUser":1084.1999998092651,"redirectCount":0,"resourceLoadedEnd":1350.5999999046326,"resourceLoadedStart":232.39999961853027,"resourceTiming":[{"duration":127.30000019073486,"initiatorType":"link","name":"https://jira.mariadb.org/s/2c21342762a6a02add1c328bed317ffd-CDN/lu2cib/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/css/_super/batch.css","startTime":232.39999961853027,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":232.39999961853027,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":359.69999980926514,"responseStart":0,"secureConnectionStart":0},{"duration":282.40000009536743,"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":232.69999980926514,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":232.69999980926514,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":515.0999999046326,"responseStart":0,"secureConnectionStart":0},{"duration":291.30000019073486,"initiatorType":"script","name":"https://jira.mariadb.org/s/0917945aaa57108d00c5076fea35e069-CDN/lu2cib/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/js/_super/batch.js?locale=en","startTime":232.89999961853027,"connectEnd":232.89999961853027,"connectStart":232.89999961853027,"domainLookupEnd":232.89999961853027,"domainLookupStart":232.89999961853027,"fetchStart":232.89999961853027,"redirectEnd":0,"redirectStart":0,"requestStart":232.89999961853027,"responseEnd":524.1999998092651,"responseStart":524.1999998092651,"secureConnectionStart":232.89999961853027},{"duration":323.19999980926514,"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":233,"connectEnd":233,"connectStart":233,"domainLookupEnd":233,"domainLookupStart":233,"fetchStart":233,"redirectEnd":0,"redirectStart":0,"requestStart":233,"responseEnd":556.1999998092651,"responseStart":556.1999998092651,"secureConnectionStart":233},{"duration":326.59999990463257,"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":233.2999997138977,"connectEnd":233.2999997138977,"connectStart":233.2999997138977,"domainLookupEnd":233.2999997138977,"domainLookupStart":233.2999997138977,"fetchStart":233.2999997138977,"redirectEnd":0,"redirectStart":0,"requestStart":233.2999997138977,"responseEnd":559.8999996185303,"responseStart":559.8999996185303,"secureConnectionStart":233.2999997138977},{"duration":327,"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":233.5,"connectEnd":233.5,"connectStart":233.5,"domainLookupEnd":233.5,"domainLookupStart":233.5,"fetchStart":233.5,"redirectEnd":0,"redirectStart":0,"requestStart":233.5,"responseEnd":560.5,"responseStart":560.5,"secureConnectionStart":233.5},{"duration":327.09999990463257,"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":233.69999980926514,"connectEnd":233.69999980926514,"connectStart":233.69999980926514,"domainLookupEnd":233.69999980926514,"domainLookupStart":233.69999980926514,"fetchStart":233.69999980926514,"redirectEnd":0,"redirectStart":0,"requestStart":233.69999980926514,"responseEnd":560.7999997138977,"responseStart":560.7999997138977,"secureConnectionStart":233.69999980926514},{"duration":435.5,"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":233.7999997138977,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":233.7999997138977,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":669.2999997138977,"responseStart":0,"secureConnectionStart":0},{"duration":327.2999997138977,"initiatorType":"script","name":"https://jira.mariadb.org/rest/api/1.0/shortcuts/820016/47140b6e0a9bc2e4913da06536125810/shortcuts.js?context=issuenavigation&context=issueaction","startTime":234.09999990463257,"connectEnd":234.09999990463257,"connectStart":234.09999990463257,"domainLookupEnd":234.09999990463257,"domainLookupStart":234.09999990463257,"fetchStart":234.09999990463257,"redirectEnd":0,"redirectStart":0,"requestStart":234.09999990463257,"responseEnd":561.3999996185303,"responseStart":561.3999996185303,"secureConnectionStart":234.09999990463257},{"duration":435.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":234.19999980926514,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":234.19999980926514,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":669.3999996185303,"responseStart":0,"secureConnectionStart":0},{"duration":327.5,"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":234.39999961853027,"connectEnd":234.39999961853027,"connectStart":234.39999961853027,"domainLookupEnd":234.39999961853027,"domainLookupStart":234.39999961853027,"fetchStart":234.39999961853027,"redirectEnd":0,"redirectStart":0,"requestStart":234.39999961853027,"responseEnd":561.8999996185303,"responseStart":561.8999996185303,"secureConnectionStart":234.39999961853027},{"duration":658.8000001907349,"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":235.39999961853027,"connectEnd":235.39999961853027,"connectStart":235.39999961853027,"domainLookupEnd":235.39999961853027,"domainLookupStart":235.39999961853027,"fetchStart":235.39999961853027,"redirectEnd":0,"redirectStart":0,"requestStart":235.39999961853027,"responseEnd":894.1999998092651,"responseStart":894.1999998092651,"secureConnectionStart":235.39999961853027},{"duration":1090.1000003814697,"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":235.39999961853027,"connectEnd":235.39999961853027,"connectStart":235.39999961853027,"domainLookupEnd":235.39999961853027,"domainLookupStart":235.39999961853027,"fetchStart":235.39999961853027,"redirectEnd":0,"redirectStart":0,"requestStart":235.39999961853027,"responseEnd":1325.5,"responseStart":1325.5,"secureConnectionStart":235.39999961853027},{"duration":213,"initiatorType":"xmlhttprequest","name":"https://jira.mariadb.org/rest/webResources/1.0/resources","startTime":683.0999999046326,"connectEnd":683.0999999046326,"connectStart":683.0999999046326,"domainLookupEnd":683.0999999046326,"domainLookupStart":683.0999999046326,"fetchStart":683.0999999046326,"redirectEnd":0,"redirectStart":0,"requestStart":683.0999999046326,"responseEnd":896.0999999046326,"responseStart":896.0999999046326,"secureConnectionStart":683.0999999046326},{"duration":393.30000019073486,"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":957.2999997138977,"connectEnd":957.2999997138977,"connectStart":957.2999997138977,"domainLookupEnd":957.2999997138977,"domainLookupStart":957.2999997138977,"fetchStart":957.2999997138977,"redirectEnd":0,"redirectStart":0,"requestStart":957.2999997138977,"responseEnd":1350.5999999046326,"responseStart":1350.5999999046326,"secureConnectionStart":957.2999997138977},{"duration":363,"initiatorType":"script","name":"https://www.google-analytics.com/analytics.js","startTime":995,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":995,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":1358,"responseStart":0,"secureConnectionStart":0}],"fetchStart":0,"domainLookupStart":0,"domainLookupEnd":0,"connectStart":0,"connectEnd":0,"requestStart":53,"responseStart":215,"responseEnd":216,"domLoading":230,"domInteractive":1360,"domContentLoadedEventStart":1360,"domContentLoadedEventEnd":1403,"domComplete":1905,"loadEventStart":1905,"loadEventEnd":1905,"userAgent":"Mozilla/5.0 AppleWebKit/537.36 (KHTML, like Gecko; compatible; ClaudeBot/1.0; +claudebot@anthropic.com)","marks":[{"name":"bigPipe.sidebar-id.start","time":1327.5999999046326},{"name":"bigPipe.sidebar-id.end","time":1328.5},{"name":"bigPipe.activity-panel-pipe-id.start","time":1328.5999999046326},{"name":"bigPipe.activity-panel-pipe-id.end","time":1329.5999999046326},{"name":"activityTabFullyLoaded","time":1418.2999997138977}],"measures":[],"correlationId":"7688fa31cfe5e","effectiveType":"4g","downlink":9.9,"rtt":0,"serverDuration":98,"dbReadsTimeInMs":13,"dbConnsTimeInMs":22,"applicationHash":"9d11dbea5f4be3d4cc21f03a88dd11d8c8687422","experiments":[]}}
This failure was observed on two builders:
The problem is, apparently, a simple timing issue, when on a really slow builder the default 120 second timeout in sync_with_master_gtid.inc wasn't enough for the slave to catch up with master. Since we don't observe it anymore on a non-valgrind builders, let's ignore this possibility for now (that p8 was indeed extremely slow); and for valgrind runs, it makes sense to increase the timeout as it has already been done in some other places in MTR.
https://github.com/MariaDB/server/commit/80a4525b3a9f234043419ce2217880516fd3195b