Cannot join second node to new cluster WSREP: Application received wrong state

May 25 16:43:19 node02 systemd[1]: Starting MariaDB 10.6.8 database server...

May 25 16:43:20 node02 sh[34993]: WSREP: Recovered position 00000000-0000-0000-0000-000000000000:-1

May 25 16:43:20 node02 mariadbd[35259]: 2022-05-25 16:43:20 0 [Note] /usr/sbin/mariadbd (server 10.6.8-MariaDB-1:10.6.8+maria~focal-log) starting as process 35259 ...

May 25 16:43:20 node02 mariadbd[35259]: 2022-05-25 16:43:20 0 [Warning] Could not increase number of max_open_files to more than 196608 (request: 1048851)

May 25 16:43:20 node02 mariadbd[35259]: 2022-05-25 16:43:20 0 [Note] WSREP: Loading provider /usr/lib/galera/libgalera_smm.so initial position: 00000000-0000-0000-0000-000000000000:-1

May 25 16:43:20 node02 mariadbd[35259]: 2022-05-25 16:43:20 0 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib/galera/libgalera_smm.so'

May 25 16:43:20 node02 mariadbd[35259]: 2022-05-25 16:43:20 0 [Note] WSREP: wsrep_load(): Galera 26.4.11(r67341d07) by Codership Oy <info@codership.com> loaded successfully.

May 25 16:43:20 node02 mariadbd[35259]: 2022-05-25 16:43:20 0 [Note] WSREP: CRC-32C: using "slicing-by-8" algorithm.

May 25 16:43:20 node02 mariadbd[35259]: 2022-05-25 16:43:20 0 [Note] WSREP: SSL cipher list set to 'TLS-AES-256-GCM-SHA384:TLS-CHACHA20-POLY1305-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:DHE-RSA-AES256-GCM-SHA384:DHE-RSA-CHACHA20-POLY1305'

May 25 16:43:20 node02 mariadbd[35259]: 2022-05-25 16:43:20 0 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1, safe_to_bootstrap: 1

May 25 16:43:20 node02 mariadbd[35259]: 2022-05-25 16:43:20 0 [Note] WSREP: GCache DEBUG: opened preamble:

May 25 16:43:20 node02 mariadbd[35259]: Version: 2

May 25 16:43:20 node02 mariadbd[35259]: UUID: 49eb1ff3-dc36-11ec-9725-6f6bb4d72609

May 25 16:43:20 node02 mariadbd[35259]: Seqno: -1 - -1

May 25 16:43:20 node02 mariadbd[35259]: Offset: -1

May 25 16:43:20 node02 mariadbd[35259]: Synced: 0

May 25 16:43:20 node02 mariadbd[35259]: 2022-05-25 16:43:20 0 [Note] WSREP: Recovering GCache ring buffer: version: 2, UUID: 49eb1ff3-dc36-11ec-9725-6f6bb4d72609, offset: -1

