[MDEV-21728] galera.pxc-421 MTR failed: mysqld got signal 11 Created: 2020-02-13  Updated: 2020-04-15  Resolved: 2020-03-16

Status: Closed
Project: MariaDB Server
Component/s: Galera, Tests
Affects Version/s: 10.3.22
Fix Version/s: N/A

Type: Bug Priority: Critical
Reporter: Stepan Patryshev (Inactive) Assignee: Stepan Patryshev (Inactive)
Resolution: Cannot Reproduce Votes: 0
Labels: None
Environment:

TestTarball_2 sles-12


Issue Links:
Relates
relates to MDEV-15804 Test failure on galera.pxc-421 Closed

 Description   

galera.pxc-421 failed on CI: mysqld got signal 11.

stdio.log:

10.3.22-6 d17474880175e0c147923d997369b12220a0ddcc

2020-02-13T03:18:59.4600696Z galera.pxc-421 'innodb'                  w2 [ fail ]
2020-02-13T03:18:59.4602160Z         Test ended at 2020-02-13 03:18:59
2020-02-13T03:18:59.4602545Z 
2020-02-13T03:18:59.4603035Z CURRENT_TEST: galera.pxc-421
2020-02-13T03:18:59.4603670Z mysqltest: At line 27: query 'SET GLOBAL wsrep_provider='none'' failed: 2013: Lost connection to MySQL server during query
2020-02-13T03:18:59.4604012Z 
2020-02-13T03:18:59.4604315Z The result from queries just before the failure was:
2020-02-13T03:18:59.4604626Z connection node_1;
2020-02-13T03:18:59.4604921Z connection node_2;
2020-02-13T03:18:59.4605208Z connection node_1;
2020-02-13T03:18:59.4605482Z set GLOBAL wsrep_slave_threads=26;
2020-02-13T03:18:59.4605788Z CREATE TABLE t1 (f1 INTEGER) ENGINE=InnoDB;
2020-02-13T03:18:59.4606092Z INSERT INTO t1 VALUES (1);
2020-02-13T03:18:59.4606387Z INSERT INTO t1 (f1) SELECT * from t1 as x1;
2020-02-13T03:18:59.4606705Z connection node_2;
2020-02-13T03:18:59.4607041Z set GLOBAL wsrep_slave_threads=16;
2020-02-13T03:18:59.4607540Z SET GLOBAL wsrep_provider='none';
2020-02-13T03:18:59.4607843Z 
2020-02-13T03:18:59.4608079Z 
2020-02-13T03:18:59.4608601Z Server [mysqld.2 - pid: 77710, winpid: 77710, exit: 256] failed during test run
2020-02-13T03:18:59.4608953Z Server log from this test:
2020-02-13T03:18:59.4609434Z ----------SERVER LOG START-----------
2020-02-13T03:18:59.4609980Z 2020-02-13  3:18:58 20 [Note] WSREP: Stop replication
2020-02-13T03:18:59.4610528Z 2020-02-13  3:18:58 20 [Note] WSREP: Closing send monitor...
2020-02-13T03:18:59.4611080Z 2020-02-13  3:18:58 20 [Note] WSREP: Closed send monitor.
2020-02-13T03:18:59.4611783Z 2020-02-13  3:18:58 20 [Note] WSREP: gcomm: terminating thread
2020-02-13T03:18:59.4612202Z 2020-02-13  3:18:58 20 [Note] WSREP: gcomm: joining thread
2020-02-13T03:18:59.4612614Z 2020-02-13  3:18:58 20 [Note] WSREP: gcomm: closing backend
2020-02-13T03:18:59.4613071Z 2020-02-13  3:18:58 20 [Note] WSREP: view(view_id(NON_PRIM,572ab9f6,8) memb {
2020-02-13T03:18:59.4613498Z 	8cd33550,0
2020-02-13T03:18:59.4613727Z } joined {
2020-02-13T03:18:59.4613945Z } left {
2020-02-13T03:18:59.4614164Z } partitioned {
2020-02-13T03:18:59.4614384Z 	572ab9f6,0
2020-02-13T03:18:59.4614586Z })
2020-02-13T03:18:59.4614971Z 2020-02-13  3:18:58 20 [Note] WSREP: view((empty))
2020-02-13T03:18:59.4615384Z 2020-02-13  3:18:58 20 [Note] WSREP: gcomm: closed
2020-02-13T03:18:59.4615895Z 2020-02-13  3:18:58 0 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
2020-02-13T03:18:59.4616874Z 2020-02-13  3:18:58 0 [Note] WSREP: Flow-control interval: [16, 16]
2020-02-13T03:18:59.4617237Z 2020-02-13  3:18:58 0 [Note] WSREP: Trying to continue unpaused monitor
2020-02-13T03:18:59.4617611Z 2020-02-13  3:18:58 0 [Note] WSREP: Received NON-PRIMARY.
2020-02-13T03:18:59.4617937Z 2020-02-13  3:18:58 0 [Note] WSREP: Shifting SYNCED -> OPEN (TO: 108)
2020-02-13T03:18:59.4618283Z 2020-02-13  3:18:58 0 [Note] WSREP: Received self-leave message.
2020-02-13T03:18:59.4618626Z 2020-02-13  3:18:58 0 [Note] WSREP: Flow-control interval: [0, 0]
2020-02-13T03:18:59.4618966Z 2020-02-13  3:18:58 0 [Note] WSREP: Trying to continue unpaused monitor
2020-02-13T03:18:59.4619309Z 2020-02-13  3:18:58 0 [Note] WSREP: Received SELF-LEAVE. Closing connection.
2020-02-13T03:18:59.4619636Z 2020-02-13  3:18:58 0 [Note] WSREP: Shifting OPEN -> CLOSED (TO: 108)
2020-02-13T03:18:59.4619978Z 2020-02-13  3:18:58 0 [Note] WSREP: RECV thread exiting 0: Success
2020-02-13T03:18:59.4620432Z 2020-02-13  3:18:58 21 [Note] WSREP: New cluster view: global state: 572b2f1b-4e0f-11ea-be2f-eba2b466e35f:108, view# -1: non-Primary, number of nodes: 1, my index: 0, protocol version 3
2020-02-13T03:18:59.4620843Z 2020-02-13  3:18:58 21 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-02-13T03:18:59.4621308Z 2020-02-13  3:18:58 21 [Note] WSREP: New cluster view: global state: 572b2f1b-4e0f-11ea-be2f-eba2b466e35f:108, view# -1: non-Primary, number of nodes: 0, my index: -1, protocol version 3
2020-02-13T03:18:59.4621848Z 2020-02-13  3:18:58 21 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-02-13T03:18:59.4622190Z 2020-02-13  3:18:58 20 [Note] WSREP: recv_thread() joined.
2020-02-13T03:18:59.4622527Z 2020-02-13  3:18:58 20 [Note] WSREP: Closing replication queue.
2020-02-13T03:18:59.4622852Z 2020-02-13  3:18:58 20 [Note] WSREP: Closing slave action queue.
2020-02-13T03:18:59.4623194Z 2020-02-13  3:18:58 21 [Note] WSREP: applier thread exiting (code:0)
2020-02-13T03:18:59.4623556Z 2020-02-13  3:18:58 25 [ERROR] WSREP: async recv cannot start, provider in closed/closing state
2020-02-13T03:18:59.4623901Z 2020-02-13  3:18:58 25 [Note] WSREP: applier thread exiting (code:8)
2020-02-13T03:18:59.4624225Z 2020-02-13  3:18:58 25 [Note] WSREP: starting shutdown
2020-02-13T03:18:59.4624413Z 200213  3:18:58 [ERROR] mysqld got signal 11 ;
2020-02-13T03:18:59.4624594Z This could be because you hit a bug. It is also possible that this binary
2020-02-13T03:18:59.4624781Z or one of the libraries it was linked against is corrupt, improperly built,
2020-02-13T03:18:59.4624965Z or misconfigured. This error can also be caused by malfunctioning hardware.
2020-02-13T03:18:59.4625102Z 
2020-02-13T03:18:59.4625409Z To report this bug, see https://mariadb.com/kb/en/reporting-bugs
2020-02-13T03:18:59.4625562Z 
2020-02-13T03:18:59.4625707Z We will try our best to scrape up some info that will hopefully help
2020-02-13T03:18:59.4625885Z diagnose the problem, but since we have already crashed, 
2020-02-13T03:18:59.4626056Z something is definitely wrong and this may fail.
2020-02-13T03:18:59.4626196Z 
2020-02-13T03:18:59.4626469Z Server version: 10.3.22-6-MariaDB-enterprise-log
2020-02-13T03:18:59.4626640Z key_buffer_size=1048576
2020-02-13T03:18:59.4626797Z read_buffer_size=131072
2020-02-13T03:18:59.4626949Z max_used_connections=1
2020-02-13T03:18:59.4627097Z max_threads=153
2020-02-13T03:18:59.4627258Z thread_count=23
2020-02-13T03:18:59.4627410Z It is possible that mysqld could use up to 
2020-02-13T03:18:59.4627660Z key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 63224 K  bytes of memory
2020-02-13T03:18:59.4627988Z Hope that's ok; if not, decrease some variables in the equation.
2020-02-13T03:18:59.4628149Z 
2020-02-13T03:18:59.4628300Z Thread pointer: 0x7ff5e4026448
2020-02-13T03:18:59.4628457Z Attempting backtrace. You can use the following information to find out
2020-02-13T03:18:59.4628640Z where mysqld died. If you see no messages after this, something went
2020-02-13T03:18:59.4628808Z terribly wrong...
2020-02-13T03:18:59.4629165Z 2020-02-13  3:18:58 32 [ERROR] WSREP: async recv cannot start, provider in closed/closing state
2020-02-13T03:18:59.4629513Z 2020-02-13  3:18:58 32 [Note] WSREP: applier thread exiting (code:8)
2020-02-13T03:18:59.4629841Z 2020-02-13  3:18:58 32 [Note] WSREP: starting shutdown
2020-02-13T03:18:59.4630131Z ----------SERVER LOG END-------------
2020-02-13T03:18:59.4630291Z 
2020-02-13T03:18:59.4630402Z 
2020-02-13T03:18:59.4632895Z  - saving '/var/tmp/mtr/2/log/galera.pxc-421-innodb/' to '/var/tmp/mtr/log/galera.pxc-421-innodb/'
2020-02-13T03:18:59.4846386Z ***Warnings generated in error logs during shutdown after running tests: galera.mysql-wsrep#90 galera.pxc-421 galera.mysql-wsrep#332
2020-02-13T03:18:59.4846884Z 
2020-02-13T03:18:59.4847431Z 2020-02-13  3:18:58 25 [ERROR] WSREP: async recv cannot start, provider in closed/closing state
2020-02-13T03:18:59.4847727Z 200213  3:18:58 [ERROR] mysqld got signal 11 ;
2020-02-13T03:18:59.4847991Z Attempting backtrace. You can use the following information to find out
2020-02-13T03:18:59.4848521Z 2020-02-13  3:18:58 32 [ERROR] WSREP: async recv cannot start, provider in closed/closing state



 Comments   
Comment by Stepan Patryshev (Inactive) [ 2020-03-16 ]

Closing since it does not fail on CI.

Generated at Thu Feb 08 09:09:21 UTC 2024 using Jira 8.20.16#820016-sha1:9d11dbea5f4be3d4cc21f03a88dd11d8c8687422.