[MDEV-16769] Notes "WSREP: Waiting for SST to complete" flood the error log Created: 2018-07-17  Updated: 2018-07-18  Resolved: 2018-07-18

Status: Closed
Project: MariaDB Server
Component/s: Galera SST, wsrep
Affects Version/s: 10.1, 10.3.8, 10.2, 10.3
Fix Version/s: 10.1.35, 10.2.17, 10.3.9

Type: Bug Priority: Blocker
Reporter: Elena Stepanova Assignee: Jan Lindström (Inactive)
Resolution: Fixed Votes: 0
Labels: None


 Description   

10.2

 
perl ./mtr galera.galera_sst_xtrabackup-v2
 
...
 
worker[1] mysql-test-run: WARNING: Too much log from test, bailing out from extracting
 
...
 
2018-07-17 12:13:50 140568815324032 [Note] WSREP: SST complete, seqno: 0
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 10 secs.
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 20 secs.
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 30 secs.
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 40 secs.
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 50 secs.
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 60 secs.
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 70 secs.
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 80 secs.
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 90 secs.
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 100 secs.
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 110 secs.
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 120 secs.
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 130 secs.
 
...
 
2018-07-17 12:13:50 140568645232384 [Note] WSREP: Waiting for SST to complete. waited 868440 secs.

Thus, it writes about 87,000 lines in one second.

According to serg's code check, the problem is present in 10.1, 10.2, 10.3.

 Comments   
Comment by Jan Lindström (Inactive) [ 2018-07-18 ] 

jan@jan-laptop-asus:~/mysql/10.1-galera/mysql-test$ perl ./mtr galera.galera_sst_xtrabackup-v2 --mysqld=--wsrep-debug=ON
 
Logging: ./mtr  galera.galera_sst_xtrabackup-v2 --mysqld=--wsrep-debug=ON
 
vardir: /home/jan/mysql/10.1-galera/mysql-test/var
 
Checking leftover processes...
 
Removing old var directory...
 
Creating var directory '/home/jan/mysql/10.1-galera/mysql-test/var'...
 
Checking supported features...
 
MariaDB Version 10.1.35-MariaDB-debug
 
 - SSL connections supported
 
 - binaries are debug compiled
 
Sphinx 'indexer' binary not found, sphinx suite will be skipped
 
Collecting tests...
 
sh: 1: ctest: not found
 
Installing system database...
 
 
 
==============================================================================
 
 
 
TEST                                      RESULT   TIME (ms) or COMMENT
 
--------------------------------------------------------------------------
 
 
 
worker[1] Using MTR_BUILD_THREAD 300, with reserved ports 16000..16019
 
galera.galera_sst_xtrabackup-v2 'debug,innodb_plugin' [ pass ]  120889
 
galera.galera_sst_xtrabackup-v2 'debug,xtradb' [ pass ]  123483
 
--------------------------------------------------------------------------
 
The servers were restarted 1 times
 
Spent 244.372 of 305 seconds executing testcases
 
 
 
Completed: All 2 tests were successful.

Most likely 1. time ever this test passes for me.

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