May 25 16:43:20 node02 mariadbd[35259]: 2022-05-25 16:43:20 0 [Note] WSREP: GCache::RingBuffer initial scan...  0.0% (         0/1073741848 bytes) complete.

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: GCache::RingBuffer initial scan...100.0% (1073741848/1073741848 bytes) complete.

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: Recovering GCache ring buffer: didn't recover any events.

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Warning] WSREP: Option 'gcs.fc_master_slave' is deprecated and will be removed in the future versions, please use 'gcs.fc_single_primary' instead.

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = 10.96.53.2; base_port = 4567; cert.log_conflicts = no; cert.optimistic_pa = yes; debug = no; evs.auto_evict = 0; evs.delay_margin = PT1S; evs.delayed_keep_period = PT30S; evs.inactive_check_period = PT0.5S; evs.inactive_timeout = PT15S; evs.join_retrans_period = PT1S; evs.max_install_timeouts = 3; evs.send_window = 4; evs.stats_report_period = PT1M; evs.suspect_timeout = PT5S; evs.user_send_window = 2; evs.view_forget_timeout = PT24H; gcache.dir = /var/lib/mysql/; gcache.keep_pages_size = 0; gcache.keep_plaintext_size = 128M; gcache.mem_size = 0; gcache.name = galera.cache; gcache.page_size = 128M; gcache.recover = yes; gcache.size = 1G; gcomm.thread_prio = ; gcs.fc_debug = 0; gcs.fc_factor = 0.8; gcs.fc_limit = 20; gcs.fc_master_slave = no; gcs.fc_single_primary = no; gcs.max_packet_size = 64500; gcs.max_throttle = 0.25; gcs.recv_q_hard_limit = 9223372036854775807; gcs.recv_q_soft_limit = 0.25; gcs.sync_donor = no; gmcast.segment = 0; gmc

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: SSL cipher list set to 'TLS-AES-256-GCM-SHA384:TLS-CHACHA20-POLY1305-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:DHE-RSA-AES256-GCM-SHA384:DHE-RSA-CHACHA20-POLY1305'

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: Start replication

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: Connecting with bootstrap option: 0

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: Setting GCS initial position to 00000000-0000-0000-0000-000000000000:-1

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: protonet asio version 0

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: SSL cipher list set to 'TLS-AES-256-GCM-SHA384:TLS-CHACHA20-POLY1305-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:DHE-RSA-AES256-GCM-SHA384:DHE-RSA-CHACHA20-POLY1305'

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: Using CRC-32C for message checksums.

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: backend: asio

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: gcomm thread scheduling priority set to other:0

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: restore pc from disk failed

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: GMCast version 0

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: (05ff94b4-a70a, 'ssl://0.0.0.0:4567') listening at ssl://0.0.0.0:4567

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: (05ff94b4-a70a, 'ssl://0.0.0.0:4567') multicast: , ttl: 1

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: EVS version 1

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: gcomm: connecting to group 'mariadb-cluster', peer 'node01:,node02:,arbitrator:'

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: (05ff94b4-a70a, 'ssl://0.0.0.0:4567') Found matching local endpoint for a connection, blacklisting address ssl://10.96.53.2:4567

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: (05ff94b4-a70a, 'ssl://0.0.0.0:4567') connection established to a309b137-b3df ssl://10.96.53.0:4567

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: (05ff94b4-a70a, 'ssl://0.0.0.0:4567') turning message relay requesting on, nonlive peers:

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: (05ff94b4-a70a, 'ssl://0.0.0.0:4567') connection established to 49e62ffd-8229 ssl://10.96.53.1:4567

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: EVS version upgrade 0 -> 1

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: declaring 49e62ffd-8229 at ssl://10.96.53.1:4567 stable

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: declaring a309b137-b3df at ssl://10.96.53.0:4567 stable

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: PC protocol upgrade 0 -> 1

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: Node 49e62ffd-8229 state prim

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: view(view_id(PRIM,05ff94b4-a70a,17) memb {

May 25 16:43:21 node02 mariadbd[35259]: #01105ff94b4-a70a,0

May 25 16:43:21 node02 mariadbd[35259]: #01149e62ffd-8229,0

May 25 16:43:21 node02 mariadbd[35259]: #011a309b137-b3df,0

May 25 16:43:21 node02 mariadbd[35259]: } joined {

May 25 16:43:21 node02 mariadbd[35259]: } left {

May 25 16:43:21 node02 mariadbd[35259]: } partitioned {

May 25 16:43:21 node02 mariadbd[35259]: })

May 25 16:43:21 node02 mariadbd[35259]: 2022-05-25 16:43:21 0 [Note] WSREP: save pc into disk

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: gcomm: connected

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: Opened channel 'mariadb-cluster'

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 3

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 069a76f5-dc39-11ec-9c6e-2fed0bf25da7

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 2 [Note] WSREP: Starting rollbacker thread 2

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 1 [Note] WSREP: Starting applier thread 1

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: STATE EXCHANGE: sent state msg: 069a76f5-dc39-11ec-9c6e-2fed0bf25da7

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: STATE EXCHANGE: got state msg: 069a76f5-dc39-11ec-9c6e-2fed0bf25da7 from 0 (node02)

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: STATE EXCHANGE: got state msg: 069a76f5-dc39-11ec-9c6e-2fed0bf25da7 from 1 (node01)

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: STATE EXCHANGE: got state msg: 069a76f5-dc39-11ec-9c6e-2fed0bf25da7 from 2 (garb)

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: Quorum results:

