safespring-community / nextcloud-db

Repository for galera cluster and proxySQL for the Nextcloud-project

nextcloud-db

Repository for galera cluster and proxySQL for the Nextcloud-project

nextcloud-db's Issues

Incorrect option -d for docker-compose down

Option -d for docker-compose down command is not supported.

Access denied during join

I was following the Docker Compose instruction

I did step 0 on all 3 nodes.

Then step 1 on db1 with my approach to fix bootstrap (issue #1)

Logs from db1 (bootstrap):

ubuntu@nx4-db--1:~/nextcloud-db/mariadb/compose$ docker logs compose_nextcloud-mariadb_1
2020-10-01 15:50:24+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 1:10.5.5+maria~focal started.
2020-10-01 15:50:24+00:00 [Note] [Entrypoint]: Checking MySQL configuration variables..
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: Checking the Docker setup environment..
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: Creating database directories..
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: Switching to dedicated user 'mysql'
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 1:10.5.5+maria~focal started.
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: Checking MySQL configuration variables..
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: Checking the Docker setup environment..
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: Creating database directories..
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: BOOTSTRAP=1, trying to bootstrap the server instead of starting it
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: FORCE_BOOTSTRAP=1, thus checking the content of /var/lib/mysql/grastate.dat
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: # GALERA saved state
version: 2.1
uuid:    d0fd43db-03f8-11eb-b1e5-7f6e05fd8840
seqno:   -1
safe_to_bootstrap: 0
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: Safe_to_bootstrap is set to 0. Will reset this to 1.
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: Variables to pass to MariaDB: mysqld --wsrep_cluster_address=gcomm:// 
2020-10-01 15:50:25+00:00 [Note] [Entrypoint]: Bootstrapping the server
2020-10-01 15:50:25 0 [Note] mysqld (mysqld 10.5.5-MariaDB-1:10.5.5+maria~focal-log) starting as process 1 ...
2020-10-01 15:50:25 0 [Note] WSREP: Loading provider /usr/lib/galera/libgalera_smm.so initial position: 00000000-0000-0000-0000-000000000000:-1
2020-10-01 15:50:25 0 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib/galera/libgalera_smm.so'
2020-10-01 15:50:25 0 [Note] WSREP: wsrep_load(): Galera 26.4.5(rb3764ab6) by Codership Oy <[email protected]> loaded successfully.
2020-10-01 15:50:25 0 [Note] WSREP: CRC-32C: using hardware acceleration.
2020-10-01 15:50:25 0 [Note] WSREP: Found saved state: d0fd43db-03f8-11eb-b1e5-7f6e05fd8840:-1, safe_to_bootstrap: 1
2020-10-01 15:50:25 0 [Note] WSREP: GCache DEBUG: opened preamble:
Version: 2
UUID: d0fd43db-03f8-11eb-b1e5-7f6e05fd8840
Seqno: -1 - -1
Offset: -1
Synced: 0
2020-10-01 15:50:25 0 [Note] WSREP: Recovering GCache ring buffer: version: 2, UUID: d0fd43db-03f8-11eb-b1e5-7f6e05fd8840, offset: -1
2020-10-01 15:50:25 0 [Note] WSREP: GCache::RingBuffer initial scan...  0.0% (         0/2147483672 bytes) complete.
2020-10-01 15:50:25 0 [Note] WSREP: GCache::RingBuffer initial scan...100.0% (2147483672/2147483672 bytes) complete.
2020-10-01 15:50:25 0 [Note] WSREP: Recovering GCache ring buffer: found gapless sequence 1-30
2020-10-01 15:50:25 0 [Note] WSREP: GCache::RingBuffer unused buffers scan...  0.0% (    0/10800 bytes) complete.
2020-10-01 15:50:25 0 [Note] WSREP: GCache::RingBuffer unused buffers scan...100.0% (10800/10800 bytes) complete.
2020-10-01 15:50:25 0 [Note] WSREP: GCache DEBUG: RingBuffer::recover(): found 28/58 locked buffers
2020-10-01 15:50:25 0 [Note] WSREP: GCache DEBUG: RingBuffer::recover(): free space: 2147478000/2147483648
2020-10-01 15:50:25 0 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = 89.45.236.31; 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.mem_size = 0; gcache.name = galera.cache; gcache.page_size = 128M; gcache.recover = yes; gcache.size = 2G; gcomm.thread_prio = ; gcs.fc_debug = 0; gcs.fc_factor = 1.0; gcs.fc_limit = 16; gcs.fc_master_slave = 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; gmcast.version = 0; pc.announce_timeout = PT3S; pc.checksum = fa
2020-10-01 15:50:25 0 [Note] WSREP: Start replication
2020-10-01 15:50:25 0 [Note] WSREP: Connecting with bootstrap option: 1
2020-10-01 15:50:25 0 [Note] WSREP: Setting GCS initial position to 00000000-0000-0000-0000-000000000000:-1
2020-10-01 15:50:25 0 [Note] WSREP: protonet asio version 0
2020-10-01 15:50:25 0 [Note] WSREP: Using CRC-32C for message checksums.
2020-10-01 15:50:25 0 [Note] WSREP: backend: asio
2020-10-01 15:50:25 0 [Note] WSREP: gcomm thread scheduling priority set to other:0 
2020-10-01 15:50:25 0 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)
2020-10-01 15:50:25 0 [Note] WSREP: restore pc from disk failed
2020-10-01 15:50:25 0 [Note] WSREP: GMCast version 0
2020-10-01 15:50:25 0 [Note] WSREP: (d24b01ee-bf3a, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2020-10-01 15:50:25 0 [Note] WSREP: (d24b01ee-bf3a, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2020-10-01 15:50:25 0 [Note] WSREP: EVS version 1
2020-10-01 15:50:25 0 [Note] WSREP: gcomm: bootstrapping new group 'Nextcloud_MariaDB_Cluster'
2020-10-01 15:50:25 0 [Note] WSREP: start_prim is enabled, turn off pc_recovery
2020-10-01 15:50:25 0 [Note] WSREP: EVS version upgrade 0 -> 1
2020-10-01 15:50:25 0 [Note] WSREP: PC protocol upgrade 0 -> 1
2020-10-01 15:50:25 0 [Note] WSREP: Node d24b01ee-bf3a state prim
2020-10-01 15:50:25 0 [Note] WSREP: view(view_id(PRIM,d24b01ee-bf3a,1) memb {
        d24b01ee-bf3a,0
} joined {
} left {
} partitioned {
})
2020-10-01 15:50:25 0 [Note] WSREP: save pc into disk
2020-10-01 15:50:25 0 [Note] WSREP: gcomm: connected
2020-10-01 15:50:25 0 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2020-10-01 15:50:25 0 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2020-10-01 15:50:25 0 [Note] WSREP: Opened channel 'Nextcloud_MariaDB_Cluster'
2020-10-01 15:50:25 0 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
2020-10-01 15:50:25 1 [Note] WSREP: Starting rollbacker thread 1
2020-10-01 15:50:25 0 [Note] WSREP: Starting new group from scratch: d24b8c34-03fd-11eb-a190-9a0e1617801b
2020-10-01 15:50:25 0 [Note] WSREP: STATE_EXCHANGE: sent state UUID: d24b9df0-03fd-11eb-b266-02be285afc8a
2020-10-01 15:50:25 0 [Note] WSREP: STATE EXCHANGE: sent state msg: d24b9df0-03fd-11eb-b266-02be285afc8a
2020-10-01 15:50:25 0 [Note] WSREP: STATE EXCHANGE: got state msg: d24b9df0-03fd-11eb-b266-02be285afc8a from 0 (nx4-db--1)
2020-10-01 15:50:25 0 [Note] WSREP: Quorum results:
        version    = 6,
        component  = PRIMARY,
        conf_id    = 0,
        members    = 1/1 (joined/total),
        act_id     = 0,
        last_appl. = 0,
        protocols  = 2/10/4 (gcs/repl/appl),
        vote policy= 0,
        group UUID = d24b8c34-03fd-11eb-a190-9a0e1617801b
2020-10-01 15:50:25 0 [Note] WSREP: Flow-control interval: [16, 16]
2020-10-01 15:50:25 0 [Note] WSREP: Restored state OPEN -> JOINED (1)
2020-10-01 15:50:25 0 [Note] WSREP: Member 0.0 (nx4-db--1) synced with group.
2020-10-01 15:50:25 0 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 1)
2020-10-01 15:50:25 2 [Note] WSREP: Starting applier thread 2
2020-10-01 15:50:25 2 [Note] WSREP: ####### processing CC 1, local, ordered
2020-10-01 15:50:25 2 [Note] WSREP: Process first view: d24b8c34-03fd-11eb-a190-9a0e1617801b my uuid: d24b01ee-03fd-11eb-bf3a-82556997abcb
2020-10-01 15:50:25 2 [Note] WSREP: Server nx4-db--1 connected to cluster at position d24b8c34-03fd-11eb-a190-9a0e1617801b:1 with ID d24b01ee-03fd-11eb-bf3a-82556997abcb
2020-10-01 15:50:25 2 [Note] WSREP: Server status change disconnected -> connected
2020-10-01 15:50:25 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:50:25 2 [Note] WSREP: ####### My UUID: d24b01ee-03fd-11eb-bf3a-82556997abcb
2020-10-01 15:50:25 2 [Note] WSREP: Cert index reset to 00000000-0000-0000-0000-000000000000:-1 (proto: 10), state transfer needed: no
2020-10-01 15:50:25 0 [Note] WSREP: Service thread queue flushed.
2020-10-01 15:50:25 2 [Note] WSREP: ####### Assign initial position for certification: 00000000-0000-0000-0000-000000000000:-1, protocol version: -1
2020-10-01 15:50:25 2 [Note] WSREP: REPL Protocols: 10 (5)
2020-10-01 15:50:25 2 [Note] WSREP: ####### Adjusting cert position: -1 -> 1
2020-10-01 15:50:25 0 [Note] WSREP: Service thread queue flushed.
2020-10-01 15:50:25 2 [Note] WSREP: GCache history reset: d0fd43db-03f8-11eb-b1e5-7f6e05fd8840:30 -> d24b8c34-03fd-11eb-a190-9a0e1617801b:0
2020-10-01 15:50:25 2 [Note] WSREP: GCache DEBUG: RingBuffer::seqno_reset(): discarded 5648 bytes
2020-10-01 15:50:25 2 [Note] WSREP: GCache DEBUG: RingBuffer::seqno_reset(): found 0/1 locked buffers
2020-10-01 15:50:25 2 [Note] WSREP: ================================================
View:
  id: d24b8c34-03fd-11eb-a190-9a0e1617801b:1
  status: primary
  protocol_version: 4
  capabilities: MULTI-MASTER, CERTIFICATION, PARALLEL_APPLYING, REPLAY, ISOLATION, PAUSE, CAUSAL_READ, INCREMENTAL_WS, UNORDERED, PREORDERED, STREAMING, NBO
  final: no
  own_index: 0
  members(1):
        0: d24b01ee-03fd-11eb-bf3a-82556997abcb, nx4-db--1
=================================================
2020-10-01 15:50:25 2 [Note] WSREP: Server status change connected -> joiner
2020-10-01 15:50:25 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:50:25 2 [Note] WSREP: Server status change joiner -> initializing
2020-10-01 15:50:25 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:50:25 0 [Note] InnoDB: Using Linux native AIO
2020-10-01 15:50:25 0 [Note] InnoDB: Uses event mutexes
2020-10-01 15:50:25 0 [Note] InnoDB: Compressed tables use zlib 1.2.11
2020-10-01 15:50:25 0 [Note] InnoDB: Number of pools: 1
2020-10-01 15:50:25 0 [Note] InnoDB: Using SSE4.2 crc32 instructions
2020-10-01 15:50:25 0 [Note] mysqld: O_TMPFILE is not supported on /tmp (disabling future attempts)
2020-10-01 15:50:25 0 [Note] InnoDB: Initializing buffer pool, total size = 4294967296, chunk size = 134217728
2020-10-01 15:50:25 0 [Note] InnoDB: Completed initialization of buffer pool
2020-10-01 15:50:25 0 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
2020-10-01 15:50:25 0 [Note] InnoDB: 128 rollback segments are active.
2020-10-01 15:50:25 0 [Note] InnoDB: Creating shared tablespace for temporary tables
2020-10-01 15:50:25 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
2020-10-01 15:50:25 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
2020-10-01 15:50:25 0 [Note] InnoDB: 10.5.5 started; log sequence number 204722; transaction id 308
2020-10-01 15:50:25 0 [Note] Plugin 'FEEDBACK' is disabled.
2020-10-01 15:50:25 0 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool
2020-10-01 15:50:25 0 [Note] InnoDB: Buffer pool(s) load completed at 201001 15:50:25
2020-10-01 15:50:25 0 [Note] Server socket created on IP: '::'.
2020-10-01 15:50:25 0 [Warning] 'user' entry 'root@nx4-db--1' ignored in --skip-name-resolve mode.
2020-10-01 15:50:25 0 [Warning] 'user' entry '@nx4-db--1' ignored in --skip-name-resolve mode.
2020-10-01 15:50:25 0 [Warning] 'proxies_priv' entry '@% root@nx4-db--1' ignored in --skip-name-resolve mode.
2020-10-01 15:50:25 0 [Note] WSREP: wsrep_init_schema_and_SR 0x0
2020-10-01 15:50:25 0 [Note] WSREP: Server initialized
2020-10-01 15:50:25 0 [Note] WSREP: Server status change initializing -> initialized
2020-10-01 15:50:25 0 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:50:25 2 [Note] WSREP: Bootstrapping a new cluster, setting initial position to 00000000-0000-0000-0000-000000000000:-1
2020-10-01 15:50:25 5 [Note] WSREP: Recovered cluster id d0fd43db-03f8-11eb-b1e5-7f6e05fd8840
2020-10-01 15:50:25 2 [Note] WSREP: Server status change initialized -> joined
2020-10-01 15:50:25 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:50:25 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:50:25 6 [Note] WSREP: Starting applier thread 6
2020-10-01 15:50:25 8 [Note] WSREP: Starting applier thread 8
2020-10-01 15:50:25 0 [Note] Reading of all Master_info entries succeeded
2020-10-01 15:50:25 0 [Note] Added new Master_info '' to hash table
2020-10-01 15:50:25 0 [Note] mysqld: ready for connections.
Version: '10.5.5-MariaDB-1:10.5.5+maria~focal-log'  socket: '/run/mysqld/mysqld.sock'  port: 3306  mariadb.org binary distribution
2020-10-01 15:50:25 7 [Note] WSREP: Starting applier thread 7
2020-10-01 15:50:25 2 [Note] WSREP: Lowest cert index boundary for CC from group: 1
2020-10-01 15:50:25 2 [Note] WSREP: Min available from gcache for CC from group: 1
2020-10-01 15:50:25 2 [Note] WSREP: Server nx4-db--1 synced with group
2020-10-01 15:50:25 2 [Note] WSREP: Server status change joined -> synced
2020-10-01 15:50:25 2 [Note] WSREP: Synchronized with group, ready for connections
2020-10-01 15:50:25 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.

I got the [Note] WSREP: Synchronized with group, ready for connections, so I proceed with step 2.

Logs from db2:

ubuntu@nx4-db--2:~/nextcloud-db/mariadb/compose$ docker logs compose_nextcloud-mariadb_1
2020-10-01 15:52:11+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 1:10.5.5+maria~focal started.
2020-10-01 15:52:11+00:00 [Note] [Entrypoint]: Checking MySQL configuration variables..
2020-10-01 15:52:11+00:00 [Note] [Entrypoint]: Checking the Docker setup environment..
2020-10-01 15:52:11+00:00 [Note] [Entrypoint]: Creating database directories..
2020-10-01 15:52:11+00:00 [Note] [Entrypoint]: Switching to dedicated user 'mysql'
2020-10-01 15:52:11+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 1:10.5.5+maria~focal started.
2020-10-01 15:52:11+00:00 [Note] [Entrypoint]: Checking MySQL configuration variables..
2020-10-01 15:52:11+00:00 [Note] [Entrypoint]: Checking the Docker setup environment..
2020-10-01 15:52:11+00:00 [Note] [Entrypoint]: Creating database directories..
2020-10-01 15:52:11+00:00 [Note] [Entrypoint]: Verifying minimum environment..
2020-10-01 15:52:11+00:00 [Note] [Entrypoint]: Initializing database directory..
2020-10-01 15:52:11+00:00 [Note] [Entrypoint]: Initializing database files
2020-10-01 15:52:12 1 [Warning] Failed to load slave replication state from table mysql.gtid_slave_pos: 1017: Can't find file: './mysql/' (errno: 2 "No such file or directory")


PLEASE REMEMBER TO SET A PASSWORD FOR THE MariaDB root USER !
To do so, start the server, then issue the following commands:

'/usr/bin/mysqladmin' -u root password 'new-password'
'/usr/bin/mysqladmin' -u root -h  password 'new-password'

Alternatively you can run:
'/usr/bin/mysql_secure_installation'

which will also give you the option of removing the test
databases and anonymous user created by default.  This is
strongly recommended for production servers.

See the MariaDB Knowledgebase at https://mariadb.com/kb or the
MySQL manual for more instructions.

Please report any problems at https://mariadb.org/jira

The latest information about MariaDB is available at https://mariadb.org/.
You can find additional information about the MySQL part at:
https://dev.mysql.com
Consider joining MariaDB's strong and vibrant community:
https://mariadb.org/get-involved/

2020-10-01 15:52:13+00:00 [Note] [Entrypoint]: Database files initialized
2020-10-01 15:52:13+00:00 [Note] [Entrypoint]: Starting temporary server
2020-10-01 15:52:13+00:00 [Note] [Entrypoint]: Waiting for server startup
2020-10-01 15:52:13 0 [Note] mysqld (mysqld 10.5.5-MariaDB-1:10.5.5+maria~focal-log) starting as process 107 ...
2020-10-01 15:52:13 0 [Note] InnoDB: Using Linux native AIO
2020-10-01 15:52:13 0 [Note] InnoDB: Uses event mutexes
2020-10-01 15:52:13 0 [Note] InnoDB: Compressed tables use zlib 1.2.11
2020-10-01 15:52:13 0 [Note] InnoDB: Number of pools: 1
2020-10-01 15:52:13 0 [Note] InnoDB: Using SSE4.2 crc32 instructions
2020-10-01 15:52:13 0 [Note] mysqld: O_TMPFILE is not supported on /tmp (disabling future attempts)
2020-10-01 15:52:13 0 [Note] InnoDB: Initializing buffer pool, total size = 4294967296, chunk size = 134217728
2020-10-01 15:52:14 0 [Note] InnoDB: Completed initialization of buffer pool
2020-10-01 15:52:14 0 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
2020-10-01 15:52:14 0 [Note] InnoDB: 128 rollback segments are active.
2020-10-01 15:52:14 0 [Note] InnoDB: Creating shared tablespace for temporary tables
2020-10-01 15:52:14 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
2020-10-01 15:52:14 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
2020-10-01 15:52:14 0 [Note] InnoDB: 10.5.5 started; log sequence number 45051; transaction id 21
2020-10-01 15:52:14 0 [Note] Plugin 'FEEDBACK' is disabled.
2020-10-01 15:52:14 0 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool
2020-10-01 15:52:14 0 [Note] InnoDB: Buffer pool(s) load completed at 201001 15:52:14
2020-10-01 15:52:14 0 [Warning] 'user' entry 'root@nx4-db--2' ignored in --skip-name-resolve mode.
2020-10-01 15:52:14 0 [Warning] 'user' entry '@nx4-db--2' ignored in --skip-name-resolve mode.
2020-10-01 15:52:14 0 [Warning] 'proxies_priv' entry '@% root@nx4-db--2' ignored in --skip-name-resolve mode.
2020-10-01 15:52:14 0 [Note] Reading of all Master_info entries succeeded
2020-10-01 15:52:14 0 [Note] Added new Master_info '' to hash table
2020-10-01 15:52:14 0 [Note] mysqld: ready for connections.
Version: '10.5.5-MariaDB-1:10.5.5+maria~focal-log'  socket: '/run/mysqld/mysqld.sock'  port: 0  mariadb.org binary distribution
2020-10-01 15:52:14 4 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:15 5 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:16 6 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:17 7 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:18 8 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:19 9 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:20 10 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:22 11 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:23 12 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:24 13 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:25 14 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:26 15 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:27 16 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:28 17 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:29 18 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:30 19 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:31 20 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:32 21 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:33 22 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:34 23 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:35 24 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:36 25 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:37 26 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:38 27 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:39 28 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:40 29 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:41 30 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:42 31 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:43 32 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:44 33 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:52:45+00:00 [ERROR] [Entrypoint]: Unable to start server.
2020-10-01 15:52:45+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 1:10.5.5+maria~focal started.
2020-10-01 15:52:45+00:00 [Note] [Entrypoint]: Checking MySQL configuration variables..
2020-10-01 15:52:46+00:00 [Note] [Entrypoint]: Checking the Docker setup environment..
2020-10-01 15:52:46+00:00 [Note] [Entrypoint]: Creating database directories..
2020-10-01 15:52:46+00:00 [Note] [Entrypoint]: Switching to dedicated user 'mysql'
2020-10-01 15:52:46+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 1:10.5.5+maria~focal started.
2020-10-01 15:52:46+00:00 [Note] [Entrypoint]: Checking MySQL configuration variables..
2020-10-01 15:52:46+00:00 [Note] [Entrypoint]: Checking the Docker setup environment..
2020-10-01 15:52:46+00:00 [Note] [Entrypoint]: Creating database directories..
2020-10-01 15:52:46+00:00 [Note] [Entrypoint]: Starting the server
2020-10-01 15:52:46 0 [Note] mysqld (mysqld 10.5.5-MariaDB-1:10.5.5+maria~focal-log) starting as process 1 ...
2020-10-01 15:52:46 0 [Note] WSREP: Loading provider /usr/lib/galera/libgalera_smm.so initial position: 00000000-0000-0000-0000-000000000000:-1
2020-10-01 15:52:46 0 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib/galera/libgalera_smm.so'
2020-10-01 15:52:46 0 [Note] WSREP: wsrep_load(): Galera 26.4.5(rb3764ab6) by Codership Oy <[email protected]> loaded successfully.
2020-10-01 15:52:46 0 [Note] WSREP: CRC-32C: using hardware acceleration.
2020-10-01 15:52:46 0 [Warning] WSREP: Could not open state file for reading: '/var/lib/mysql//grastate.dat'
2020-10-01 15:52:46 0 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1, safe_to_bootstrap: 1
2020-10-01 15:52:46 0 [Note] WSREP: GCache DEBUG: opened preamble:
Version: 0
UUID: 00000000-0000-0000-0000-000000000000
Seqno: -1 - -1
Offset: -1
Synced: 0
2020-10-01 15:52:46 0 [Note] WSREP: Skipped GCache ring buffer recovery: could not determine history UUID.
2020-10-01 15:52:46 0 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = 89.45.237.135; 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.mem_size = 0; gcache.name = galera.cache; gcache.page_size = 128M; gcache.recover = yes; gcache.size = 2G; gcomm.thread_prio = ; gcs.fc_debug = 0; gcs.fc_factor = 1.0; gcs.fc_limit = 16; gcs.fc_master_slave = 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; gmcast.version = 0; pc.announce_timeout = PT3S; pc.checksum = f
2020-10-01 15:52:46 0 [Note] WSREP: Start replication
2020-10-01 15:52:46 0 [Note] WSREP: Connecting with bootstrap option: 0
2020-10-01 15:52:46 0 [Note] WSREP: Setting GCS initial position to 00000000-0000-0000-0000-000000000000:-1
2020-10-01 15:52:46 0 [Note] WSREP: protonet asio version 0
2020-10-01 15:52:46 0 [Note] WSREP: Using CRC-32C for message checksums.
2020-10-01 15:52:46 0 [Note] WSREP: backend: asio
2020-10-01 15:52:46 0 [Note] WSREP: gcomm thread scheduling priority set to other:0 
2020-10-01 15:52:46 0 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)
2020-10-01 15:52:46 0 [Note] WSREP: restore pc from disk failed
2020-10-01 15:52:46 0 [Note] WSREP: GMCast version 0
2020-10-01 15:52:46 0 [Note] WSREP: (264f2f9d-848a, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2020-10-01 15:52:46 0 [Note] WSREP: (264f2f9d-848a, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2020-10-01 15:52:46 0 [Note] WSREP: EVS version 1
2020-10-01 15:52:46 0 [Note] WSREP: gcomm: connecting to group 'Nextcloud_MariaDB_Cluster', peer '89.45.236.31:,89.45.237.135:,89.45.237.66:'
2020-10-01 15:52:46 0 [Note] WSREP: (264f2f9d-848a, 'tcp://0.0.0.0:4567') Found matching local endpoint for a connection, blacklisting address tcp://89.45.237.135:4567
2020-10-01 15:52:46 0 [Note] WSREP: (264f2f9d-848a, 'tcp://0.0.0.0:4567') connection established to d24b01ee-bf3a tcp://89.45.236.31:4567
2020-10-01 15:52:46 0 [Note] WSREP: (264f2f9d-848a, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers: 
2020-10-01 15:52:46 0 [Note] WSREP: EVS version upgrade 0 -> 1
2020-10-01 15:52:46 0 [Note] WSREP: declaring d24b01ee-bf3a at tcp://89.45.236.31:4567 stable
2020-10-01 15:52:46 0 [Note] WSREP: PC protocol upgrade 0 -> 1
2020-10-01 15:52:46 0 [Note] WSREP: Node d24b01ee-bf3a state prim
2020-10-01 15:52:46 0 [Note] WSREP: view(view_id(PRIM,264f2f9d-848a,2) memb {
        264f2f9d-848a,0
        d24b01ee-bf3a,0
} joined {
} left {
} partitioned {
})
2020-10-01 15:52:46 0 [Note] WSREP: save pc into disk
2020-10-01 15:52:46 0 [Note] WSREP: discarding pending addr without UUID: tcp://89.45.237.66:4567
2020-10-01 15:52:46 0 [Note] WSREP: gcomm: connected
2020-10-01 15:52:46 0 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2020-10-01 15:52:46 0 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2020-10-01 15:52:46 0 [Note] WSREP: Opened channel 'Nextcloud_MariaDB_Cluster'
2020-10-01 15:52:46 0 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 2
2020-10-01 15:52:46 0 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 269c2c4f-03fe-11eb-ae21-d30b5b82371b
2020-10-01 15:52:46 2 [Note] WSREP: Starting applier thread 2
2020-10-01 15:52:46 1 [Note] WSREP: Starting rollbacker thread 1
2020-10-01 15:52:46 0 [Note] WSREP: STATE EXCHANGE: sent state msg: 269c2c4f-03fe-11eb-ae21-d30b5b82371b
2020-10-01 15:52:46 0 [Note] WSREP: STATE EXCHANGE: got state msg: 269c2c4f-03fe-11eb-ae21-d30b5b82371b from 0 (nx4-db--2)
2020-10-01 15:52:46 0 [Note] WSREP: STATE EXCHANGE: got state msg: 269c2c4f-03fe-11eb-ae21-d30b5b82371b from 1 (nx4-db--1)
2020-10-01 15:52:46 0 [Note] WSREP: Quorum results:
        version    = 6,
        component  = PRIMARY,
        conf_id    = 1,
        members    = 1/2 (joined/total),
        act_id     = 1,
        last_appl. = 0,
        protocols  = 2/10/4 (gcs/repl/appl),
        vote policy= 0,
        group UUID = d24b8c34-03fd-11eb-a190-9a0e1617801b
2020-10-01 15:52:46 0 [Note] WSREP: Flow-control interval: [23, 23]
2020-10-01 15:52:46 0 [Note] WSREP: Shifting OPEN -> PRIMARY (TO: 2)
2020-10-01 15:52:46 2 [Note] WSREP: ####### processing CC 2, local, ordered
2020-10-01 15:52:46 2 [Note] WSREP: Process first view: d24b8c34-03fd-11eb-a190-9a0e1617801b my uuid: 264f2f9d-03fe-11eb-848a-43c9b27d2eb7
2020-10-01 15:52:46 2 [Note] WSREP: Server nx4-db--2 connected to cluster at position d24b8c34-03fd-11eb-a190-9a0e1617801b:2 with ID 264f2f9d-03fe-11eb-848a-43c9b27d2eb7
2020-10-01 15:52:46 2 [Note] WSREP: Server status change disconnected -> connected
2020-10-01 15:52:46 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:52:46 2 [Note] WSREP: ####### My UUID: 264f2f9d-03fe-11eb-848a-43c9b27d2eb7
2020-10-01 15:52:46 2 [Note] WSREP: Cert index reset to 00000000-0000-0000-0000-000000000000:-1 (proto: 10), state transfer needed: yes
2020-10-01 15:52:46 0 [Note] WSREP: Service thread queue flushed.
2020-10-01 15:52:46 2 [Note] WSREP: ####### Assign initial position for certification: 00000000-0000-0000-0000-000000000000:-1, protocol version: -1
2020-10-01 15:52:46 2 [Note] WSREP: State transfer required: 
        Group state: d24b8c34-03fd-11eb-a190-9a0e1617801b:2
        Local state: 00000000-0000-0000-0000-000000000000:-1
2020-10-01 15:52:46 2 [Note] WSREP: Server status change connected -> joiner
2020-10-01 15:52:46 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:52:46 0 [Note] WSREP: Joiner monitor thread started to monitor
2020-10-01 15:52:46 0 [Note] WSREP: Running: 'wsrep_sst_mariabackup --role 'joiner' --address '89.45.237.135' --datadir '/var/lib/mysql/' --parent '1' --binlog 'binlog' --mysqld-args --wsrep_cluster_address=gcomm://89.45.236.31,89.45.237.135,89.45.237.66'
WSREP_SST: [INFO] Streaming with xbstream (20201001 15:52:47.214)
WSREP_SST: [INFO] Using socat as streamer (20201001 15:52:47.218)
WSREP_SST: [INFO] Evaluating timeout -k 110 100 socat -u TCP-LISTEN:4444,reuseaddr stdio | mbstream -x; RC=( ${PIPESTATUS[@]} ) (20201001 15:52:47.280)
2020-10-01 15:52:47 2 [Note] WSREP: Prepared SST request: mariabackup|89.45.237.135:4444/xtrabackup_sst//1
2020-10-01 15:52:47 2 [Note] WSREP: ####### IST uuid:00000000-0000-0000-0000-000000000000 f: 0, l: 2, STRv: 3
2020-10-01 15:52:47 2 [Note] WSREP: IST receiver addr using tcp://89.45.237.135:4568
2020-10-01 15:52:47 2 [Note] WSREP: Prepared IST receiver for 0-2, listening at: tcp://89.45.237.135:4568
2020-10-01 15:52:47 0 [Note] WSREP: Member 0.0 (nx4-db--2) requested state transfer from '*any*'. Selected 1.0 (nx4-db--1)(SYNCED) as donor.
2020-10-01 15:52:47 0 [Note] WSREP: Shifting PRIMARY -> JOINER (TO: 2)
2020-10-01 15:52:47 2 [Note] WSREP: Requesting state transfer: success, donor: 1
2020-10-01 15:52:47 2 [Note] WSREP: Resetting GCache seqno map due to different histories.
2020-10-01 15:52:47 2 [Note] WSREP: GCache history reset: 00000000-0000-0000-0000-000000000000:0 -> d24b8c34-03fd-11eb-a190-9a0e1617801b:2
WSREP_SST: [INFO] Proceeding with SST (20201001 15:52:47.823)
WSREP_SST: [INFO] Evaluating socat -u TCP-LISTEN:4444,reuseaddr stdio | mbstream -x; RC=( ${PIPESTATUS[@]} ) (20201001 15:52:47.826)
WSREP_SST: [INFO] Cleaning the existing datadir and innodb-data/log directories (20201001 15:52:47.827)
removed '/var/lib/mysql/performance_schema/db.opt'
removed directory '/var/lib/mysql/performance_schema'
removed '/var/lib/mysql/ibtmp1'
removed '/var/lib/mysql/mysql/innodb_table_stats.ibd'
removed '/var/lib/mysql/mysql/user.frm'
removed '/var/lib/mysql/mysql/roles_mapping.frm'
removed '/var/lib/mysql/mysql/time_zone_transition_type.MAD'
removed '/var/lib/mysql/mysql/global_priv.MAD'
removed '/var/lib/mysql/mysql/gtid_slave_pos.frm'
removed '/var/lib/mysql/mysql/columns_priv.frm'
removed '/var/lib/mysql/mysql/help_relation.MAD'
removed '/var/lib/mysql/mysql/proc.MAI'
removed '/var/lib/mysql/mysql/procs_priv.MAD'
removed '/var/lib/mysql/mysql/tables_priv.MAI'
removed '/var/lib/mysql/mysql/transaction_registry.frm'
removed '/var/lib/mysql/mysql/table_stats.frm'
removed '/var/lib/mysql/mysql/procs_priv.frm'
removed '/var/lib/mysql/mysql/plugin.frm'
removed '/var/lib/mysql/mysql/help_category.MAI'
removed '/var/lib/mysql/mysql/db.opt'
removed '/var/lib/mysql/mysql/tables_priv.MAD'
removed '/var/lib/mysql/mysql/general_log.CSM'
removed '/var/lib/mysql/mysql/roles_mapping.MAI'
removed '/var/lib/mysql/mysql/innodb_index_stats.ibd'
removed '/var/lib/mysql/mysql/tables_priv.frm'
removed '/var/lib/mysql/mysql/column_stats.frm'
removed '/var/lib/mysql/mysql/general_log.frm'
removed '/var/lib/mysql/mysql/time_zone_transition_type.MAI'
removed '/var/lib/mysql/mysql/plugin.MAD'
removed '/var/lib/mysql/mysql/columns_priv.MAI'
removed '/var/lib/mysql/mysql/slow_log.frm'
removed '/var/lib/mysql/mysql/proxies_priv.MAI'
removed '/var/lib/mysql/mysql/db.MAD'
removed '/var/lib/mysql/mysql/help_relation.frm'
removed '/var/lib/mysql/mysql/help_category.frm'
removed '/var/lib/mysql/mysql/help_keyword.frm'
removed '/var/lib/mysql/mysql/index_stats.frm'
removed '/var/lib/mysql/mysql/help_category.MAD'
removed '/var/lib/mysql/mysql/time_zone_transition.MAD'
removed '/var/lib/mysql/mysql/func.frm'
removed '/var/lib/mysql/mysql/help_keyword.MAI'
removed '/var/lib/mysql/mysql/column_stats.MAI'
removed '/var/lib/mysql/mysql/help_relation.MAI'
removed '/var/lib/mysql/mysql/time_zone_leap_second.frm'
removed '/var/lib/mysql/mysql/transaction_registry.ibd'
removed '/var/lib/mysql/mysql/func.MAI'
removed '/var/lib/mysql/mysql/roles_mapping.MAD'
removed '/var/lib/mysql/mysql/time_zone.MAI'
removed '/var/lib/mysql/mysql/help_topic.MAD'
removed '/var/lib/mysql/mysql/proxies_priv.frm'
removed '/var/lib/mysql/mysql/general_log.CSV'
removed '/var/lib/mysql/mysql/db.MAI'
removed '/var/lib/mysql/mysql/help_topic.MAI'
removed '/var/lib/mysql/mysql/time_zone_name.MAI'
removed '/var/lib/mysql/mysql/time_zone_transition.frm'
removed '/var/lib/mysql/mysql/innodb_index_stats.frm'
removed '/var/lib/mysql/mysql/time_zone_leap_second.MAD'
removed '/var/lib/mysql/mysql/procs_priv.MAI'
removed '/var/lib/mysql/mysql/time_zone.frm'
removed '/var/lib/mysql/mysql/time_zone_leap_second.MAI'
removed '/var/lib/mysql/mysql/proxies_priv.MAD'
removed '/var/lib/mysql/mysql/time_zone_name.MAD'
removed '/var/lib/mysql/mysql/proc.MAD'
removed '/var/lib/mysql/mysql/slow_log.CSV'
removed '/var/lib/mysql/mysql/help_topic.frm'
removed '/var/lib/mysql/mysql/gtid_slave_pos.ibd'
removed '/var/lib/mysql/mysql/help_keyword.MAD'
removed '/var/lib/mysql/mysql/time_zone.MAD'
removed '/var/lib/mysql/mysql/time_zone_transition_type.frm'
removed '/var/lib/mysql/mysql/plugin.MAI'
removed '/var/lib/mysql/mysql/time_zone_name.frm'
removed '/var/lib/mysql/mysql/table_stats.MAD'
removed '/var/lib/mysql/mysql/innodb_table_stats.frm'
removed '/var/lib/mysql/mysql/global_priv.MAI'
removed '/var/lib/mysql/mysql/slow_log.CSM'
removed '/var/lib/mysql/mysql/time_zone_transition.MAI'
removed '/var/lib/mysql/mysql/column_stats.MAD'
removed '/var/lib/mysql/mysql/proc.frm'
removed '/var/lib/mysql/mysql/global_priv.frm'
removed '/var/lib/mysql/mysql/index_stats.MAD'
removed '/var/lib/mysql/mysql/db.frm'
removed '/var/lib/mysql/mysql/servers.MAI'
removed '/var/lib/mysql/mysql/table_stats.MAI'
removed '/var/lib/mysql/mysql/servers.MAD'
removed '/var/lib/mysql/mysql/columns_priv.MAD'
removed '/var/lib/mysql/mysql/func.MAD'
removed '/var/lib/mysql/mysql/index_stats.MAI'
removed '/var/lib/mysql/mysql/event.MAD'
removed '/var/lib/mysql/mysql/event.MAI'
removed '/var/lib/mysql/mysql/event.frm'
removed '/var/lib/mysql/mysql/servers.frm'
removed directory '/var/lib/mysql/mysql'
removed '/var/lib/mysql/test/db.opt'
removed directory '/var/lib/mysql/test'
removed '/var/lib/mysql/nx4-db--2.pid'
removed '/var/lib/mysql/binlog.000002'
removed '/var/lib/mysql/binlog.000001'
removed '/var/lib/mysql/multi-master.info'
removed '/var/lib/mysql/ib_buffer_pool'
removed '/var/lib/mysql/aria_log_control'
removed '/var/lib/mysql/ibdata1'
removed '/var/lib/mysql/aria_log.00000001'
removed '/var/lib/mysql/binlog.index'
WSREP_SST: [INFO] Waiting for SST streaming to complete! (20201001 15:52:47.859)
2020-10-01 15:52:49 0 [Note] WSREP: (264f2f9d-848a, 'tcp://0.0.0.0:4567') turning message relay requesting off
2020-10-01 15:52:57 0 [Warning] WSREP: 1.0 (nx4-db--1): State transfer to 0.0 (nx4-db--2) failed: -22 (Invalid argument)
2020-10-01 15:52:57 0 [ERROR] WSREP: gcs/src/gcs_group.cpp:gcs_group_handle_join_msg():1178: Will never receive state. Need to abort.
2020-10-01 15:52:57 0 [Note] WSREP: gcomm: terminating thread
2020-10-01 15:52:57 0 [Note] WSREP: gcomm: joining thread
2020-10-01 15:52:57 0 [Note] WSREP: gcomm: closing backend
WSREP_SST: [ERROR] xtrabackup_checkpoints missing, failed innobackupex/SST on donor (20201001 15:52:57.874)
WSREP_SST: [ERROR] Cleanup after exit with status:2 (20201001 15:52:57.877)
2020-10-01 15:52:57 0 [ERROR] WSREP: Process completed with error: wsrep_sst_mariabackup --role 'joiner' --address '89.45.237.135' --datadir '/var/lib/mysql/' --parent '1' --binlog 'binlog' --mysqld-args --wsrep_cluster_address=gcomm://89.45.236.31,89.45.237.135,89.45.237.66: 2 (No such file or directory)
2020-10-01 15:52:57 0 [ERROR] WSREP: Failed to read uuid:seqno and wsrep_gtid_domain_id from joiner script.
2020-10-01 15:52:57 3 [Note] WSREP: SST received
2020-10-01 15:52:57 3 [Note] WSREP: SST received: 00000000-0000-0000-0000-000000000000:-1
2020-10-01 15:52:57 0 [Note] WSREP: Joiner monitor thread ended with total time 11 sec
2020-10-01 15:52:57 2 [ERROR] WSREP: Application received wrong state: 
        Received: 00000000-0000-0000-0000-000000000000
        Required: d24b8c34-03fd-11eb-a190-9a0e1617801b
2020-10-01 15:52:57 2 [ERROR] WSREP: Application state transfer failed. This is unrecoverable condition, restart required.
2020-10-01 15:52:57 2 [Note] WSREP: ReplicatorSMM::abort()
2020-10-01 15:52:57 2 [Note] WSREP: Closing send monitor...
2020-10-01 15:52:57 2 [Note] WSREP: Closed send monitor.
2020-10-01 15:52:58 0 [Note] WSREP: view(view_id(NON_PRIM,264f2f9d-848a,2) memb {
        264f2f9d-848a,0
} joined {
} left {
} partitioned {
        d24b01ee-bf3a,0
})
2020-10-01 15:52:58 0 [Note] WSREP: PC protocol downgrade 1 -> 0
2020-10-01 15:52:58 0 [Note] WSREP: view((empty))
2020-10-01 15:52:58 0 [Note] WSREP: gcomm: closed
2020-10-01 15:52:58 2 [Note] WSREP: gcomm: terminating thread
2020-10-01 15:52:58 2 [Note] WSREP: gcomm: joining thread
2020-10-01 15:52:58 2 [Note] WSREP: gcomm: closing backend
201001 15:52:58 [ERROR] mysqld got signal 11 ;
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.5.5-MariaDB-1:10.5.5+maria~focal-log
key_buffer_size=0
read_buffer_size=131072
max_used_connections=0
max_threads=752
thread_count=2
It is possible that mysqld could use up to 
key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 1655144 K  bytes of memory
Hope that's ok; if not, decrease some variables in the equation.

Thread pointer: 0x7f393c000c58
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 = 0x7f394cc5dd98 thread_stack 0x49000
2020-10-01 15:52:58 0 [Note] WSREP: mysqld: Terminated.
2020-10-01 15:52:59+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 1:10.5.5+maria~focal started.
2020-10-01 15:52:59+00:00 [Note] [Entrypoint]: Checking MySQL configuration variables..
2020-10-01 15:52:59+00:00 [Note] [Entrypoint]: Checking the Docker setup environment..
2020-10-01 15:52:59+00:00 [Note] [Entrypoint]: Creating database directories..
2020-10-01 15:52:59+00:00 [Note] [Entrypoint]: Switching to dedicated user 'mysql'
2020-10-01 15:52:59+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 1:10.5.5+maria~focal started.
2020-10-01 15:52:59+00:00 [Note] [Entrypoint]: Checking MySQL configuration variables..
2020-10-01 15:52:59+00:00 [Note] [Entrypoint]: Checking the Docker setup environment..
2020-10-01 15:52:59+00:00 [Note] [Entrypoint]: Creating database directories..
2020-10-01 15:52:59+00:00 [Note] [Entrypoint]: Verifying minimum environment..
2020-10-01 15:52:59+00:00 [Note] [Entrypoint]: Initializing database directory..
2020-10-01 15:52:59+00:00 [Note] [Entrypoint]: Initializing database files
2020-10-01 15:53:00 1 [Warning] Failed to load slave replication state from table mysql.gtid_slave_pos: 1017: Can't find file: './mysql/' (errno: 2 "No such file or directory")


PLEASE REMEMBER TO SET A PASSWORD FOR THE MariaDB root USER !
To do so, start the server, then issue the following commands:

'/usr/bin/mysqladmin' -u root password 'new-password'
'/usr/bin/mysqladmin' -u root -h  password 'new-password'

Alternatively you can run:
'/usr/bin/mysql_secure_installation'

which will also give you the option of removing the test
databases and anonymous user created by default.  This is
strongly recommended for production servers.

See the MariaDB Knowledgebase at https://mariadb.com/kb or the
MySQL manual for more instructions.

Please report any problems at https://mariadb.org/jira

The latest information about MariaDB is available at https://mariadb.org/.
You can find additional information about the MySQL part at:
https://dev.mysql.com
Consider joining MariaDB's strong and vibrant community:
https://mariadb.org/get-involved/

2020-10-01 15:53:01+00:00 [Note] [Entrypoint]: Database files initialized
2020-10-01 15:53:01+00:00 [Note] [Entrypoint]: Starting temporary server
2020-10-01 15:53:01+00:00 [Note] [Entrypoint]: Waiting for server startup
2020-10-01 15:53:01 0 [Note] mysqld (mysqld 10.5.5-MariaDB-1:10.5.5+maria~focal-log) starting as process 104 ...
2020-10-01 15:53:01 0 [Note] InnoDB: Using Linux native AIO
2020-10-01 15:53:01 0 [Note] InnoDB: Uses event mutexes
2020-10-01 15:53:01 0 [Note] InnoDB: Compressed tables use zlib 1.2.11
2020-10-01 15:53:01 0 [Note] InnoDB: Number of pools: 1
2020-10-01 15:53:01 0 [Note] InnoDB: Using SSE4.2 crc32 instructions
2020-10-01 15:53:01 0 [Note] mysqld: O_TMPFILE is not supported on /tmp (disabling future attempts)
2020-10-01 15:53:01 0 [Note] InnoDB: Initializing buffer pool, total size = 4294967296, chunk size = 134217728
2020-10-01 15:53:02 0 [Note] InnoDB: Completed initialization of buffer pool
2020-10-01 15:53:02 0 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
2020-10-01 15:53:02 0 [Note] InnoDB: 128 rollback segments are active.
2020-10-01 15:53:02 0 [Note] InnoDB: Creating shared tablespace for temporary tables
2020-10-01 15:53:02 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
2020-10-01 15:53:02 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
2020-10-01 15:53:02 0 [Note] InnoDB: 10.5.5 started; log sequence number 45051; transaction id 21
2020-10-01 15:53:02 0 [Note] Plugin 'FEEDBACK' is disabled.
2020-10-01 15:53:02 0 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool
2020-10-01 15:53:02 0 [Note] InnoDB: Buffer pool(s) load completed at 201001 15:53:02
2020-10-01 15:53:02 0 [Warning] 'user' entry 'root@nx4-db--2' ignored in --skip-name-resolve mode.
2020-10-01 15:53:02 0 [Warning] 'user' entry '@nx4-db--2' ignored in --skip-name-resolve mode.
2020-10-01 15:53:02 0 [Warning] 'proxies_priv' entry '@% root@nx4-db--2' ignored in --skip-name-resolve mode.
2020-10-01 15:53:02 0 [Note] Reading of all Master_info entries succeeded
2020-10-01 15:53:02 0 [Note] Added new Master_info '' to hash table
2020-10-01 15:53:02 0 [Note] mysqld: ready for connections.
Version: '10.5.5-MariaDB-1:10.5.5+maria~focal-log'  socket: '/run/mysqld/mysqld.sock'  port: 0  mariadb.org binary distribution
2020-10-01 15:53:02 4 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:53:03 5 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:53:04 6 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:53:05 7 [Warning] Access denied for user 'root'@'localhost' (using password: YES)
2020-10-01 15:53:06 8 [Warning] Access denied for user 'root'@'localhost' (using password: YES)

and new logs from db1 (continuing from where the previous log ended)

2020-10-01 15:52:46 0 [Note] WSREP: (d24b01ee-bf3a, 'tcp://0.0.0.0:4567') connection established to 264f2f9d-848a tcp://89.45.237.135:4567
2020-10-01 15:52:46 0 [Note] WSREP: (d24b01ee-bf3a, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers: 
2020-10-01 15:52:46 0 [Note] WSREP: declaring 264f2f9d-848a at tcp://89.45.237.135:4567 stable
2020-10-01 15:52:46 0 [Note] WSREP: Node d24b01ee-bf3a state prim
2020-10-01 15:52:46 0 [Note] WSREP: view(view_id(PRIM,264f2f9d-848a,2) memb {
        264f2f9d-848a,0
        d24b01ee-bf3a,0
} joined {
} left {
} partitioned {
})
2020-10-01 15:52:46 0 [Note] WSREP: save pc into disk
2020-10-01 15:52:46 0 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 1, memb_num = 2
2020-10-01 15:52:46 0 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
2020-10-01 15:52:46 0 [Note] WSREP: STATE EXCHANGE: sent state msg: 269c2c4f-03fe-11eb-ae21-d30b5b82371b
2020-10-01 15:52:46 0 [Note] WSREP: STATE EXCHANGE: got state msg: 269c2c4f-03fe-11eb-ae21-d30b5b82371b from 0 (nx4-db--2)
2020-10-01 15:52:46 0 [Note] WSREP: STATE EXCHANGE: got state msg: 269c2c4f-03fe-11eb-ae21-d30b5b82371b from 1 (nx4-db--1)
2020-10-01 15:52:46 0 [Note] WSREP: Quorum results:
        version    = 6,
        component  = PRIMARY,
        conf_id    = 1,
        members    = 1/2 (joined/total),
        act_id     = 1,
        last_appl. = 0,
        protocols  = 2/10/4 (gcs/repl/appl),
        vote policy= 0,
        group UUID = d24b8c34-03fd-11eb-a190-9a0e1617801b
2020-10-01 15:52:46 0 [Note] WSREP: Flow-control interval: [23, 23]
2020-10-01 15:52:46 2 [Note] WSREP: ####### processing CC 2, local, ordered
2020-10-01 15:52:46 2 [Note] WSREP: ####### My UUID: d24b01ee-03fd-11eb-bf3a-82556997abcb
2020-10-01 15:52:46 2 [Note] WSREP: Skipping cert index reset
2020-10-01 15:52:46 2 [Note] WSREP: REPL Protocols: 10 (5)
2020-10-01 15:52:46 2 [Note] WSREP: ####### Adjusting cert position: 1 -> 2
2020-10-01 15:52:46 0 [Note] WSREP: Service thread queue flushed.
2020-10-01 15:52:46 2 [Note] WSREP: ================================================
View:
  id: d24b8c34-03fd-11eb-a190-9a0e1617801b:2
  status: primary
  protocol_version: 4
  capabilities: MULTI-MASTER, CERTIFICATION, PARALLEL_APPLYING, REPLAY, ISOLATION, PAUSE, CAUSAL_READ, INCREMENTAL_WS, UNORDERED, PREORDERED, STREAMING, NBO
  final: no
  own_index: 1
  members(2):
        0: 264f2f9d-03fe-11eb-848a-43c9b27d2eb7, nx4-db--2
        1: d24b01ee-03fd-11eb-bf3a-82556997abcb, nx4-db--1
=================================================
2020-10-01 15:52:46 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:52:46 2 [Note] WSREP: Lowest cert index boundary for CC from group: 2
2020-10-01 15:52:46 2 [Note] WSREP: Min available from gcache for CC from group: 1
2020-10-01 15:52:47 0 [Note] WSREP: Member 0.0 (nx4-db--2) requested state transfer from '*any*'. Selected 1.0 (nx4-db--1)(SYNCED) as donor.
2020-10-01 15:52:47 0 [Note] WSREP: Shifting SYNCED -> DONOR/DESYNCED (TO: 2)
2020-10-01 15:52:47 2 [Note] WSREP: Detected STR version: 1, req_len: 130, req: STRv1
2020-10-01 15:52:47 2 [Note] WSREP: Cert index preload: 2 -> 2
2020-10-01 15:52:47 2 [Note] WSREP: Server status change synced -> donor
2020-10-01 15:52:47 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:52:47 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:52:47 0 [Note] WSREP: Donor monitor thread started to monitor
2020-10-01 15:52:47 0 [Note] WSREP: async IST sender starting to serve tcp://89.45.237.135:4568 sending 2-2, preload starts from 2
2020-10-01 15:52:47 0 [Note] WSREP: Running: 'wsrep_sst_mariabackup --role 'donor' --address '89.45.237.135:4444/xtrabackup_sst//1' --socket '/run/mysqld/mysqld.sock' --datadir '/var/lib/mysql/' --gtid 'd24b8c34-03fd-11eb-a190-9a0e1617801b:2' --gtid-domain-id '1000' --binlog 'binlog' --mysqld-args --wsrep_cluster_address=gcomm://'
2020-10-01 15:52:47 0 [Note] WSREP: IST sender 2 -> 2
2020-10-01 15:52:47 2 [Note] WSREP: sst_donor_thread signaled with 0
WSREP_SST: [INFO] Moving /var/lib/mysql//mariabackup.backup.log to /tmp/sst_log_archive/mariabackup.backup.log.2020.10.01-15.52.47.741149442 (20201001 15:52:47.747)
WSREP_SST: [INFO] Streaming with xbstream (20201001 15:52:47.757)
WSREP_SST: [INFO] Using socat as streamer (20201001 15:52:47.761)
WSREP_SST: [INFO] Using /tmp/tmp.FZ9POeuYGr as xtrabackup temporary directory (20201001 15:52:47.789)
WSREP_SST: [INFO] Using /tmp/tmp.t2HQhOvZ9L as innobackupex temporary directory (20201001 15:52:47.794)
WSREP_SST: [INFO] Streaming GTID file before SST (20201001 15:52:47.797)
WSREP_SST: [INFO] Evaluating mbstream -c ${INFO_FILE} | socat -u stdio TCP:89.45.237.135:4444; RC=( ${PIPESTATUS[@]} ) (20201001 15:52:47.802)
WSREP_SST: [INFO] Sleeping before data transfer for SST (20201001 15:52:47.811)
2020-10-01 15:52:49 0 [Note] WSREP: (d24b01ee-bf3a, 'tcp://0.0.0.0:4567') turning message relay requesting off
WSREP_SST: [INFO] Streaming the backup to joiner at 89.45.237.135 4444 (20201001 15:52:57.817)
WSREP_SST: [INFO] Evaluating /usr//bin/mariabackup  --backup --no-version-check  $tmpopts $INNOEXTRA --galera-info --stream=$sfmt --target-dir=$itmpdir --mysqld-args $WSREP_SST_OPT_MYSQLD 2> /var/lib/mysql//mariabackup.backup.log | socat -u stdio TCP:89.45.237.135:4444; RC=( ${PIPESTATUS[@]} ) (20201001 15:52:57.821)
2020-10-01 15:52:57 11 [Warning] Access denied for user 'backup'@'localhost' (using password: YES)
WSREP_SST: [ERROR] /usr//bin/mariabackup finished with error: 1.  Check syslog or /var/lib/mysql//mariabackup.backup.log for details (20201001 15:52:57.846)
WSREP_SST: [ERROR] Cleanup after exit with status:22 (20201001 15:52:57.850)
WSREP_SST: [INFO] Cleaning up temporary directories (20201001 15:52:57.855)
2020-10-01 15:52:57 0 [ERROR] WSREP: Failed to read from: wsrep_sst_mariabackup --role 'donor' --address '89.45.237.135:4444/xtrabackup_sst//1' --socket '/run/mysqld/mysqld.sock' --datadir '/var/lib/mysql/' --gtid 'd24b8c34-03fd-11eb-a190-9a0e1617801b:2' --gtid-domain-id '1000' --binlog 'binlog' --mysqld-args --wsrep_cluster_address=gcomm://
2020-10-01 15:52:57 0 [ERROR] WSREP: Process completed with error: wsrep_sst_mariabackup --role 'donor' --address '89.45.237.135:4444/xtrabackup_sst//1' --socket '/run/mysqld/mysqld.sock' --datadir '/var/lib/mysql/' --gtid 'd24b8c34-03fd-11eb-a190-9a0e1617801b:2' --gtid-domain-id '1000' --binlog 'binlog' --mysqld-args --wsrep_cluster_address=gcomm://: 22 (Invalid argument)
2020-10-01 15:52:57 0 [Note] WSREP: SST sending failed: -22
2020-10-01 15:52:57 0 [Note] WSREP: Server status change donor -> joined
2020-10-01 15:52:57 0 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:52:57 0 [ERROR] WSREP: Command did not run: wsrep_sst_mariabackup --role 'donor' --address '89.45.237.135:4444/xtrabackup_sst//1' --socket '/run/mysqld/mysqld.sock' --datadir '/var/lib/mysql/' --gtid 'd24b8c34-03fd-11eb-a190-9a0e1617801b:2' --gtid-domain-id '1000' --binlog 'binlog' --mysqld-args --wsrep_cluster_address=gcomm://
2020-10-01 15:52:57 0 [Note] WSREP: Donor monitor thread ended with total time 10 sec
2020-10-01 15:52:57 0 [Warning] WSREP: 1.0 (nx4-db--1): State transfer to 0.0 (nx4-db--2) failed: -22 (Invalid argument)
2020-10-01 15:52:57 0 [Note] WSREP: Shifting DONOR/DESYNCED -> JOINED (TO: 2)
2020-10-01 15:52:57 0 [Note] WSREP: Member 1.0 (nx4-db--1) synced with group.
2020-10-01 15:52:57 0 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 2)
2020-10-01 15:52:57 6 [Note] WSREP: Server nx4-db--1 synced with group
2020-10-01 15:52:57 6 [Note] WSREP: Server status change joined -> synced
2020-10-01 15:52:57 6 [Note] WSREP: Synchronized with group, ready for connections
2020-10-01 15:52:57 6 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:52:58 0 [Note] WSREP: forgetting 264f2f9d-848a (tcp://89.45.237.135:4567)
2020-10-01 15:52:58 0 [Note] WSREP: Node d24b01ee-bf3a state prim
2020-10-01 15:52:58 0 [Note] WSREP: view(view_id(PRIM,d24b01ee-bf3a,3) memb {
        d24b01ee-bf3a,0
} joined {
} left {
} partitioned {
        264f2f9d-848a,0
})
2020-10-01 15:52:58 0 [Note] WSREP: save pc into disk
2020-10-01 15:52:58 0 [Note] WSREP: forgetting 264f2f9d-848a (tcp://89.45.237.135:4567)
2020-10-01 15:52:58 0 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
2020-10-01 15:52:58 0 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 2dbacbe2-03fe-11eb-b5e5-ba295d2ae1d4
2020-10-01 15:52:58 0 [Note] WSREP: STATE EXCHANGE: sent state msg: 2dbacbe2-03fe-11eb-b5e5-ba295d2ae1d4
2020-10-01 15:52:58 0 [Note] WSREP: STATE EXCHANGE: got state msg: 2dbacbe2-03fe-11eb-b5e5-ba295d2ae1d4 from 0 (nx4-db--1)
2020-10-01 15:52:58 0 [Note] WSREP: Quorum results:
        version    = 6,
        component  = PRIMARY,
        conf_id    = 2,
        members    = 1/1 (joined/total),
        act_id     = 2,
        last_appl. = 0,
        protocols  = 2/10/4 (gcs/repl/appl),
        vote policy= 0,
        group UUID = d24b8c34-03fd-11eb-a190-9a0e1617801b
2020-10-01 15:52:58 0 [Note] WSREP: Flow-control interval: [16, 16]
2020-10-01 15:52:58 7 [Note] WSREP: ####### processing CC 3, local, ordered
2020-10-01 15:52:58 7 [Note] WSREP: ####### My UUID: d24b01ee-03fd-11eb-bf3a-82556997abcb
2020-10-01 15:52:58 7 [Note] WSREP: Skipping cert index reset
2020-10-01 15:52:58 7 [Note] WSREP: REPL Protocols: 10 (5)
2020-10-01 15:52:58 7 [Note] WSREP: ####### Adjusting cert position: 2 -> 3
2020-10-01 15:52:58 0 [Note] WSREP: Service thread queue flushed.
2020-10-01 15:52:58 7 [Note] WSREP: ================================================
View:
  id: d24b8c34-03fd-11eb-a190-9a0e1617801b:3
  status: primary
  protocol_version: 4
  capabilities: MULTI-MASTER, CERTIFICATION, PARALLEL_APPLYING, REPLAY, ISOLATION, PAUSE, CAUSAL_READ, INCREMENTAL_WS, UNORDERED, PREORDERED, STREAMING, NBO
  final: no
  own_index: 0
  members(1):
        0: d24b01ee-03fd-11eb-bf3a-82556997abcb, nx4-db--1
=================================================
2020-10-01 15:52:58 7 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:52:58 7 [Note] WSREP: Lowest cert index boundary for CC from group: 3
2020-10-01 15:52:58 7 [Note] WSREP: Min available from gcache for CC from group: 1
2020-10-01 15:52:58 0 [Note] WSREP: async IST sender served
2020-10-01 15:53:04 0 [Note] WSREP:  cleaning up 264f2f9d-848a (tcp://89.45.237.135:4567)
2020-10-01 15:53:35 0 [Note] WSREP: (d24b01ee-bf3a, 'tcp://0.0.0.0:4567') connection established to 43d39095-83e8 tcp://89.45.237.135:4567
2020-10-01 15:53:35 0 [Note] WSREP: (d24b01ee-bf3a, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers: 
2020-10-01 15:53:36 0 [Note] WSREP: declaring 43d39095-83e8 at tcp://89.45.237.135:4567 stable
2020-10-01 15:53:36 0 [Note] WSREP: Node d24b01ee-bf3a state prim
2020-10-01 15:53:36 0 [Note] WSREP: view(view_id(PRIM,43d39095-83e8,4) memb {
        43d39095-83e8,0
        d24b01ee-bf3a,0
} joined {
} left {
} partitioned {
})
2020-10-01 15:53:36 0 [Note] WSREP: save pc into disk
2020-10-01 15:53:36 0 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 1, memb_num = 2
2020-10-01 15:53:36 0 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
2020-10-01 15:53:36 0 [Note] WSREP: STATE EXCHANGE: sent state msg: 446c98c9-03fe-11eb-8115-0ba7669c5a9f
2020-10-01 15:53:36 0 [Note] WSREP: STATE EXCHANGE: got state msg: 446c98c9-03fe-11eb-8115-0ba7669c5a9f from 0 (nx4-db--2)
2020-10-01 15:53:36 0 [Note] WSREP: STATE EXCHANGE: got state msg: 446c98c9-03fe-11eb-8115-0ba7669c5a9f from 1 (nx4-db--1)
2020-10-01 15:53:36 0 [Note] WSREP: Quorum results:
        version    = 6,
        component  = PRIMARY,
        conf_id    = 3,
        members    = 1/2 (joined/total),
        act_id     = 3,
        last_appl. = 0,
        protocols  = 2/10/4 (gcs/repl/appl),
        vote policy= 0,
        group UUID = d24b8c34-03fd-11eb-a190-9a0e1617801b
2020-10-01 15:53:36 0 [Note] WSREP: Flow-control interval: [23, 23]
2020-10-01 15:53:36 7 [Note] WSREP: ####### processing CC 4, local, ordered
2020-10-01 15:53:36 7 [Note] WSREP: ####### My UUID: d24b01ee-03fd-11eb-bf3a-82556997abcb
2020-10-01 15:53:36 7 [Note] WSREP: Skipping cert index reset
2020-10-01 15:53:36 7 [Note] WSREP: REPL Protocols: 10 (5)
2020-10-01 15:53:36 7 [Note] WSREP: ####### Adjusting cert position: 3 -> 4
2020-10-01 15:53:36 0 [Note] WSREP: Service thread queue flushed.
2020-10-01 15:53:36 7 [Note] WSREP: ================================================
View:
  id: d24b8c34-03fd-11eb-a190-9a0e1617801b:4
  status: primary
  protocol_version: 4
  capabilities: MULTI-MASTER, CERTIFICATION, PARALLEL_APPLYING, REPLAY, ISOLATION, PAUSE, CAUSAL_READ, INCREMENTAL_WS, UNORDERED, PREORDERED, STREAMING, NBO
  final: no
  own_index: 1
  members(2):
        0: 43d39095-03fe-11eb-83e8-4f10a65b17d5, nx4-db--2
        1: d24b01ee-03fd-11eb-bf3a-82556997abcb, nx4-db--1
=================================================
2020-10-01 15:53:36 7 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:53:36 7 [Note] WSREP: Lowest cert index boundary for CC from group: 4
2020-10-01 15:53:36 7 [Note] WSREP: Min available from gcache for CC from group: 1
2020-10-01 15:53:37 0 [Note] WSREP: Member 0.0 (nx4-db--2) requested state transfer from '*any*'. Selected 1.0 (nx4-db--1)(SYNCED) as donor.
2020-10-01 15:53:37 0 [Note] WSREP: Shifting SYNCED -> DONOR/DESYNCED (TO: 4)
2020-10-01 15:53:37 7 [Note] WSREP: Detected STR version: 1, req_len: 130, req: STRv1
2020-10-01 15:53:37 7 [Note] WSREP: Cert index preload: 4 -> 4
2020-10-01 15:53:37 7 [Note] WSREP: Server status change synced -> donor
2020-10-01 15:53:37 7 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:53:37 7 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:53:37 0 [Note] WSREP: async IST sender starting to serve tcp://89.45.237.135:4568 sending 4-4, preload starts from 4
2020-10-01 15:53:37 0 [Note] WSREP: Donor monitor thread started to monitor
2020-10-01 15:53:37 0 [Note] WSREP: Running: 'wsrep_sst_mariabackup --role 'donor' --address '89.45.237.135:4444/xtrabackup_sst//1' --socket '/run/mysqld/mysqld.sock' --datadir '/var/lib/mysql/' --gtid 'd24b8c34-03fd-11eb-a190-9a0e1617801b:4' --gtid-domain-id '1000' --binlog 'binlog' --mysqld-args --wsrep_cluster_address=gcomm://'
2020-10-01 15:53:37 0 [Note] WSREP: IST sender 4 -> 4
2020-10-01 15:53:37 7 [Note] WSREP: sst_donor_thread signaled with 0
WSREP_SST: [INFO] Moving /var/lib/mysql//mariabackup.backup.log to /tmp/sst_log_archive/mariabackup.backup.log.2020.10.01-15.53.37.709731485 (20201001 15:53:37.713)
WSREP_SST: [INFO] Streaming with xbstream (20201001 15:53:37.722)
WSREP_SST: [INFO] Using socat as streamer (20201001 15:53:37.725)
WSREP_SST: [INFO] Using /tmp/tmp.3n0Zz7dgyo as xtrabackup temporary directory (20201001 15:53:37.755)
WSREP_SST: [INFO] Using /tmp/tmp.7If5QOK7uv as innobackupex temporary directory (20201001 15:53:37.760)
WSREP_SST: [INFO] Streaming GTID file before SST (20201001 15:53:37.763)
WSREP_SST: [INFO] Evaluating mbstream -c ${INFO_FILE} | socat -u stdio TCP:89.45.237.135:4444; RC=( ${PIPESTATUS[@]} ) (20201001 15:53:37.766)
WSREP_SST: [INFO] Sleeping before data transfer for SST (20201001 15:53:37.776)
2020-10-01 15:53:39 0 [Note] WSREP: (d24b01ee-bf3a, 'tcp://0.0.0.0:4567') turning message relay requesting off
WSREP_SST: [INFO] Streaming the backup to joiner at 89.45.237.135 4444 (20201001 15:53:47.780)
WSREP_SST: [INFO] Evaluating /usr//bin/mariabackup  --backup --no-version-check  $tmpopts $INNOEXTRA --galera-info --stream=$sfmt --target-dir=$itmpdir --mysqld-args $WSREP_SST_OPT_MYSQLD 2> /var/lib/mysql//mariabackup.backup.log | socat -u stdio TCP:89.45.237.135:4444; RC=( ${PIPESTATUS[@]} ) (20201001 15:53:47.783)
2020-10-01 15:53:47 12 [Warning] Access denied for user 'backup'@'localhost' (using password: YES)
WSREP_SST: [ERROR] /usr//bin/mariabackup finished with error: 1.  Check syslog or /var/lib/mysql//mariabackup.backup.log for details (20201001 15:53:47.808)
WSREP_SST: [ERROR] Cleanup after exit with status:22 (20201001 15:53:47.811)
WSREP_SST: [INFO] Cleaning up temporary directories (20201001 15:53:47.815)
2020-10-01 15:53:47 0 [ERROR] WSREP: Failed to read from: wsrep_sst_mariabackup --role 'donor' --address '89.45.237.135:4444/xtrabackup_sst//1' --socket '/run/mysqld/mysqld.sock' --datadir '/var/lib/mysql/' --gtid 'd24b8c34-03fd-11eb-a190-9a0e1617801b:4' --gtid-domain-id '1000' --binlog 'binlog' --mysqld-args --wsrep_cluster_address=gcomm://
2020-10-01 15:53:47 0 [ERROR] WSREP: Process completed with error: wsrep_sst_mariabackup --role 'donor' --address '89.45.237.135:4444/xtrabackup_sst//1' --socket '/run/mysqld/mysqld.sock' --datadir '/var/lib/mysql/' --gtid 'd24b8c34-03fd-11eb-a190-9a0e1617801b:4' --gtid-domain-id '1000' --binlog 'binlog' --mysqld-args --wsrep_cluster_address=gcomm://: 22 (Invalid argument)
2020-10-01 15:53:47 0 [Note] WSREP: SST sending failed: -22
2020-10-01 15:53:47 0 [Note] WSREP: Server status change donor -> joined
2020-10-01 15:53:47 0 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:53:47 0 [ERROR] WSREP: Command did not run: wsrep_sst_mariabackup --role 'donor' --address '89.45.237.135:4444/xtrabackup_sst//1' --socket '/run/mysqld/mysqld.sock' --datadir '/var/lib/mysql/' --gtid 'd24b8c34-03fd-11eb-a190-9a0e1617801b:4' --gtid-domain-id '1000' --binlog 'binlog' --mysqld-args --wsrep_cluster_address=gcomm://
2020-10-01 15:53:47 0 [Note] WSREP: Donor monitor thread ended with total time 10 sec
2020-10-01 15:53:47 0 [Warning] WSREP: 1.0 (nx4-db--1): State transfer to 0.0 (nx4-db--2) failed: -22 (Invalid argument)
2020-10-01 15:53:47 0 [Note] WSREP: Shifting DONOR/DESYNCED -> JOINED (TO: 4)
2020-10-01 15:53:47 0 [Note] WSREP: Member 1.0 (nx4-db--1) synced with group.
2020-10-01 15:53:47 0 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 4)
2020-10-01 15:53:47 8 [Note] WSREP: Server nx4-db--1 synced with group
2020-10-01 15:53:47 8 [Note] WSREP: Server status change joined -> synced
2020-10-01 15:53:47 8 [Note] WSREP: Synchronized with group, ready for connections
2020-10-01 15:53:47 8 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:53:48 0 [Note] WSREP: forgetting 43d39095-83e8 (tcp://89.45.237.135:4567)
2020-10-01 15:53:48 0 [Note] WSREP: Node d24b01ee-bf3a state prim
2020-10-01 15:53:48 0 [Note] WSREP: view(view_id(PRIM,d24b01ee-bf3a,5) memb {
        d24b01ee-bf3a,0
} joined {
} left {
} partitioned {
        43d39095-83e8,0
})
2020-10-01 15:53:48 0 [Note] WSREP: save pc into disk
2020-10-01 15:53:48 0 [Note] WSREP: forgetting 43d39095-83e8 (tcp://89.45.237.135:4567)
2020-10-01 15:53:48 0 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
2020-10-01 15:53:48 0 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 4b81d8fa-03fe-11eb-9466-bb4070013a16
2020-10-01 15:53:48 0 [Note] WSREP: STATE EXCHANGE: sent state msg: 4b81d8fa-03fe-11eb-9466-bb4070013a16
2020-10-01 15:53:48 0 [Note] WSREP: STATE EXCHANGE: got state msg: 4b81d8fa-03fe-11eb-9466-bb4070013a16 from 0 (nx4-db--1)
2020-10-01 15:53:48 0 [Note] WSREP: Quorum results:
        version    = 6,
        component  = PRIMARY,
        conf_id    = 4,
        members    = 1/1 (joined/total),
        act_id     = 4,
        last_appl. = 0,
        protocols  = 2/10/4 (gcs/repl/appl),
        vote policy= 0,
        group UUID = d24b8c34-03fd-11eb-a190-9a0e1617801b
2020-10-01 15:53:48 0 [Note] WSREP: Flow-control interval: [16, 16]
2020-10-01 15:53:48 6 [Note] WSREP: ####### processing CC 5, local, ordered
2020-10-01 15:53:48 6 [Note] WSREP: ####### My UUID: d24b01ee-03fd-11eb-bf3a-82556997abcb
2020-10-01 15:53:48 6 [Note] WSREP: Skipping cert index reset
2020-10-01 15:53:48 6 [Note] WSREP: REPL Protocols: 10 (5)
2020-10-01 15:53:48 6 [Note] WSREP: ####### Adjusting cert position: 4 -> 5
2020-10-01 15:53:48 0 [Note] WSREP: Service thread queue flushed.
2020-10-01 15:53:48 6 [Note] WSREP: ================================================
View:
  id: d24b8c34-03fd-11eb-a190-9a0e1617801b:5
  status: primary
  protocol_version: 4
  capabilities: MULTI-MASTER, CERTIFICATION, PARALLEL_APPLYING, REPLAY, ISOLATION, PAUSE, CAUSAL_READ, INCREMENTAL_WS, UNORDERED, PREORDERED, STREAMING, NBO
  final: no
  own_index: 0
  members(1):
        0: d24b01ee-03fd-11eb-bf3a-82556997abcb, nx4-db--1
=================================================
2020-10-01 15:53:48 6 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2020-10-01 15:53:48 6 [Note] WSREP: Lowest cert index boundary for CC from group: 5
2020-10-01 15:53:48 6 [Note] WSREP: Min available from gcache for CC from group: 1
2020-10-01 15:53:48 0 [Note] WSREP: async IST sender served
2020-10-01 15:53:54 0 [Note] WSREP:  cleaning up 43d39095-83e8 (tcp://89.45.237.135:4567)

and some more logs from db2:

Thread pointer: 0x7f3af4000c58
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 = 0x7f3b84597d98 thread_stack 0x49000
2020-10-01 16:06:06 0 [Note] WSREP: gcomm: closed
2020-10-01 16:06:06 0 [Note] WSREP: mysqld: Terminated.
2020-10-01 16:06:07+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 1:10.5.5+maria~focal started.
2020-10-01 16:06:07+00:00 [Note] [Entrypoint]: Checking MySQL configuration variables..
2020-10-01 16:06:07+00:00 [Note] [Entrypoint]: Checking the Docker setup environment..
2020-10-01 16:06:07+00:00 [Note] [Entrypoint]: Creating database directories..
2020-10-01 16:06:07+00:00 [Note] [Entrypoint]: Switching to dedicated user 'mysql'
2020-10-01 16:06:07+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 1:10.5.5+maria~focal started.
2020-10-01 16:06:07+00:00 [Note] [Entrypoint]: Checking MySQL configuration variables..
2020-10-01 16:06:07+00:00 [Note] [Entrypoint]: Checking the Docker setup environment..
2020-10-01 16:06:07+00:00 [Note] [Entrypoint]: Creating database directories..
2020-10-01 16:06:07+00:00 [Note] [Entrypoint]: Verifying minimum environment..
2020-10-01 16:06:07+00:00 [Note] [Entrypoint]: Initializing database directory..
2020-10-01 16:06:07+00:00 [Note] [Entrypoint]: Initializing database files
2020-10-01 16:06:08 1 [Warning] Failed to load slave replication state from table mysql.gtid_slave_pos: 1017: Can't find file: './mysql/' (errno: 2 "No such file or directory")

Tag 10.5.5-1 does not exist for safespring/nextcloud-mariadb Docker image

The instruction for building the Docker image produces an image with tag latest. Therefore, the current version of docker-compose.yaml is incorrect.

Wrong format of docker-compose logs command

The option -f of the docker-compose logs command has to come before the service name, as defined in the documentation.

For example

$ docker-compose logs nextcloud-mariadb -f

should be changed to

$ docker-compose logs -f nextcloud-mariadb

The same issues occurs several times in the MariaDB compose README file.

docker build latest fails if mariadb has been updated

The current version of MariaDB as declared in https://mirror.one.com/mariadb/repo/10.5/ubuntu/dists/focal/main/binary-amd64/Packages is newer than the version in the Dockerfile. This leads to an error when building latest.

ERROR:
mariadb-server : Depends: mariadb-server-10.5 (>= 1:10.5.6+maria~focal) but it is not going to be installed
E: Unable to correct problems, you have held broken packages.

If you update the Dockerfile to 10.5.8, building latest works as expected.

Invalid docker-compose.bootstrap.yaml

ubuntu@nx4-db--1:~/nextcloud-db/mariadb/compose$ docker-compose -f docker-compose.yaml -f docker-compose.bootstrap.yaml up -d
ERROR: The Compose file is invalid because:
Service mariadb-server has neither an image nor a build context specified. At least one must be provided.

Should mariadb-server be replaced with nextcloud-mariadb (just to overwrite the default docker-compose.yaml environmnt variables for the bootstrap?