Note: MDEV-11597 and MDEV-11317 have been fixed by now, but the problem below (much more difficult to reproduce) is still there.
10.2 fd0479ce592e0
|
mysqld: /data/src/10.2/sql/sql_error.cc:380: void Diagnostics_area::set_ok_status(ulonglong, ulonglong, const char*): Assertion `!is_set() || (m_status == DA_OK_BULK && is_bulk_op())' failed.
|
170112 2:52:15 [ERROR] mysqld got signal 6 ;
|
# 2017-01-12T02:52:40 [13124] #6 0x00007f79e2fcd266 in __assert_fail_base (fmt=0x7f79e3106238 "%s%s%s:%u: %s%sAssertion `%s' failed.\n%n", assertion=assertion@entry=0x7f79e652e430 "!is_set() || (m_status == DA_OK_BULK && is_bulk_op())", file=file@entry=0x7f79e652e368 "/data/src/10.2/sql/sql_error.cc", line=line@entry=380, function=function@entry=0x7f79e652e880 <Diagnostics_area::set_ok_status(unsigned long long, unsigned long long, char const*)::__PRETTY_FUNCTION__> "void Diagnostics_area::set_ok_status(ulonglong, ulonglong, const char*)") at assert.c:92
|
# 2017-01-12T02:52:40 [13124] #7 0x00007f79e2fcd312 in __GI___assert_fail (assertion=0x7f79e652e430 "!is_set() || (m_status == DA_OK_BULK && is_bulk_op())", file=0x7f79e652e368 "/data/src/10.2/sql/sql_error.cc", line=380, function=0x7f79e652e880 <Diagnostics_area::set_ok_status(unsigned long long, unsigned long long, char const*)::__PRETTY_FUNCTION__> "void Diagnostics_area::set_ok_status(ulonglong, ulonglong, const char*)") at assert.c:101
|
# 2017-01-12T02:52:40 [13124] #8 0x00007f79e5a80a5d in Diagnostics_area::set_ok_status (this=0x7f799d41b050, affected_rows=0, last_insert_id=0, message=0x0) at /data/src/10.2/sql/sql_error.cc:380
|
# 2017-01-12T02:52:40 [13124] #9 0x00007f79e5a3604d in my_ok (thd=0x7f799d416070, affected_rows=0, id=0, message=0x0) at /data/src/10.2/sql/sql_class.h:4329
|
# 2017-01-12T02:52:40 [13124] #10 0x00007f79e5aae3e5 in mysql_execute_command (thd=0x7f799d416070) at /data/src/10.2/sql/sql_parse.cc:3937
|
# 2017-01-12T02:52:40 [13124] #11 0x00007f79e5aba8a0 in mysql_parse (thd=0x7f799d416070, rawbuf=0x7f799d4631d0 "CREATE OR REPLACE TABLE `create_or_replace_tmp` LIKE `t6` /* QNO 430 CON_ID 13 */", length=81, parser_state=0x7f79e6b6be20, is_com_multi=false, is_next_command=false) at /data/src/10.2/sql/sql_parse.cc:7842
|
# 2017-01-12T02:52:40 [13124] #12 0x00007f79e5aa89ab in dispatch_command (command=COM_QUERY, thd=0x7f799d416070, packet=0x7f799d454071 "CREATE OR REPLACE TABLE `create_or_replace_tmp` LIKE `t6` /* QNO 430 CON_ID 13 */ ", packet_length=82, is_com_multi=false, is_next_command=false) at /data/src/10.2/sql/sql_parse.cc:1800
|
# 2017-01-12T02:52:40 [13124] #13 0x00007f79e5aa73a3 in do_command (thd=0x7f799d416070) at /data/src/10.2/sql/sql_parse.cc:1360
|
# 2017-01-12T02:52:40 [13124] #14 0x00007f79e5befc48 in do_handle_one_connection (connect=0x7f79e2460050) at /data/src/10.2/sql/sql_connect.cc:1354
|
# 2017-01-12T02:52:40 [13124] #15 0x00007f79e5bef9d5 in handle_one_connection (arg=0x7f79e2460050) at /data/src/10.2/sql/sql_connect.cc:1260
|
# 2017-01-12T02:52:40 [13124] #16 0x00007f79e50da0a4 in start_thread (arg=0x7f79e6b6d300) at pthread_create.c:309
|
# 2017-01-12T02:52:40 [13124] #17 0x00007f79e308787d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:111
|
On 10.0 and 10.1 the assertion is different:
10.1 4b05d60e62e
|
mysqld: /data/src/10.1/sql/sql_error.cc:378: void Diagnostics_area::set_ok_status(ulonglong, ulonglong, const char*): Assertion `! is_set()' failed.
|
170112 3:05:13 [ERROR] mysqld got signal 6 ;
|
|
# 2017-01-12T03:05:36 [13531] #7 0x00007f95227a6312 in __GI___assert_fail (assertion=0x7f95258c72c0 "! is_set()", file=0x7f95258c71f8 "/data/src/10.1/sql/sql_error.cc", line=378, function=0x7f95258c76c0 <Diagnostics_area::set_ok_status(unsigned long long, unsigned long long, char const*)::__PRETTY_FUNCTION__> "void Diagnostics_area::set_ok_status(ulonglong, ulonglong, const char*)") at assert.c:101
|
# 2017-01-12T03:05:36 [13531] #8 0x00007f9524f86b00 in Diagnostics_area::set_ok_status (this=0x7f94fe671e78, affected_rows=0, last_insert_id=0, message=0x0) at /data/src/10.1/sql/sql_error.cc:378
|
# 2017-01-12T03:05:36 [13531] #9 0x00007f9524f40471 in my_ok (thd=0x7f94fe66d070, affected_rows=0, id=0, message=0x0) at /data/src/10.1/sql/sql_class.h:4080
|
# 2017-01-12T03:05:36 [13531] #10 0x00007f9524fb0dfb in mysql_execute_command (thd=0x7f94fe66d070) at /data/src/10.1/sql/sql_parse.cc:3467
|
# 2017-01-12T03:05:36 [13531] #11 0x00007f9524fbcbcd in mysql_parse (thd=0x7f94fe66d070, rawbuf=0x7f94f4822088 "CREATE OR REPLACE TABLE `create_or_replace_tmp` LIKE `t2` /* QNO 454 CON_ID 8 */", length=80, parser_state=0x7f9525e58630) at /data/src/10.1/sql/sql_parse.cc:7322
|
# 2017-01-12T03:05:36 [13531] #12 0x00007f9524fabbda in dispatch_command (command=COM_QUERY, thd=0x7f94fe66d070, packet=0x7f94fe673071 "CREATE OR REPLACE TABLE `create_or_replace_tmp` LIKE `t2` /* QNO 454 CON_ID 8 */ ", packet_length=81) at /data/src/10.1/sql/sql_parse.cc:1488
|
# 2017-01-12T03:05:36 [13531] #13 0x00007f9524faa953 in do_command (thd=0x7f94fe66d070) at /data/src/10.1/sql/sql_parse.cc:1109
|
# 2017-01-12T03:05:36 [13531] #14 0x00007f95250e07cc in do_handle_one_connection (thd_arg=0x7f94fe66d070) at /data/src/10.1/sql/sql_connect.cc:1350
|
# 2017-01-12T03:05:36 [13531] #15 0x00007f95250e0530 in handle_one_connection (arg=0x7f94fe66d070) at /data/src/10.1/sql/sql_connect.cc:1262
|
# 2017-01-12T03:05:36 [13531] #16 0x00007f95246a80a4 in start_thread (arg=0x7f9525e59b00) at pthread_create.c:309
|
# 2017-01-12T03:05:36 [13531] #17 0x00007f952286087d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:111
|
To reproduce:
git clone https://github.com/elenst/rqg --branch mdev11779 rqg-mdev11779
|
cd rqg-mdev11779
|
. ./run <basedir> <vardir>
|
The test starts the server on port 19300 and runs the test flow for 5 minutes. The flow includes killing and restarting the server, it produces a lot of noise. It can also return bogus STATUS_SERVER_CRASHED at the end, it is not an indication of the problem itself. The real indication is that the test terminates prematurely and prints a stack trace at the end (and of course the server error log contains the error report).
Due to crash/restart being a part of the flow, unfortunately it's impossible to convert it to gentest.pl running on a previously started server.
{"report":{"fcp":860.1000001430511,"ttfb":178.80000019073486,"pageVisibility":"visible","entityId":59773,"key":"jira.project.issue.view-issue","isInitial":true,"threshold":1000,"elementTimings":{},"userDeviceMemory":8,"userDeviceProcessors":64,"apdex":1,"journeyId":"9881a89f-2e99-4392-bac9-e3076b09954d","navigationType":0,"readyForUser":963.7000000476837,"redirectCount":0,"resourceLoadedEnd":1185.8000001907349,"resourceLoadedStart":184.60000014305115,"resourceTiming":[{"duration":252.09999990463257,"initiatorType":"link","name":"https://jira.mariadb.org/s/2c21342762a6a02add1c328bed317ffd-CDN/lu2bu7/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/css/_super/batch.css","startTime":184.60000014305115,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":184.60000014305115,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":436.7000000476837,"responseStart":0,"secureConnectionStart":0},{"duration":251.80000019073486,"initiatorType":"link","name":"https://jira.mariadb.org/s/7ebd35e77e471bc30ff0eba799ebc151-CDN/lu2bu7/820016/12ta74/8679b4946efa1a0bb029a3a22206fb5d/_/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":185,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":185,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":436.80000019073486,"responseStart":0,"secureConnectionStart":0},{"duration":260.7000000476837,"initiatorType":"script","name":"https://jira.mariadb.org/s/fbf975c0cce4b1abf04784eeae9ba1f4-CDN/lu2bu7/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/js/_super/batch.js?locale=en","startTime":185.20000004768372,"connectEnd":185.20000004768372,"connectStart":185.20000004768372,"domainLookupEnd":185.20000004768372,"domainLookupStart":185.20000004768372,"fetchStart":185.20000004768372,"redirectEnd":0,"redirectStart":0,"requestStart":185.20000004768372,"responseEnd":445.90000009536743,"responseStart":445.90000009536743,"secureConnectionStart":185.20000004768372},{"duration":285.7999999523163,"initiatorType":"script","name":"https://jira.mariadb.org/s/099b33461394b8015fc36c0a4b96e19f-CDN/lu2bu7/820016/12ta74/8679b4946efa1a0bb029a3a22206fb5d/_/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":185.30000019073486,"connectEnd":185.30000019073486,"connectStart":185.30000019073486,"domainLookupEnd":185.30000019073486,"domainLookupStart":185.30000019073486,"fetchStart":185.30000019073486,"redirectEnd":0,"redirectStart":0,"requestStart":185.30000019073486,"responseEnd":471.10000014305115,"responseStart":471.10000014305115,"secureConnectionStart":185.30000019073486},{"duration":289,"initiatorType":"script","name":"https://jira.mariadb.org/s/94c15bff32baef80f4096a08aceae8bc-CDN/lu2bu7/820016/12ta74/c92c0caa9a024ae85b0ebdbed7fb4bd7/_/download/contextbatch/js/atl.global,-_super/batch.js?locale=en","startTime":185.40000009536743,"connectEnd":185.40000009536743,"connectStart":185.40000009536743,"domainLookupEnd":185.40000009536743,"domainLookupStart":185.40000009536743,"fetchStart":185.40000009536743,"redirectEnd":0,"redirectStart":0,"requestStart":185.40000009536743,"responseEnd":474.40000009536743,"responseStart":474.40000009536743,"secureConnectionStart":185.40000009536743},{"duration":289.40000009536743,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bu7/820016/12ta74/1.0/_/download/batch/jira.webresources:calendar-en/jira.webresources:calendar-en.js","startTime":185.5,"connectEnd":185.5,"connectStart":185.5,"domainLookupEnd":185.5,"domainLookupStart":185.5,"fetchStart":185.5,"redirectEnd":0,"redirectStart":0,"requestStart":185.5,"responseEnd":474.90000009536743,"responseStart":474.90000009536743,"secureConnectionStart":185.5},{"duration":290.2999999523163,"initiatorType":"link","name":"https://jira.mariadb.org/s/b04b06a02d1959df322d9cded3aeecc1-CDN/lu2bu7/820016/12ta74/a2ff6aa845ffc9a1d22fe23d9ee791fc/_/download/contextbatch/css/jira.global.look-and-feel,-_super/batch.css","startTime":185.70000004768372,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":185.70000004768372,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":476,"responseStart":0,"secureConnectionStart":0},{"duration":289.7999999523163,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bu7/820016/12ta74/1.0/_/download/batch/jira.webresources:calendar-localisation-moment/jira.webresources:calendar-localisation-moment.js","startTime":185.70000004768372,"connectEnd":185.70000004768372,"connectStart":185.70000004768372,"domainLookupEnd":185.70000004768372,"domainLookupStart":185.70000004768372,"fetchStart":185.70000004768372,"redirectEnd":0,"redirectStart":0,"requestStart":185.70000004768372,"responseEnd":475.5,"responseStart":475.5,"secureConnectionStart":185.70000004768372},{"duration":290.19999980926514,"initiatorType":"script","name":"https://jira.mariadb.org/rest/api/1.0/shortcuts/820016/47140b6e0a9bc2e4913da06536125810/shortcuts.js?context=issuenavigation&context=issueaction","startTime":185.80000019073486,"connectEnd":185.80000019073486,"connectStart":185.80000019073486,"domainLookupEnd":185.80000019073486,"domainLookupStart":185.80000019073486,"fetchStart":185.80000019073486,"redirectEnd":0,"redirectStart":0,"requestStart":185.80000019073486,"responseEnd":476,"responseStart":476,"secureConnectionStart":185.80000019073486},{"duration":290.60000014305115,"initiatorType":"link","name":"https://jira.mariadb.org/s/3ac36323ba5e4eb0af2aa7ac7211b4bb-CDN/lu2bu7/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":186,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":186,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":476.60000014305115,"responseStart":0,"secureConnectionStart":0},{"duration":290.59999990463257,"initiatorType":"script","name":"https://jira.mariadb.org/s/3339d87fa2538a859872f2df449bf8d0-CDN/lu2bu7/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":186.10000014305115,"connectEnd":186.10000014305115,"connectStart":186.10000014305115,"domainLookupEnd":186.10000014305115,"domainLookupStart":186.10000014305115,"fetchStart":186.10000014305115,"redirectEnd":0,"redirectStart":0,"requestStart":186.10000014305115,"responseEnd":476.7000000476837,"responseStart":476.7000000476837,"secureConnectionStart":186.10000014305115},{"duration":993.2999999523163,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bu7/820016/12ta74/1.0/_/download/batch/jira.webresources:bigpipe-js/jira.webresources:bigpipe-js.js","startTime":191.90000009536743,"connectEnd":191.90000009536743,"connectStart":191.90000009536743,"domainLookupEnd":191.90000009536743,"domainLookupStart":191.90000009536743,"fetchStart":191.90000009536743,"redirectEnd":0,"redirectStart":0,"requestStart":191.90000009536743,"responseEnd":1185.2000000476837,"responseStart":1185.2000000476837,"secureConnectionStart":191.90000009536743},{"duration":993.8000001907349,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bu7/820016/12ta74/1.0/_/download/batch/jira.webresources:bigpipe-init/jira.webresources:bigpipe-init.js","startTime":192,"connectEnd":192,"connectStart":192,"domainLookupEnd":192,"domainLookupStart":192,"fetchStart":192,"redirectEnd":0,"redirectStart":0,"requestStart":192,"responseEnd":1185.8000001907349,"responseStart":1185.8000001907349,"secureConnectionStart":192},{"duration":478.40000009536743,"initiatorType":"xmlhttprequest","name":"https://jira.mariadb.org/rest/webResources/1.0/resources","startTime":657.4000000953674,"connectEnd":657.4000000953674,"connectStart":657.4000000953674,"domainLookupEnd":657.4000000953674,"domainLookupStart":657.4000000953674,"fetchStart":657.4000000953674,"redirectEnd":0,"redirectStart":0,"requestStart":657.4000000953674,"responseEnd":1135.8000001907349,"responseStart":1135.8000001907349,"secureConnectionStart":657.4000000953674}],"fetchStart":0,"domainLookupStart":0,"domainLookupEnd":0,"connectStart":0,"connectEnd":0,"requestStart":42,"responseStart":179,"responseEnd":189,"domLoading":183,"domInteractive":1208,"domContentLoadedEventStart":1208,"domContentLoadedEventEnd":1241,"domComplete":2452,"loadEventStart":2452,"loadEventEnd":2454,"userAgent":"Mozilla/5.0 AppleWebKit/537.36 (KHTML, like Gecko; compatible; ClaudeBot/1.0; +claudebot@anthropic.com)","marks":[{"name":"bigPipe.sidebar-id.start","time":1191.4000000953674},{"name":"bigPipe.sidebar-id.end","time":1192.2000000476837},{"name":"bigPipe.activity-panel-pipe-id.start","time":1192.4000000953674},{"name":"bigPipe.activity-panel-pipe-id.end","time":1194.7000000476837},{"name":"activityTabFullyLoaded","time":1247.9000000953674}],"measures":[],"correlationId":"448254ab966684","effectiveType":"4g","downlink":10,"rtt":0,"serverDuration":81,"dbReadsTimeInMs":21,"dbConnsTimeInMs":31,"applicationHash":"9d11dbea5f4be3d4cc21f03a88dd11d8c8687422","experiments":[]}}