May 25 16:43:22 node02 mariadbd[35259]: #011version    = 6,

May 25 16:43:22 node02 mariadbd[35259]: #011component  = PRIMARY,

May 25 16:43:22 node02 mariadbd[35259]: #011conf_id    = 16,

May 25 16:43:22 node02 mariadbd[35259]: #011members    = 2/3 (joined/total),

May 25 16:43:22 node02 mariadbd[35259]: #011act_id     = 16,

May 25 16:43:22 node02 mariadbd[35259]: #011last_appl. = 0,

May 25 16:43:22 node02 mariadbd[35259]: #011protocols  = 2/10/4 (gcs/repl/appl),

May 25 16:43:22 node02 mariadbd[35259]: #011vote policy= 0,

May 25 16:43:22 node02 mariadbd[35259]: #011group UUID = 49eb1ff3-dc36-11ec-9725-6f6bb4d72609

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: Flow-control interval: [28, 35]

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: Shifting OPEN -> PRIMARY (TO: 17)

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 1 [Note] WSREP: ####### processing CC 17, local, ordered

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 1 [Note] WSREP: Process first view: 49eb1ff3-dc36-11ec-9725-6f6bb4d72609 my uuid: 05ff94b4-dc39-11ec-a70a-67bf409317a6

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 1 [Note] WSREP: Server node02 connected to cluster at position 49eb1ff3-dc36-11ec-9725-6f6bb4d72609:17 with ID 05ff94b4-dc39-11ec-a70a-67bf409317a6

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 1 [Note] WSREP: Server status change disconnected -> connected

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 1 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 1 [Note] WSREP: ####### My UUID: 05ff94b4-dc39-11ec-a70a-67bf409317a6

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 1 [Note] WSREP: Cert index reset to 00000000-0000-0000-0000-000000000000:-1 (proto: 10), state transfer needed: yes

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: Service thread queue flushed.

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 1 [Note] WSREP: ####### Assign initial position for certification: 00000000-0000-0000-0000-000000000000:-1, protocol version: -1

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 1 [Note] WSREP: State transfer required:

May 25 16:43:22 node02 mariadbd[35259]: #011Group state: 49eb1ff3-dc36-11ec-9725-6f6bb4d72609:17

May 25 16:43:22 node02 mariadbd[35259]: #011Local state: 00000000-0000-0000-0000-000000000000:-1

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 1 [Note] WSREP: Server status change connected -> joiner

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 1 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: Joiner monitor thread started to monitor

May 25 16:43:22 node02 mariadbd[35259]: 2022-05-25 16:43:22 0 [Note] WSREP: Running: 'wsrep_sst_mariabackup --role 'joiner' --address '10.96.53.2' --datadir '/var/lib/mysql/' --parent '35259' --binlog '/var/log/mysql/mysql-bin' --binlog-index '/var/log/mysql/mariadb-bin.index' --mysqld-args --wsrep_start_position=00000000-0000-0000-0000-000000000000:-1'

May 25 16:43:22 node02 mariadbd[35270]: WSREP_SST: [INFO] mariabackup SST started on joiner (20220525 16:43:22.481)

May 25 16:43:22 node02 mariadbd[35270]: WSREP_SST: [INFO] SSL configuration: CA='/etc/mysql/ssl/root.rsa.crt', CAPATH='', CERT='/etc/mysql/ssl/server.rsa.crt', KEY='/etc/mysql/ssl/server.rsa.key', MODE='DISABLED', encrypt='4' (20220525 16:43:22.706)

May 25 16:43:22 node02 mariadbd[35270]: WSREP_SST: [INFO] Logging all stderr of SST/mariabackup to syslog (20220525 16:43:22.972)

May 25 16:43:22 node02 -wsrep-sst-joiner: Streaming with mbstream

May 25 16:43:22 node02 -wsrep-sst-joiner: Using socat as streamer

May 25 16:43:22 node02 -wsrep-sst-joiner: Using openssl based encryption with socat: with key and crt

May 25 16:43:23 node02 -wsrep-sst-joiner: Decrypting with cert='/etc/mysql/ssl/server.rsa.crt', key='/etc/mysql/ssl/server.rsa.key', ca='/etc/mysql/ssl/root.rsa.crt', capath=''

