http://buildbot.askmonty.org/buildbot/builders/qa-kvm-linux/builds/1658/steps/stable_tests/logs/stdio
tokudb_bugs.xa-3 'innodb' w2 [ fail ]
|
Test ended at 2017-07-05 13:24:51
|
|
CURRENT_TEST: tokudb_bugs.xa-3
|
|
|
Server [mysqld.1 - pid: 2997, winpid: 2997, exit: 256] failed during test run
|
Server log from this test:
|
----------SERVER LOG START-----------
|
SIGKILL myself
|
2017-07-05 13:24:49 140090411992896 [Note] /home/buildbot/build/sql/mysqld (mysqld 10.2.7-MariaDB-debug-log) starting as process 2998 ...
|
2017-07-05 13:24:49 140090411992896 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
|
2017-07-05 13:24:49 140090411992896 [Note] Plugin 'SEQUENCE' is disabled.
|
Wed Jul 5 13:24:49 2017 PerconaFT recovery starting in env /home/buildbot/build/mysql-test/var/2/mysqld.1/data/
|
Wed Jul 5 13:24:49 2017 PerconaFT recovery scanning backward from 545
|
Wed Jul 5 13:24:49 2017 PerconaFT recovery bw_end_checkpoint at 12 timestamp 1499275474701350 xid 8 (bw_newer)
|
Wed Jul 5 13:24:49 2017 PerconaFT recovery bw_begin_checkpoint at 8 timestamp 1499275474700634 (bw_between)
|
Wed Jul 5 13:24:49 2017 PerconaFT recovery turning around at begin checkpoint 8 time 716
|
Wed Jul 5 13:24:49 2017 PerconaFT recovery starts scanning forward to 545 from 8 left 537 (fw_between)
|
Wed Jul 5 13:24:49 2017 PerconaFT recovery closing 2 dictionaries
|
Wed Jul 5 13:24:49 2017 PerconaFT recovery making a checkpoint
|
Wed Jul 5 13:24:49 2017 PerconaFT recovery done
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Uses event mutexes
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Compressed tables use zlib 1.2.8
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Using Linux native AIO
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Number of pools: 1
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Using generic crc32 instructions
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Initializing buffer pool, total size = 8M, instances = 1, chunk size = 8M
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Completed initialization of buffer pool
|
2017-07-05 13:24:49 140089241872128 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Highest supported file format is Barracuda.
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Starting crash recovery from checkpoint LSN=2785956
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Ignoring data file './test/t1.ibd' with space ID 14, since the redo log references ./test/t1.ibd with space ID 7.
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Ignoring data file './test/t1.ibd' with space ID 14, since the redo log references ./test/t1.ibd with space ID 13.
|
2017-07-05 13:24:49 140090411992896 [Note] InnoDB: Starting a batch to recover 179 pages from redo log.
|
mysqld: /home/buildbot/build/storage/innobase/mtr/mtr0mtr.cc:603: void mtr_t::commit_checkpoint(lsn_t, bool): Assertion `!recv_no_log_write' failed.
|
170705 13:24:50 [ERROR] mysqld got signal 6 ;
|
This could be because you hit a bug. It is also possible that this binary
|
or one of the libraries it was linked against is corrupt, improperly built,
|
or misconfigured. This error can also be caused by malfunctioning hardware.
|
|
To report this bug, see https://mariadb.com/kb/en/reporting-bugs
|
|
We will try our best to scrape up some info that will hopefully help
|
diagnose the problem, but since we have already crashed,
|
something is definitely wrong and this may fail.
|
|
Server version: 10.2.7-MariaDB-debug-log
|
key_buffer_size=1048576
|
read_buffer_size=131072
|
max_used_connections=0
|
max_threads=153
|
thread_count=0
|
It is possible that mysqld could use up to
|
key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 63068 K bytes of memory
|
Hope that's ok; if not, decrease some variables in the equation.
|
|
Thread pointer: 0x0
|
Attempting backtrace. You can use the following information to find out
|
where mysqld died. If you see no messages after this, something went
|
terribly wrong...
|
stack_bottom = 0x0 thread_stack 0x49000
|
/home/buildbot/build/sql/mysqld(my_print_stacktrace+0x38)[0x7f6956b6c3c8]
|
/home/buildbot/build/sql/mysqld(handle_fatal_signal+0x3a3)[0x7f6956404810]
|
/lib/x86_64-linux-gnu/libpthread.so.0(+0xf890)[0x7f69557bd890]
|
/lib/x86_64-linux-gnu/libc.so.6(gsignal+0x37)[0x7f6953af3067]
|
/lib/x86_64-linux-gnu/libc.so.6(abort+0x148)[0x7f6953af4448]
|
/lib/x86_64-linux-gnu/libc.so.6(+0x2e266)[0x7f6953aec266]
|
/lib/x86_64-linux-gnu/libc.so.6(+0x2e312)[0x7f6953aec312]
|
/home/buildbot/build/sql/mysqld(+0xac51ae)[0x7f69566b31ae]
|
/home/buildbot/build/sql/mysqld(+0xd21f62)[0x7f695690ff62]
|
/home/buildbot/build/sql/mysqld(+0xab8f30)[0x7f69566a6f30]
|
/home/buildbot/build/sql/mysqld(+0xbcef01)[0x7f69567bcf01]
|
/home/buildbot/build/sql/mysqld(+0xa0f039)[0x7f69565fd039]
|
/home/buildbot/build/sql/mysqld(_Z24ha_initialize_handlertonP13st_plugin_int+0xfc)[0x7f6956406849]
|
mysys/stacktrace.c:267(my_print_stacktrace)[0x7f69561b14f8]
|
/home/buildbot/build/sql/mysqld(_Z11plugin_initPiPPci+0x912)[0x7f69561b2101]
|
sql/signal_handler.cc:168(handle_fatal_signal)[0x7f69560bef35]
|
/home/buildbot/build/sql/mysqld(_Z11mysqld_mainiPPc+0x5f4)[0x7f69560bffba]
|
fil/fil0fil.cc:6580(fil_names_clear(unsigned long, bool))[0x7f69560b4ee0]
|
/lib/x86_64-linux-gnu/libc.so.6(__libc_start_main+0xf5)[0x7f6953adfb45]
|
log/log0recv.cc:3351(recv_recovery_from_checkpoint_start(unsigned long))[0x7f69560b4db9]
|
The manual page at http://dev.mysql.com/doc/mysql/en/crashing.html contains
|
information that should help you find out what is causing the crash.
|
Writing a core file
|
----------SERVER LOG END-------------
|
mysqltest failed but provided no output
|
The result from queries just before the failure was:
|
< snip >
|
drop table if exists t1, t2;
|
CREATE TABLE t1 (a INT PRIMARY KEY) ENGINE=innodb;
|
CREATE TABLE t2 (b INT PRIMARY KEY) ENGINE=tokudb;
|
BEGIN;
|
SELECT @@log_bin;
|
@@log_bin
|
0
|
INSERT INTO t1 VALUES (1);
|
INSERT INTO t2 VALUES (2);
|
SET SESSION debug_dbug="d,crash_commit_before";
|
COMMIT;
|
ERROR HY000: Lost connection to MySQL server during query
|
|
|
|
- saving '/home/buildbot/build/mysql-test/var/2/log/tokudb_bugs.xa-3-innodb/' to '/home/buildbot/build/mysql-test/var/log/tokudb_bugs.xa-3-innodb/'
|
worker[2] > Restart - not started
|
***Warnings generated in error logs during shutdown after running tests: tokudb_bugs.xa-3
|
I also had the same assertion failure with tokudb_bugs.xa-4 on a local debug build.
{"report":{"fcp":863.0999999046326,"ttfb":185.79999995231628,"pageVisibility":"visible","entityId":62186,"key":"jira.project.issue.view-issue","isInitial":true,"threshold":1000,"elementTimings":{},"userDeviceMemory":8,"userDeviceProcessors":64,"apdex":1,"journeyId":"b7a15f0a-39a9-4a56-90e1-2aedcc71a705","navigationType":0,"readyForUser":958,"redirectCount":0,"resourceLoadedEnd":916.9000000953674,"resourceLoadedStart":192.20000004768372,"resourceTiming":[{"duration":8.399999856948853,"initiatorType":"link","name":"https://jira.mariadb.org/s/2c21342762a6a02add1c328bed317ffd-CDN/lu2bu7/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/css/_super/batch.css","startTime":192.20000004768372,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":192.20000004768372,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":200.59999990463257,"responseStart":0,"secureConnectionStart":0},{"duration":8.599999904632568,"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":192.5,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":192.5,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":201.09999990463257,"responseStart":0,"secureConnectionStart":0},{"duration":68.5,"initiatorType":"script","name":"https://jira.mariadb.org/s/fbf975c0cce4b1abf04784eeae9ba1f4-CDN/lu2bu7/820016/12ta74/0a8bac35585be7fc6c9cc5a0464cd4cf/_/download/contextbatch/js/_super/batch.js?locale=en","startTime":192.59999990463257,"connectEnd":192.59999990463257,"connectStart":192.59999990463257,"domainLookupEnd":192.59999990463257,"domainLookupStart":192.59999990463257,"fetchStart":192.59999990463257,"redirectEnd":0,"redirectStart":0,"requestStart":192.59999990463257,"responseEnd":261.09999990463257,"responseStart":261.09999990463257,"secureConnectionStart":192.59999990463257},{"duration":304.59999990463257,"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":192.70000004768372,"connectEnd":192.70000004768372,"connectStart":192.70000004768372,"domainLookupEnd":192.70000004768372,"domainLookupStart":192.70000004768372,"fetchStart":192.70000004768372,"redirectEnd":0,"redirectStart":0,"requestStart":192.70000004768372,"responseEnd":497.2999999523163,"responseStart":497.2999999523163,"secureConnectionStart":192.70000004768372},{"duration":308.2999999523163,"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":192.79999995231628,"connectEnd":192.79999995231628,"connectStart":192.79999995231628,"domainLookupEnd":192.79999995231628,"domainLookupStart":192.79999995231628,"fetchStart":192.79999995231628,"redirectEnd":0,"redirectStart":0,"requestStart":192.79999995231628,"responseEnd":501.09999990463257,"responseStart":501.09999990463257,"secureConnectionStart":192.79999995231628},{"duration":308.7999999523163,"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":192.90000009536743,"connectEnd":192.90000009536743,"connectStart":192.90000009536743,"domainLookupEnd":192.90000009536743,"domainLookupStart":192.90000009536743,"fetchStart":192.90000009536743,"redirectEnd":0,"redirectStart":0,"requestStart":192.90000009536743,"responseEnd":501.7000000476837,"responseStart":501.59999990463257,"secureConnectionStart":192.90000009536743},{"duration":309.5,"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":193,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":193,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":502.5,"responseStart":0,"secureConnectionStart":0},{"duration":309.09999990463257,"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":193,"connectEnd":193,"connectStart":193,"domainLookupEnd":193,"domainLookupStart":193,"fetchStart":193,"redirectEnd":0,"redirectStart":0,"requestStart":193,"responseEnd":502.09999990463257,"responseStart":502.09999990463257,"secureConnectionStart":193},{"duration":309.30000019073486,"initiatorType":"script","name":"https://jira.mariadb.org/rest/api/1.0/shortcuts/820016/47140b6e0a9bc2e4913da06536125810/shortcuts.js?context=issuenavigation&context=issueaction","startTime":193.09999990463257,"connectEnd":193.09999990463257,"connectStart":193.09999990463257,"domainLookupEnd":193.09999990463257,"domainLookupStart":193.09999990463257,"fetchStart":193.09999990463257,"redirectEnd":0,"redirectStart":0,"requestStart":193.09999990463257,"responseEnd":502.40000009536743,"responseStart":502.40000009536743,"secureConnectionStart":193.09999990463257},{"duration":309.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":193.29999995231628,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":193.29999995231628,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":502.90000009536743,"responseStart":0,"secureConnectionStart":0},{"duration":309.5,"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":193.5,"connectEnd":193.5,"connectStart":193.5,"domainLookupEnd":193.5,"domainLookupStart":193.5,"fetchStart":193.5,"redirectEnd":0,"redirectStart":0,"requestStart":193.5,"responseEnd":503,"responseStart":503,"secureConnectionStart":193.5},{"duration":518.9000000953674,"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":194,"connectEnd":194,"connectStart":194,"domainLookupEnd":194,"domainLookupStart":194,"fetchStart":194,"redirectEnd":0,"redirectStart":0,"requestStart":194,"responseEnd":712.9000000953674,"responseStart":712.9000000953674,"secureConnectionStart":194},{"duration":592.3000001907349,"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":194.09999990463257,"connectEnd":194.09999990463257,"connectStart":194.09999990463257,"domainLookupEnd":194.09999990463257,"domainLookupStart":194.09999990463257,"fetchStart":194.09999990463257,"redirectEnd":0,"redirectStart":0,"requestStart":194.09999990463257,"responseEnd":786.4000000953674,"responseStart":786.4000000953674,"secureConnectionStart":194.09999990463257},{"duration":303.60000014305115,"initiatorType":"xmlhttprequest","name":"https://jira.mariadb.org/rest/webResources/1.0/resources","startTime":408.59999990463257,"connectEnd":408.59999990463257,"connectStart":408.59999990463257,"domainLookupEnd":408.59999990463257,"domainLookupStart":408.59999990463257,"fetchStart":408.59999990463257,"redirectEnd":0,"redirectStart":0,"requestStart":408.59999990463257,"responseEnd":712.2000000476837,"responseStart":712.2000000476837,"secureConnectionStart":408.59999990463257},{"duration":21.59999990463257,"initiatorType":"link","name":"https://jira.mariadb.org/s/d5715adaadd168a9002b108b2b039b50-CDN/lu2bu7/820016/12ta74/be4b45e9cec53099498fa61c8b7acba4/_/download/contextbatch/css/jira.project.sidebar,-_super,-project.issue.navigator,-jira.general,-jira.browse.project,-jira.view.issue,-jira.global,-atl.general,-com.atlassian.jira.projects.sidebar.init/batch.css?agile_global_admin_condition=true&jag=true&jira.create.linked.issue=true&slack-enabled=true","startTime":765.7000000476837,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":765.7000000476837,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":787.2999999523163,"responseStart":0,"secureConnectionStart":0},{"duration":135.5,"initiatorType":"script","name":"https://jira.mariadb.org/s/d41d8cd98f00b204e9800998ecf8427e-CDN/lu2bu7/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","startTime":766.4000000953674,"connectEnd":766.4000000953674,"connectStart":766.4000000953674,"domainLookupEnd":766.4000000953674,"domainLookupStart":766.4000000953674,"fetchStart":766.4000000953674,"redirectEnd":0,"redirectStart":0,"requestStart":766.4000000953674,"responseEnd":901.9000000953674,"responseStart":901.9000000953674,"secureConnectionStart":766.4000000953674},{"duration":150.10000014305115,"initiatorType":"script","name":"https://jira.mariadb.org/s/f51ef5507eea4c158f257c66c93b2a3f-CDN/lu2bu7/820016/12ta74/be4b45e9cec53099498fa61c8b7acba4/_/download/contextbatch/js/jira.project.sidebar,-_super,-project.issue.navigator,-jira.general,-jira.browse.project,-jira.view.issue,-jira.global,-atl.general,-com.atlassian.jira.projects.sidebar.init/batch.js?agile_global_admin_condition=true&jag=true&jira.create.linked.issue=true&locale=en&slack-enabled=true","startTime":766.7999999523163,"connectEnd":766.7999999523163,"connectStart":766.7999999523163,"domainLookupEnd":766.7999999523163,"domainLookupStart":766.7999999523163,"fetchStart":766.7999999523163,"redirectEnd":0,"redirectStart":0,"requestStart":766.7999999523163,"responseEnd":916.9000000953674,"responseStart":916.9000000953674,"secureConnectionStart":766.7999999523163},{"duration":93.20000004768372,"initiatorType":"script","name":"https://www.google-analytics.com/analytics.js","startTime":855.7000000476837,"connectEnd":0,"connectStart":0,"domainLookupEnd":0,"domainLookupStart":0,"fetchStart":855.7000000476837,"redirectEnd":0,"redirectStart":0,"requestStart":0,"responseEnd":948.9000000953674,"responseStart":0,"secureConnectionStart":0},{"duration":121.89999985694885,"initiatorType":"xmlhttprequest","name":"https://jira.mariadb.org/rest/webResources/1.0/resources","startTime":878.4000000953674,"connectEnd":878.4000000953674,"connectStart":878.4000000953674,"domainLookupEnd":878.4000000953674,"domainLookupStart":878.4000000953674,"fetchStart":878.4000000953674,"redirectEnd":0,"redirectStart":0,"requestStart":878.4000000953674,"responseEnd":1000.2999999523163,"responseStart":1000.2999999523163,"secureConnectionStart":878.4000000953674}],"fetchStart":0,"domainLookupStart":0,"domainLookupEnd":0,"connectStart":0,"connectEnd":0,"requestStart":35,"responseStart":186,"responseEnd":189,"domLoading":189,"domInteractive":1038,"domContentLoadedEventStart":1038,"domContentLoadedEventEnd":1086,"domComplete":1744,"loadEventStart":1744,"loadEventEnd":1746,"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.5},{"name":"bigPipe.sidebar-id.end","time":1003.4000000953674},{"name":"bigPipe.activity-panel-pipe-id.start","time":1003.5},{"name":"bigPipe.activity-panel-pipe-id.end","time":1006},{"name":"activityTabFullyLoaded","time":1096.7999999523163}],"measures":[],"correlationId":"f6b319a7a8c897","effectiveType":"4g","downlink":9.2,"rtt":0,"serverDuration":75,"dbReadsTimeInMs":10,"dbConnsTimeInMs":17,"applicationHash":"9d11dbea5f4be3d4cc21f03a88dd11d8c8687422","experiments":[]}}