Details
-
Bug
-
Status: Closed (View Workflow)
-
Major
-
Resolution: Won't Fix
-
10.2
-
None
Description
http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/27314/steps/mtr_nm/logs/stdio
10.2 545cba13eb4e013363a1267 |
rpl.rpl_row_img_eng_min 'innodb,row' w3 [ fail ]
|
|
CURRENT_TEST: rpl.rpl_row_img_eng_min
|
mysqltest: In included file "./include/rpl_row_img_general_loop.inc":
|
included from /mnt/buildbot/build/mariadb-10.2.38/mysql-test/suite/rpl/t/rpl_row_img_eng_min.test at line 34:
|
At line 36: query 'SET SQL_LOG_BIN=0' failed: 2013: Lost connection to MySQL server during query
|
|
The result from queries just before the failure was:
|
< snip >
|
UPDATE t SET c1 = '8' WHERE c2 = '4';
|
UPDATE t SET c2 = '8' WHERE c2 = '4';
|
UPDATE t SET c3 = '0' WHERE c4 = NULL;
|
UPDATE t SET c2 = '0' WHERE c4 = '0';
|
UPDATE t SET c2 = '2' WHERE c4 = '2';
|
include/rpl_sync.inc
|
include/diff_tables.inc [server_1:test.t, server_2:test.t, server_3:test.t]
|
connection server_1;
|
DELETE FROM t WHERE c1 = 7;
|
DELETE FROM t WHERE c1 = 8;
|
DELETE FROM t;
|
include/rpl_sync.inc
|
include/diff_tables.inc [server_1:test.t, server_2:test.t, server_3:test.t]
|
connection server_1;
|
DROP TABLE t;
|
include/rpl_sync.inc
|
connection server_1;
|
SET SQL_LOG_BIN=0;
|
connection server_2;
|
SET SQL_LOG_BIN=0;
|
|
More results from queries before failure can be found in /mnt/buildbot/build/mariadb-10.2.38/mysql-test/var/3/log/rpl_row_img_eng_min.log
|
|
|
Server [mysqld.2 - pid: 27257, winpid: 27257, exit: 1280] failed during test run
|
Server log from this test:
|
----------SERVER LOG START-----------
|
2021-03-05 4:54:50 3068512192 [Note] /mnt/buildbot/build/mariadb-10.2.38/sql/mysqld (mysqld 10.2.38-MariaDB-debug-log) starting as process 27261 ...
|
2021-03-05 4:54:50 3068512192 [Warning] Could not increase number of max_open_files to more than 1024 (request: 32186)
|
2021-03-05 4:54:50 3068512192 [Warning] Changed limits: max_open_files: 1024 max_connections: 151 (was 151) table_cache: 421 (was 2000)
|
2021-03-05 4:54:50 3068512192 [Note] Plugin 'SEQUENCE' is disabled.
|
2021-03-05 4:54:50 3068512192 [Note] Plugin 'partition' is disabled.
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: Uses event mutexes
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: Compressed tables use zlib 1.2.8
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: Using Linux native AIO
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: Number of pools: 1
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: Using generic crc32 instructions
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: Initializing buffer pool, total size = 8M, instances = 1, chunk size = 8M
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: Completed initialization of buffer pool
|
2021-03-05 4:54:50 2902190912 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: Highest supported file format is Barracuda.
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: 128 out of 128 rollback segments are active.
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: Creating shared tablespace for temporary tables
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
|
2021-03-05 4:54:50 3068512192 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
|
2021-03-05 4:54:51 3068512192 [Note] InnoDB: Waiting for purge to start
|
2021-03-05 4:54:51 3068512192 [Note] InnoDB: 5.7.33 started; log sequence number 1628778
|
2021-03-05 4:54:51 2799688512 [Note] InnoDB: Loading buffer pool(s) from /dev/shm/var_auto_LlrT/3/mysqld.2/data/ib_buffer_pool
|
2021-03-05 4:54:51 2799688512 [Note] InnoDB: Buffer pool(s) load completed at 210305 4:54:51
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_CMP' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'FEEDBACK' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'user_variables' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_MUTEXES' is disabled.
|
2021-03-05 4:54:51 3068512192 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
|
2021-03-05 4:54:51 3068512192 [Warning] /mnt/buildbot/build/mariadb-10.2.38/sql/mysqld: unknown option '--loose-pam-debug'
|
2021-03-05 4:54:51 3068512192 [Note] Server socket created on IP: '127.0.0.1'.
|
2021-03-05 4:54:51 3068512192 [Note] Reading of all Master_info entries succeeded
|
2021-03-05 4:54:51 3068512192 [Note] Added new Master_info '' to hash table
|
2021-03-05 4:54:51 3068512192 [Note] /mnt/buildbot/build/mariadb-10.2.38/sql/mysqld: ready for connections.
|
Version: '10.2.38-MariaDB-debug-log' socket: '/mnt/buildbot/build/mariadb-10.2.38/mysql-test/var/tmp/3/mysqld.2.sock' port: 16041 Source distribution
|
2021-03-05 4:54:53 2893495104 [Note] Deleted Master_info file '/mnt/buildbot/build/mariadb-10.2.38/mysql-test/var/3/mysqld.2/data/master.info'.
|
2021-03-05 4:54:53 2893495104 [Note] Deleted Master_info file '/mnt/buildbot/build/mariadb-10.2.38/mysql-test/var/3/mysqld.2/data/relay-log.info'.
|
2021-03-05 4:54:53 2893495104 [Note] Master connection name: '' Master_info_file: 'master.info' Relay_info_file: 'relay-log.info'
|
2021-03-05 4:54:53 2893495104 [Note] 'CHANGE MASTER TO executed'. Previous state master_host='', master_port='3306', master_log_file='', master_log_pos='4'. New state master_host='127.0.0.1', master_port='16040', master_log_file='master-bin.000001', master_log_pos='4'.
|
2021-03-05 4:54:53 2830801728 [Note] Start binlog_dump to slave_server(3), pos(master-bin.000001, 4), using_gtid(0), gtid('')
|
2021-03-05 4:54:54 2820664128 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 4, relay log './mysqld-relay-bin.000001' position: 4
|
2021-03-05 4:54:54 2830498624 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16040',replication started in log 'master-bin.000001' at position 4
|
2021-03-05 4:54:54 2820664128 [Note] Error reading relay log event: slave SQL thread was killed
|
2021-03-05 4:54:54 2820664128 [Note] Slave SQL thread exiting, replication stopped in log 'master-bin.000001' at position 450
|
2021-03-05 4:54:54 2820664128 [Note] master was 127.0.0.1:16040
|
2021-03-05 4:54:54 2830498624 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 450
|
2021-03-05 4:54:54 2830498624 [Note] master was 127.0.0.1:16040
|
2021-03-05 4:54:54 2830498624 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 450, relay log './mysqld-relay-bin.000002' position: 750
|
2021-03-05 4:54:54 2820664128 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16040',replication started in log 'master-bin.000001' at position 450
|
2021-03-05 4:54:54 2820361024 [Note] Start binlog_dump to slave_server(3), pos(master-bin.000001, 571), using_gtid(0), gtid('')
|
----------SERVER LOG END-------------
|
|
|
- skipping '/mnt/buildbot/build/mariadb-10.2.38/mysql-test/var/3/log/rpl.rpl_row_img_eng_min-innodb,row/'
|
|
Retrying test rpl.rpl_row_img_eng_min, attempt(2/3)...
|
|
***Warnings generated in error logs during shutdown after running tests: rpl.rpl_parallel rpl.rpl_old_master
|
|
2021-03-05 4:39:12 2953296704 [Warning] Unsafe statement written to the binary log using statement format since BINLOG_FORMAT = STATEMENT. Statement is unsafe because it accesses a non-transactional table after accessing a transactional table within the same transaction Statement: INSERT INTO t1 VALUES (20)
|
Attempting backtrace. You can use the following information to find out
|
2021-03-05 4:39:13 2765511488 [Warning] Slave: Connection was killed Error_code: 1927
|
2021-03-05 4:39:13 2764045120 [Warning] Slave: Commit failed due to failure of an earlier commit on which this one depends Error_code: 1964
|
2021-03-05 4:39:14 2818566976 [Warning] Slave: Connection was killed Error_code: 1927
|
2021-03-05 4:39:14 2764045120 [Warning] Slave: Commit failed due to failure of an earlier commit on which this one depends Error_code: 1964
|
2021-03-05 4:39:15 2763742016 [Warning] Slave: Connection was killed Error_code: 1927
|
2021-03-05 4:39:15 2818263872 [Warning] Slave: Commit failed due to failure of an earlier commit on which this one depends Error_code: 1964
|
Attempting backtrace. You can use the following information to find out
|