May 25 16:43:23 node02 -wsrep-sst-joiner: Evaluating timeout -k 310 300 socat -u openssl-listen:4444,reuseaddr,cert='/etc/mysql/ssl/server.rsa.crt',key='/etc/mysql/ssl/server.rsa.key',cafile='/etc/mysql/ssl/root.rsa.crt',commonname='' stdio | '/usr//bin/mbstream' -x; RC=( ${PIPESTATUS[@]} )

May 25 16:43:23 node02 mariadbd[35259]: 2022-05-25 16:43:23 1 [Note] WSREP: ####### IST uuid:00000000-0000-0000-0000-000000000000 f: 0, l: 17, STRv: 3

May 25 16:43:23 node02 mariadbd[35259]: 2022-05-25 16:43:23 1 [Note] WSREP: IST receiver addr using ssl://10.96.53.2:4568

May 25 16:43:23 node02 mariadbd[35259]: 2022-05-25 16:43:23 1 [Note] WSREP: IST receiver using ssl

May 25 16:43:23 node02 mariadbd[35259]: 2022-05-25 16:43:23 1 [Note] WSREP: Prepared IST receiver for 0-17, listening at: ssl://10.96.53.2:4568

May 25 16:43:23 node02 mariadbd[35259]: 2022-05-25 16:43:23 0 [Note] WSREP: Member 0.0 (node02) requested state transfer from '*any*'. Selected 1.0 (node01)(SYNCED) as donor.

May 25 16:43:23 node02 mariadbd[35259]: 2022-05-25 16:43:23 0 [Note] WSREP: Shifting PRIMARY -> JOINER (TO: 17)

May 25 16:43:23 node02 mariadbd[35259]: 2022-05-25 16:43:23 1 [Note] WSREP: Requesting state transfer: success, donor: 1

May 25 16:43:23 node02 mariadbd[35259]: 2022-05-25 16:43:23 1 [Note] WSREP: Resetting GCache seqno map due to different histories.

May 25 16:43:23 node02 mariadbd[35259]: 2022-05-25 16:43:23 1 [Note] WSREP: GCache history reset: 49eb1ff3-dc36-11ec-9725-6f6bb4d72609:0 -> 49eb1ff3-dc36-11ec-9725-6f6bb4d72609:17

May 25 16:43:24 node02 -wsrep-sst-joiner: Proceeding with SST

May 25 16:43:24 node02 -wsrep-sst-joiner: Evaluating socat -u openssl-listen:4444,reuseaddr,cert='/etc/mysql/ssl/server.rsa.crt',key='/etc/mysql/ssl/server.rsa.key',cafile='/etc/mysql/ssl/root.rsa.crt',commonname='' stdio | '/usr//bin/mbstream' -x; RC=( ${PIPESTATUS[@]} )

May 25 16:43:24 node02 -wsrep-sst-joiner: Cleaning the old binary logs

May 25 16:43:24 node02 -wsrep-sst-joiner: Cleaning the binlog directory '/var/log/mysql' as well

May 25 16:43:24 node02 -wsrep-sst-joiner: Cleaning the existing datadir and innodb-data/log directories

May 25 16:43:24 node02 -wsrep-sst-joiner: Waiting for SST streaming to complete!

May 25 16:43:24 node02 mariadbd[35259]: 2022-05-25 16:43:24 0 [Note] WSREP: (05ff94b4-a70a, 'ssl://0.0.0.0:4567') turning message relay requesting off

May 25 16:43:31 node02 mysqld_exporter[549]: ts=2022-05-25T14:43:31.106Z caller=exporter.go:149 level=error msg="Error pinging mysqld" err="dial tcp 10.96.53.2:3306: connect: connection refused"

May 25 16:43:37 node02 mariadbd[35259]: 2022-05-25 16:43:37 0 [Note] WSREP: 1.0 (node01): State transfer to 0.0 (node02) complete.

May 25 16:43:37 node02 mariadbd[35259]: 2022-05-25 16:43:37 0 [Note] WSREP: Member 1.0 (node01) synced with group.

May 25 16:43:37 node02 -wsrep-sst-joiner: Preparing the backup at /var/lib/mysql/.sst

