By type
Galera: Finding peers
+ CONTAINER_SCRIPTS_DIR=/usr/share/container-scripts/mysql
+ EXTRA_DEFAULTS_FILE=/etc/my.cnf.d/galera.cnf
+ '[' -z onap ']'
+ echo 'Galera: Finding peers'
++ hostname -f
++ cut -d. -f2
+ K8S_SVC_NAME=vfc-mariadb
+ echo 'Using service name: vfc-mariadb'
+ cp /usr/share/container-scripts/mysql/galera.cnf /etc/my.cnf.d/galera.cnf
Using service name: vfc-mariadb
+ /usr/bin/peer-finder -on-start=/usr/share/container-scripts/mysql/configure-galera.sh -service=vfc-mariadb
2021/04/15 02:34:08 Peer list updated
was []
now [onap-vfc-mariadb-0.vfc-mariadb.onap.svc.cluster.local onap-vfc-mariadb-1.vfc-mariadb.onap.svc.cluster.local onap-vfc-mariadb-2.vfc-mariadb.onap.svc.cluster.local]
2021/04/15 02:34:08 execing: /usr/share/container-scripts/mysql/configure-galera.sh with stdin: onap-vfc-mariadb-0.vfc-mariadb.onap.svc.cluster.local
onap-vfc-mariadb-1.vfc-mariadb.onap.svc.cluster.local
onap-vfc-mariadb-2.vfc-mariadb.onap.svc.cluster.local
2021/04/15 02:34:08
2021/04/15 02:34:09 Peer finder exiting
+ '[' '!' -d /var/lib/mysql/mysql ']'
+ echo 'Configure first time mysql'
+ /usr/share/container-scripts/mysql/configure-mysql.sh
Configure first time mysql
+ echo 'Running mysql_install_db ...'
+ mysql_install_db --datadir=/var/lib/mysql
Running mysql_install_db ...
Installing MariaDB/MySQL system tables in '/var/lib/mysql' ...
2021-04-15 2:34:10 140196230146304 [Note] /usr/sbin/mysqld (mysqld 10.1.24-MariaDB) starting as process 51 ...
2021-04-15 2:34:10 140196230146304 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-04-15 2:34:10 140196230146304 [Note] WSREP: wsrep_load(): loading provider library 'none'
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: innodb_empty_free_list_algorithm has been changed to legacy because of small buffer pool size. In order to use backoff, increase buffer pool at least up to 20MB.
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: The InnoDB memory heap is disabled
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Using Linux native AIO
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Using SSE crc32 instructions
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Completed initialization of buffer pool
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: The first specified data file ./ibdata1 did not exist: a new database to be created!
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Setting file ./ibdata1 size to 12 MB
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Setting log file ./ib_logfile101 size to 48 MB
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Setting log file ./ib_logfile1 size to 48 MB
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Renaming log file ./ib_logfile101 to ./ib_logfile0
2021-04-15 2:34:10 140196230146304 [Warning] InnoDB: New log files created, LSN=45883
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Doublewrite buffer not found: creating new
2021-04-15 2:34:10 140196230146304 [Note] InnoDB: Doublewrite buffer created
2021-04-15 2:34:11 140196230146304 [Note] InnoDB: 128 rollback segment(s) are active.
2021-04-15 2:34:11 140196230146304 [Warning] InnoDB: Creating foreign key constraint system tables.
2021-04-15 2:34:11 140196230146304 [Note] InnoDB: Foreign key constraint system tables created
2021-04-15 2:34:11 140196230146304 [Note] InnoDB: Creating tablespace and datafile system tables.
2021-04-15 2:34:11 140196230146304 [Note] InnoDB: Tablespace and datafile system tables created.
2021-04-15 2:34:11 140196230146304 [Note] InnoDB: Waiting for purge to start
2021-04-15 2:34:11 140196230146304 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 0
2021-04-15 2:34:11 140195445864192 [Note] InnoDB: Dumping buffer pool(s) not yet started
OK
Filling help tables...
2021-04-15 2:34:15 140390849018112 [Note] /usr/sbin/mysqld (mysqld 10.1.24-MariaDB) starting as process 80 ...
2021-04-15 2:34:15 140390849018112 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-04-15 2:34:15 140390849018112 [Note] WSREP: wsrep_load(): loading provider library 'none'
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: innodb_empty_free_list_algorithm has been changed to legacy because of small buffer pool size. In order to use backoff, increase buffer pool at least up to 20MB.
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: The InnoDB memory heap is disabled
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: Using Linux native AIO
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: Using SSE crc32 instructions
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: Completed initialization of buffer pool
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: Highest supported file format is Barracuda.
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: 128 rollback segment(s) are active.
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: Waiting for purge to start
2021-04-15 2:34:15 140390849018112 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616799
2021-04-15 2:34:15 140390069958400 [Note] InnoDB: Dumping buffer pool(s) not yet started
OK
Creating OpenGIS required SP-s...
2021-04-15 2:34:19 140692155017472 [Note] /usr/sbin/mysqld (mysqld 10.1.24-MariaDB) starting as process 110 ...
2021-04-15 2:34:19 140692155017472 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-04-15 2:34:19 140692155017472 [Note] WSREP: wsrep_load(): loading provider library 'none'
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: innodb_empty_free_list_algorithm has been changed to legacy because of small buffer pool size. In order to use backoff, increase buffer pool at least up to 20MB.
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: The InnoDB memory heap is disabled
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: Using Linux native AIO
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: Using SSE crc32 instructions
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: Completed initialization of buffer pool
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: Highest supported file format is Barracuda.
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: 128 rollback segment(s) are active.
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: Waiting for purge to start
2021-04-15 2:34:19 140692155017472 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616809
2021-04-15 2:34:19 140691376174848 [Note] InnoDB: Dumping buffer pool(s) not yet started
OK
To start mysqld at boot time you have to copy
support-files/mysql.server to the right place for your system
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 onap-vfc-mariadb-2 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 http://mariadb.com/kb or the
MySQL manual for more instructions.
You can start the MariaDB daemon with:
cd '/usr' ; /usr/bin/mysqld_safe --datadir='/var/lib/mysql'
You can test the MariaDB daemon with mysql-test-run.pl
cd '/usr/mysql-test' ; perl mysql-test-run.pl
Please report any problems at http://mariadb.org/jira
The latest information about MariaDB is available at http://mariadb.org/.
You can find additional information about the MySQL part at:
http://dev.mysql.com
Consider joining MariaDB's strong and vibrant community:
https://mariadb.org/get-involved/
+ echo 'Finished mysql_install_db'
Finished mysql_install_db
+ pid=137
+ mysqld --skip-networking --socket=/var/lib/mysql/mysql-init.sock --wsrep_on=OFF
+ mysql=(mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock)
+ for i in '{30..0}'
+ echo 'SELECT 1'
+ mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock
+ echo 'MySQL init process in progress...'
+ sleep 1
MySQL init process in progress...
2021-04-15 2:34:23 139888795318528 [Note] mysqld (mysqld 10.1.24-MariaDB) starting as process 137 ...
2021-04-15 2:34:23 139888795318528 [Warning] You need to use --log-bin to make --binlog-format work.
2021-04-15 2:34:23 139888795318528 [Note] InnoDB: innodb_empty_free_list_algorithm has been changed to legacy because of small buffer pool size. In order to use backoff, increase buffer pool at least up to 20MB.
2021-04-15 2:34:23 139888795318528 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-04-15 2:34:23 139888795318528 [Note] InnoDB: The InnoDB memory heap is disabled
2021-04-15 2:34:23 139888795318528 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-04-15 2:34:23 139888795318528 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-04-15 2:34:23 139888795318528 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-04-15 2:34:23 139888795318528 [Note] InnoDB: Using Linux native AIO
2021-04-15 2:34:23 139888795318528 [Note] InnoDB: Using SSE crc32 instructions
2021-04-15 2:34:23 139888795318528 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-04-15 2:34:23 139888795318528 [Note] InnoDB: Completed initialization of buffer pool
2021-04-15 2:34:23 139888795318528 [Note] InnoDB: Highest supported file format is Barracuda.
2021-04-15 2:34:24 139888795318528 [Note] InnoDB: 128 rollback segment(s) are active.
2021-04-15 2:34:24 139888795318528 [Note] InnoDB: Waiting for purge to start
2021-04-15 2:34:24 139888795318528 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616819
2021-04-15 2:34:24 139888011769600 [Note] InnoDB: Dumping buffer pool(s) not yet started
2021-04-15 2:34:24 139888795318528 [Note] Plugin 'FEEDBACK' is disabled.
2021-04-15 2:34:24 139888795318528 [Note] mysqld: ready for connections.
Version: '10.1.24-MariaDB' socket: '/var/lib/mysql/mysql-init.sock' port: 0 MariaDB Server
+ for i in '{30..0}'
+ echo 'SELECT 1'
+ mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock
+ break
+ '[' 29 = 0 ']'
+ '[' -z '' ']'
+ mysql_tzinfo_to_sql /usr/share/zoneinfo
+ sed 's/Local time zone must be set--see zic manual page/FCTY/'
+ mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock mysql
++ prepare_password YuraJayi0+Fumu
++ echo YuraJayi0+Fumu
++ sed -e 's/'\''/\\'\''/g; s/"/\\"/g'
+ mysql_root_password=YuraJayi0+Fumu
+ mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock
+ '[' '!' -z YuraJayi0+Fumu ']'
+ mysql+=(-p"${MYSQL_ROOT_PASSWORD}")
+ mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock -pYuraJayi0+Fumu
+ '[' '' ']'
+ '[' my-user -a BuvaRiwo8=Joru ']'
++ prepare_password BuvaRiwo8=Joru
++ echo BuvaRiwo8=Joru
++ sed -e 's/'\''/\\'\''/g; s/"/\\"/g'
+ mysql_password=BuvaRiwo8=Joru
+ echo 'CREATE USER '\''my-user'\''@'\''%'\'' IDENTIFIED BY '\''BuvaRiwo8=Joru'\'' ;'
+ mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock -pYuraJayi0+Fumu
+ '[' '' ']'
+ echo 'FLUSH PRIVILEGES ;'
+ mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock -pYuraJayi0+Fumu
+ kill -s TERM 137
+ wait 137
2021-04-15 2:34:28 139888794467072 [Note] mysqld: Normal shutdown
2021-04-15 2:34:28 139888794467072 [Note] Event Scheduler: Purging the queue. 0 events
2021-04-15 2:34:28 139887994984192 [Note] InnoDB: FTS optimize thread exiting.
2021-04-15 2:34:28 139888794467072 [Note] InnoDB: Starting shutdown...
2021-04-15 2:34:29 139888794467072 [Note] InnoDB: Waiting for page_cleaner to finish flushing of buffer pool
2021-04-15 2:34:30 139888794467072 [Note] InnoDB: Shutdown completed; log sequence number 1616829
2021-04-15 2:34:30 139888794467072 [Note] mysqld: Shutdown complete
+ echo
+ echo 'MySQL init process done. Ready for start up.'
+ echo
MySQL init process done. Ready for start up.
+ exec mysqld
2021-04-15 2:34:31 140462466300160 [Note] mysqld (mysqld 10.1.24-MariaDB) starting as process 1 ...
2021-04-15 2:34:31 140462466300160 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-04-15 2:34:31 140462466300160 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib64/galera/libgalera_smm.so'
2021-04-15 2:34:31 140462466300160 [Note] WSREP: wsrep_load(): Galera 25.3.20(r3703) by Codership Oy loaded successfully.
2021-04-15 2:34:31 140462466300160 [Note] WSREP: CRC-32C: using hardware acceleration.
2021-04-15 2:34:31 140462466300160 [Warning] WSREP: Could not open state file for reading: '/var/lib/mysql//grastate.dat'
2021-04-15 2:34:31 140462466300160 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1, safe_to_bootsrap: 1
2021-04-15 2:34:31 140462466300160 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = onap-vfc-mariadb-2.vfc-mariadb.onap.svc.cluster.local; base_port = 4567; cert.log_conflicts = no; 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 = /var/lib/mysql//galera.cache; gcache.page_size = 128M; gcache.recover = no; gcache.size = 128M; 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_
2021-04-15 2:34:31 140462466300160 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(00000000-0000-0000-0000-000000000000:-1)
2021-04-15 2:34:31 140462466300160 [Note] WSREP: Assign initial position for certification: -1, protocol version: -1
2021-04-15 2:34:31 140462466300160 [Note] WSREP: wsrep_sst_grab()
2021-04-15 2:34:31 140462466300160 [Note] WSREP: Start replication
2021-04-15 2:34:31 140462466300160 [Note] WSREP: Setting initial position to 00000000-0000-0000-0000-000000000000:-1
2021-04-15 2:34:31 140462466300160 [Note] WSREP: protonet asio version 0
2021-04-15 2:34:31 140462466300160 [Note] WSREP: Using CRC-32C for message checksums.
2021-04-15 2:34:31 140462466300160 [Note] WSREP: backend: asio
2021-04-15 2:34:31 140462466300160 [Note] WSREP: gcomm thread scheduling priority set to other:0
2021-04-15 2:34:31 140462466300160 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)
2021-04-15 2:34:31 140462466300160 [Note] WSREP: restore pc from disk failed
2021-04-15 2:34:31 140462466300160 [Note] WSREP: GMCast version 0
2021-04-15 2:34:31 140462466300160 [Note] WSREP: (1ba13098, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2021-04-15 2:34:31 140462466300160 [Note] WSREP: (1ba13098, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2021-04-15 2:34:31 140462466300160 [Note] WSREP: EVS version 0
2021-04-15 2:34:31 140462466300160 [Note] WSREP: gcomm: connecting to group 'vfc-mariadb', peer 'onap-vfc-mariadb-0.vfc-mariadb.onap.svc.cluster.local:,onap-vfc-mariadb-1.vfc-mariadb.onap.svc.cluster.local:,onap-vfc-mariadb-2.vfc-mariadb.onap.svc.cluster.local:'
2021-04-15 2:34:31 140462466300160 [Note] WSREP: (1ba13098, 'tcp://0.0.0.0:4567') connection established to 1ba13098 tcp://10.233.70.152:4567
2021-04-15 2:34:31 140462466300160 [Warning] WSREP: (1ba13098, 'tcp://0.0.0.0:4567') address 'tcp://10.233.70.152:4567' points to own listening address, blacklisting
2021-04-15 2:34:31 140462466300160 [Note] WSREP: (1ba13098, 'tcp://0.0.0.0:4567') connection established to ef9b323f tcp://10.233.76.22:4567
2021-04-15 2:34:31 140462466300160 [Note] WSREP: (1ba13098, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2021-04-15 2:34:31 140462466300160 [Note] WSREP: (1ba13098, 'tcp://0.0.0.0:4567') connection established to d47e55a7 tcp://10.233.77.123:4567
2021-04-15 2:34:31 140462466300160 [Note] WSREP: declaring d47e55a7 at tcp://10.233.77.123:4567 stable
2021-04-15 2:34:31 140462466300160 [Note] WSREP: declaring ef9b323f at tcp://10.233.76.22:4567 stable
2021-04-15 2:34:31 140462466300160 [Note] WSREP: Node d47e55a7 state prim
2021-04-15 2:34:31 140462466300160 [Note] WSREP: view(view_id(PRIM,1ba13098,3) memb {
1ba13098,0
d47e55a7,0
ef9b323f,0
} joined {
} left {
} partitioned {
})
2021-04-15 2:34:31 140462466300160 [Note] WSREP: save pc into disk
2021-04-15 2:34:32 140462466300160 [Note] WSREP: gcomm: connected
2021-04-15 2:34:32 140462466300160 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2021-04-15 2:34:32 140462466300160 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2021-04-15 2:34:32 140462466300160 [Note] WSREP: Opened channel 'vfc-mariadb'
2021-04-15 2:34:32 140462466300160 [Note] WSREP: Waiting for SST to complete.
2021-04-15 2:34:32 140462144874240 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 3
2021-04-15 2:34:32 140462144874240 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 1c3ab02c-9d93-11eb-a135-3697528ca480
2021-04-15 2:34:32 140462144874240 [Note] WSREP: STATE EXCHANGE: sent state msg: 1c3ab02c-9d93-11eb-a135-3697528ca480
2021-04-15 2:34:32 140462144874240 [Note] WSREP: STATE EXCHANGE: got state msg: 1c3ab02c-9d93-11eb-a135-3697528ca480 from 1 (onap-vfc-mariadb-0)
2021-04-15 2:34:32 140462144874240 [Note] WSREP: STATE EXCHANGE: got state msg: 1c3ab02c-9d93-11eb-a135-3697528ca480 from 2 (onap-vfc-mariadb-1)
2021-04-15 2:34:32 140462144874240 [Note] WSREP: STATE EXCHANGE: got state msg: 1c3ab02c-9d93-11eb-a135-3697528ca480 from 0 (onap-vfc-mariadb-2)
2021-04-15 2:34:32 140462144874240 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 2,
members = 2/3 (joined/total),
act_id = 0,
last_appl. = -1,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = d47f2847-9d92-11eb-aee4-6bcf6fbe6f72
2021-04-15 2:34:32 140462144874240 [Note] WSREP: Flow-control interval: [28, 28]
2021-04-15 2:34:32 140462144874240 [Note] WSREP: Shifting OPEN -> PRIMARY (TO: 0)
2021-04-15 2:34:32 140462465850112 [Note] WSREP: State transfer required:
Group state: d47f2847-9d92-11eb-aee4-6bcf6fbe6f72:0
Local state: 00000000-0000-0000-0000-000000000000:-1
2021-04-15 2:34:32 140462465850112 [Note] WSREP: New cluster view: global state: d47f2847-9d92-11eb-aee4-6bcf6fbe6f72:0, view# 3: Primary, number of nodes: 3, my index: 0, protocol version 3
2021-04-15 2:34:32 140462465850112 [Warning] WSREP: Gap in state sequence. Need state transfer.
2021-04-15 2:34:32 140462115518208 [Note] WSREP: Running: 'wsrep_sst_xtrabackup-v2 --role 'joiner' --address 'onap-vfc-mariadb-2.vfc-mariadb.onap.svc.cluster.local' --datadir '/var/lib/mysql/' --parent '1' '' '
2021-04-15 2:34:34 140462153266944 [Note] WSREP: (1ba13098, 'tcp://0.0.0.0:4567') connection to peer 1ba13098 with addr tcp://10.233.70.152:4567 timed out, no messages seen in PT3S
2021-04-15 2:34:34 140462153266944 [Note] WSREP: (1ba13098, 'tcp://0.0.0.0:4567') turning message relay requesting off
WSREP_SST: [INFO] Streaming with xbstream (20210415 02:34:35.015)
WSREP_SST: [INFO] Using socat as streamer (20210415 02:34:35.021)
WSREP_SST: [INFO] Evaluating timeout -k 110 100 socat -u TCP-LISTEN:4444,reuseaddr stdio | xbstream -x; RC=( ${PIPESTATUS[@]} ) (20210415 02:34:35.218)
2021-04-15 2:34:35 140462465850112 [Note] WSREP: Prepared SST request: xtrabackup-v2|onap-vfc-mariadb-2.vfc-mariadb.onap.svc.cluster.local:4444/xtrabackup_sst//1
2021-04-15 2:34:35 140462465850112 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-04-15 2:34:35 140462465850112 [Note] WSREP: REPL Protocols: 7 (3, 2)
2021-04-15 2:34:35 140462465850112 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
2021-04-15 2:34:35 140462203180800 [Note] WSREP: Service thread queue flushed.
2021-04-15 2:34:35 140462465850112 [Warning] WSREP: Failed to prepare for incremental state transfer: Local state UUID (00000000-0000-0000-0000-000000000000) does not match group state UUID (d47f2847-9d92-11eb-aee4-6bcf6fbe6f72): 1 (Operation not permitted)
at galera/src/replicator_str.cpp:prepare_for_IST():482. IST will be unavailable.
2021-04-15 2:34:35 140462144874240 [Note] WSREP: Member 0.0 (onap-vfc-mariadb-2) requested state transfer from '*any*'. Selected 1.0 (onap-vfc-mariadb-0)(SYNCED) as donor.
2021-04-15 2:34:35 140462144874240 [Note] WSREP: Shifting PRIMARY -> JOINER (TO: 0)
2021-04-15 2:34:35 140462465850112 [Note] WSREP: Requesting state transfer: success, donor: 1
2021-04-15 2:34:35 140462465850112 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(d47f2847-9d92-11eb-aee4-6bcf6fbe6f72:0)
WSREP_SST: [INFO] Proceeding with SST (20210415 02:34:37.027)
WSREP_SST: [INFO] Cleaning the existing datadir and innodb-data/log directories (20210415 02:34:37.032)
WSREP_SST: [INFO] Evaluating socat -u TCP-LISTEN:4444,reuseaddr stdio | xbstream -x; RC=( ${PIPESTATUS[@]} ) (20210415 02:34:37.031)
removed '/var/lib/mysql/mysql/db.frm'
removed '/var/lib/mysql/mysql/db.MYI'
removed '/var/lib/mysql/mysql/db.MYD'
removed '/var/lib/mysql/mysql/host.frm'
removed '/var/lib/mysql/mysql/host.MYI'
removed '/var/lib/mysql/mysql/host.MYD'
removed '/var/lib/mysql/mysql/user.frm'
removed '/var/lib/mysql/mysql/user.MYI'
removed '/var/lib/mysql/mysql/user.MYD'
removed '/var/lib/mysql/mysql/roles_mapping.frm'
removed '/var/lib/mysql/mysql/roles_mapping.MYI'
removed '/var/lib/mysql/mysql/roles_mapping.MYD'
removed '/var/lib/mysql/mysql/func.frm'
removed '/var/lib/mysql/mysql/func.MYI'
removed '/var/lib/mysql/mysql/func.MYD'
removed '/var/lib/mysql/mysql/plugin.frm'
removed '/var/lib/mysql/mysql/plugin.MYI'
removed '/var/lib/mysql/mysql/plugin.MYD'
removed '/var/lib/mysql/mysql/servers.frm'
removed '/var/lib/mysql/mysql/servers.MYI'
removed '/var/lib/mysql/mysql/servers.MYD'
removed '/var/lib/mysql/mysql/tables_priv.frm'
removed '/var/lib/mysql/mysql/tables_priv.MYI'
removed '/var/lib/mysql/mysql/tables_priv.MYD'
removed '/var/lib/mysql/mysql/columns_priv.frm'
removed '/var/lib/mysql/mysql/columns_priv.MYI'
removed '/var/lib/mysql/mysql/columns_priv.MYD'
removed '/var/lib/mysql/mysql/help_topic.frm'
removed '/var/lib/mysql/mysql/help_topic.MYI'
removed '/var/lib/mysql/mysql/help_topic.MYD'
removed '/var/lib/mysql/mysql/help_category.frm'
removed '/var/lib/mysql/mysql/help_category.MYI'
removed '/var/lib/mysql/mysql/help_category.MYD'
removed '/var/lib/mysql/mysql/help_relation.frm'
removed '/var/lib/mysql/mysql/help_relation.MYI'
removed '/var/lib/mysql/mysql/help_relation.MYD'
removed '/var/lib/mysql/mysql/help_keyword.frm'
removed '/var/lib/mysql/mysql/help_keyword.MYI'
removed '/var/lib/mysql/mysql/help_keyword.MYD'
removed '/var/lib/mysql/mysql/time_zone_name.frm'
removed '/var/lib/mysql/mysql/time_zone_name.MYI'
removed '/var/lib/mysql/mysql/time_zone_name.MYD'
removed '/var/lib/mysql/mysql/time_zone.frm'
removed '/var/lib/mysql/mysql/time_zone.MYI'
removed '/var/lib/mysql/mysql/time_zone.MYD'
removed '/var/lib/mysql/mysql/time_zone_transition_type.MYI'
removed '/var/lib/mysql/mysql/time_zone_transition_type.MYD'
removed '/var/lib/mysql/mysql/time_zone_transition_type.frm'
removed '/var/lib/mysql/mysql/time_zone_leap_second.frm'
removed '/var/lib/mysql/mysql/time_zone_leap_second.MYI'
removed '/var/lib/mysql/mysql/time_zone_leap_second.MYD'
removed '/var/lib/mysql/mysql/proc.frm'
removed '/var/lib/mysql/mysql/proc.MYI'
removed '/var/lib/mysql/mysql/proc.MYD'
removed '/var/lib/mysql/mysql/procs_priv.frm'
removed '/var/lib/mysql/mysql/procs_priv.MYI'
removed '/var/lib/mysql/mysql/procs_priv.MYD'
removed '/var/lib/mysql/mysql/general_log.frm'
removed '/var/lib/mysql/mysql/general_log.CSM'
removed '/var/lib/mysql/mysql/general_log.CSV'
removed '/var/lib/mysql/mysql/slow_log.frm'
removed '/var/lib/mysql/mysql/slow_log.CSM'
removed '/var/lib/mysql/mysql/slow_log.CSV'
removed '/var/lib/mysql/mysql/event.frm'
removed '/var/lib/mysql/mysql/event.MYI'
removed '/var/lib/mysql/mysql/event.MYD'
removed '/var/lib/mysql/mysql/innodb_table_stats.frm'
removed '/var/lib/mysql/mysql/innodb_table_stats.ibd'
removed '/var/lib/mysql/mysql/innodb_index_stats.frm'
removed '/var/lib/mysql/mysql/innodb_index_stats.ibd'
removed '/var/lib/mysql/mysql/proxies_priv.frm'
removed '/var/lib/mysql/mysql/proxies_priv.MYI'
removed '/var/lib/mysql/mysql/proxies_priv.MYD'
removed '/var/lib/mysql/mysql/table_stats.frm'
removed '/var/lib/mysql/mysql/table_stats.MYI'
removed '/var/lib/mysql/mysql/table_stats.MYD'
removed '/var/lib/mysql/mysql/column_stats.frm'
removed '/var/lib/mysql/mysql/column_stats.MYI'
removed '/var/lib/mysql/mysql/column_stats.MYD'
removed '/var/lib/mysql/mysql/index_stats.frm'
removed '/var/lib/mysql/mysql/index_stats.MYI'
removed '/var/lib/mysql/mysql/index_stats.MYD'
removed '/var/lib/mysql/mysql/gtid_slave_pos.frm'
removed '/var/lib/mysql/mysql/gtid_slave_pos.ibd'
removed '/var/lib/mysql/mysql/time_zone_transition.MYI'
removed '/var/lib/mysql/mysql/time_zone_transition.MYD'
removed '/var/lib/mysql/mysql/time_zone_transition.frm'
removed directory: '/var/lib/mysql/mysql'
removed '/var/lib/mysql/aria_log_control'
removed '/var/lib/mysql/aria_log.00000001'
removed '/var/lib/mysql/ibdata1'
removed '/var/lib/mysql/ib_logfile1'
removed '/var/lib/mysql/ib_logfile0'
removed '/var/lib/mysql/performance_schema/db.opt'
removed directory: '/var/lib/mysql/performance_schema'
removed '/var/lib/mysql/multi-master.info'
WSREP_SST: [INFO] Waiting for SST streaming to complete! (20210415 02:34:37.188)
2021-04-15 2:34:48 140462144874240 [Note] WSREP: 1.0 (onap-vfc-mariadb-0): State transfer to 0.0 (onap-vfc-mariadb-2) complete.
2021-04-15 2:34:48 140462144874240 [Note] WSREP: Member 1.0 (onap-vfc-mariadb-0) synced with group.
WSREP_SST: [INFO] Preparing the backup at /var/lib/mysql//.sst (20210415 02:34:48.819)
WSREP_SST: [INFO] Evaluating innobackupex --no-version-check --apply-log $rebuildcmd ${DATA} &>${DATA}/innobackup.prepare.log (20210415 02:34:48.822)
rm: cannot remove '/var/lib/mysql//innobackup.prepare.log': No such file or directory
rm: cannot remove '/var/lib/mysql//innobackup.move.log': No such file or directory
WSREP_SST: [INFO] Moving the backup to /var/lib/mysql/ (20210415 02:34:52.318)
WSREP_SST: [INFO] Evaluating innobackupex --no-version-check --move-back --force-non-empty-directories ${DATA} &>${DATA}/innobackup.move.log (20210415 02:34:52.324)
WSREP_SST: [INFO] Move successful, removing /var/lib/mysql//.sst (20210415 02:34:52.726)
WSREP_SST: [INFO] Galera co-ords from recovery: d47f2847-9d92-11eb-aee4-6bcf6fbe6f72:0 (20210415 02:34:52.751)
WSREP_SST: [INFO] Total time on joiner: 0 seconds (20210415 02:34:52.759)
WSREP_SST: [INFO] Removing the sst_in_progress file (20210415 02:34:52.764)
2021-04-15 2:34:52 140462466300160 [Note] WSREP: SST complete, seqno: 0
2021-04-15 2:34:52 140462466300160 [Note] InnoDB: innodb_empty_free_list_algorithm has been changed to legacy because of small buffer pool size. In order to use backoff, increase buffer pool at least up to 20MB.
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: The InnoDB memory heap is disabled
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: Using Linux native AIO
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: Using SSE crc32 instructions
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: Completed initialization of buffer pool
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: Highest supported file format is Barracuda.
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: 128 rollback segment(s) are active.
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: Waiting for purge to start
2021-04-15 2:34:53 140462466300160 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1617430
2021-04-15 2:34:53 140461457012480 [Note] InnoDB: Dumping buffer pool(s) not yet started
2021-04-15 2:34:53 140462466300160 [Note] Plugin 'FEEDBACK' is disabled.
2021-04-15 2:34:53 140462466300160 [Note] Server socket created on IP: '0.0.0.0'.
2021-04-15 2:34:53 140462466300160 [Note] WSREP: Signalling provider to continue.
2021-04-15 2:34:53 140462466300160 [Note] WSREP: SST received: d47f2847-9d92-11eb-aee4-6bcf6fbe6f72:0
2021-04-15 2:34:53 140462144874240 [Note] WSREP: 0.0 (onap-vfc-mariadb-2): State transfer from 1.0 (onap-vfc-mariadb-0) complete.
2021-04-15 2:34:53 140462144874240 [Note] WSREP: Shifting JOINER -> JOINED (TO: 0)
2021-04-15 2:34:53 140462144874240 [Note] WSREP: Member 0.0 (onap-vfc-mariadb-2) synced with group.
2021-04-15 2:34:53 140462144874240 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 0)
2021-04-15 2:34:53 140462465850112 [Note] WSREP: Synchronized with group, ready for connections
2021-04-15 2:34:53 140462465850112 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-04-15 2:34:53 140462466300160 [Note] mysqld: ready for connections.
Version: '10.1.24-MariaDB' socket: '/var/lib/mysql/mysql.sock' port: 3306 MariaDB Server
2021-04-15 2:35:52 140462388636416 [Warning] IP address '10.233.78.63' could not be resolved: Name or service not known