May 25 16:43:37 node02 -wsrep-sst-joiner: Evaluating /usr//bin/mariabackup --prepare --no-version-check --log-bin='/var/log/mysql/mysql-bin' --target-dir='/var/lib/mysql/.sst' --datadir='/var/lib/mysql/.sst' --mysqld-args --log-bin-index='/var/log/mysql/mariadb-bin.index' '--wsrep_start_position=00000000-0000-0000-0000-000000000000:-1' 2>&1 | logger -p daemon.err -t -innobackupex-apply

May 25 16:43:37 node02 -innobackupex-apply: /usr//bin/mariabackup based on MariaDB server 10.6.8-MariaDB debian-linux-gnu (x86_64)

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 cd to /var/lib/mysql/.sst/

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 open files limit requested 0, set to 196608

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 Renaming ./mysql/wsrep_cluster.new to ./mysql/wsrep_cluster.ibd

May 25 16:43:37 node02 -innobackupex-apply: 

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 Renaming ./mysql/wsrep_cluster_members.new to ./mysql/wsrep_cluster_members.ibd

May 25 16:43:37 node02 -innobackupex-apply: 

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 Renaming ./mysql/wsrep_streaming_log.new to ./mysql/wsrep_streaming_log.ibd

May 25 16:43:37 node02 -innobackupex-apply: 

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 This target seems to be not prepared yet.

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 mariabackup: using the following InnoDB configuration for recovery:

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 innodb_data_home_dir = .

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 innodb_data_file_path = ibdata1:10M:autoextend

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 innodb_log_group_home_dir = .

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 InnoDB: Using Linux native AIO

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 Starting InnoDB instance for recovery.

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 mariabackup: Using 104857600 bytes for buffer pool (set by --use-memory parameter)

May 25 16:43:37 node02 -innobackupex-apply: 2022-05-25 16:43:37 0 [Note] InnoDB: Compressed tables use zlib 1.2.11

May 25 16:43:37 node02 -innobackupex-apply: 2022-05-25 16:43:37 0 [Note] InnoDB: Number of pools: 1

May 25 16:43:37 node02 -innobackupex-apply: 2022-05-25 16:43:37 0 [Note] InnoDB: Using generic crc32 instructions

May 25 16:43:37 node02 -innobackupex-apply: 2022-05-25 16:43:37 0 [Note] InnoDB: Using Linux native AIO

May 25 16:43:37 node02 -innobackupex-apply: 2022-05-25 16:43:37 0 [Note] InnoDB: Initializing buffer pool, total size = 104857600, chunk size = 104857600

May 25 16:43:37 node02 -innobackupex-apply: 2022-05-25 16:43:37 0 [Note] InnoDB: Completed initialization of buffer pool

May 25 16:43:37 node02 -innobackupex-apply: 2022-05-25 16:43:37 0 [Note] InnoDB: Starting crash recovery from checkpoint LSN=283172,283172

May 25 16:43:37 node02 systemd[1]: mariadb.service: Got notification message from PID 35901, but reception only permitted for main PID 35259

May 25 16:43:37 node02 -innobackupex-apply: 2022-05-25 16:43:37 0 [Note] InnoDB: Starting final batch to recover 44 pages from redo log.

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 Last binlog file , position 0

May 25 16:43:37 node02 -innobackupex-apply: [00] 2022-05-25 16:43:37 completed OK!

May 25 16:43:38 node02 -wsrep-sst-joiner: Moving binary logs to /var/log/mysql

May 25 16:43:38 node02 -wsrep-sst-joiner: Moving the backup to /var/lib/mysql

May 25 16:43:38 node02 -wsrep-sst-joiner: Evaluating /usr//bin/mariabackup --move-back --no-version-check --log-bin='/var/log/mysql/mysql-bin' --force-non-empty-directories --target-dir='/var/lib/mysql/.sst' --datadir='/var/lib/mysql' 2>&1 | logger -p daemon.err -t -innobackupex-move

May 25 16:43:38 node02 -innobackupex-move: /usr//bin/mariabackup based on MariaDB server 10.6.8-MariaDB debian-linux-gnu (x86_64)

May 25 16:43:38 node02 -innobackupex-move: [00] 2022-05-25 16:43:38 Error: Move file ibdata1 to /var/lib/mysql/./ibdata1 failed: Destination file exists

May 25 16:43:38 node02 -wsrep-sst-joiner: Move successful, removing /var/lib/mysql/.sst

May 25 16:43:38 node02 -wsrep-sst-joiner: SST magic file '/var/lib/mysql/xtrabackup_galera_info' not found/readable

May 25 16:43:38 node02 -wsrep-sst-joiner: Cleanup after exit with status: 2

May 25 16:43:38 node02 -wsrep-sst-joiner: Removing /var/lib/mysql/xtrabackup_galera_info file due to signal

May 25 16:43:38 node02 -wsrep-sst-joiner: Removing the sst_in_progress file

May 25 16:43:38 node02 -wsrep-sst-joiner: Cleaning up temporary directories

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 0 [ERROR] WSREP: Process completed with error: wsrep_sst_mariabackup --role 'joiner' --address '10.96.53.2' --datadir '/var/lib/mysql/' --parent '35259' --binlog '/var/log/mysql/mysql-bin' --binlog-index '/var/log/mysql/mariadb-bin.index' --mysqld-args --wsrep_start_position=00000000-0000-0000-0000-000000000000:-1: 2 (No such file or directory)

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 0 [ERROR] WSREP: Failed to read uuid:seqno and wsrep_gtid_domain_id from joiner script.

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 3 [Note] WSREP: SST received

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 3 [Note] WSREP: SST received: 00000000-0000-0000-0000-000000000000:-1

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 3 [Note] WSREP: SST succeeded for position 00000000-0000-0000-0000-000000000000:-1

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 0 [Note] WSREP: Joiner monitor thread ended with total time 16 sec

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [ERROR] WSREP: Application received wrong state:

May 25 16:43:38 node02 mariadbd[35259]: #011Received: 00000000-0000-0000-0000-000000000000

May 25 16:43:38 node02 mariadbd[35259]: #011Required: 49eb1ff3-dc36-11ec-9725-6f6bb4d72609

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [ERROR] WSREP: Application state transfer failed. This is unrecoverable condition, restart required.

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: ReplicatorSMM::abort()

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: Closing send monitor...

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: Closed send monitor.

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: gcomm: terminating thread

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: gcomm: joining thread

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: gcomm: closing backend

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: view(view_id(NON_PRIM,05ff94b4-a70a,17) memb {

May 25 16:43:38 node02 mariadbd[35259]: #01105ff94b4-a70a,0

May 25 16:43:38 node02 mariadbd[35259]: } joined {

May 25 16:43:38 node02 mariadbd[35259]: } left {

May 25 16:43:38 node02 mariadbd[35259]: } partitioned {

May 25 16:43:38 node02 mariadbd[35259]: #01149e62ffd-8229,0

May 25 16:43:38 node02 mariadbd[35259]: #011a309b137-b3df,0

May 25 16:43:38 node02 mariadbd[35259]: })

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: PC protocol downgrade 1 -> 0

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: view((empty))

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: gcomm: closed

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 0 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 0 [Note] WSREP: Flow-control interval: [16, 20]

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 0 [Note] WSREP: Received NON-PRIMARY.

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 0 [Note] WSREP: Shifting JOINER -> OPEN (TO: 17)

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 0 [Note] WSREP: New SELF-LEAVE.

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 0 [Note] WSREP: Flow-control interval: [0, 0]

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 0 [Note] WSREP: Received SELF-LEAVE. Closing connection.

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 0 [Note] WSREP: Shifting OPEN -> CLOSED (TO: 17)

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 0 [Note] WSREP: RECV thread exiting 0: Success

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: recv_thread() joined.

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: Closing replication queue.

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: Closing slave action queue.

May 25 16:43:38 node02 mariadbd[35259]: 2022-05-25 16:43:38 1 [Note] WSREP: /usr/sbin/mariadbd: Terminated.

May 25 16:43:38 node02 systemd[1]: mariadb.service: Main process exited, code=killed, status=6/ABRT

May 25 16:43:38 node02 systemd[1]: mariadb.service: Failed with result 'signal'.

May 25 16:43:38 node02 systemd[1]: Failed to start MariaDB 10.6.8 database server.