By type
+ CONTAINER_SCRIPTS_DIR=/usr/share/container-scripts/mysql
+ EXTRA_DEFAULTS_FILE=/etc/my.cnf.d/galera.cnf
+ '[' -z onap ']'
+ echo 'Galera: Finding peers'
Galera: Finding peers
++ hostname -f
++ cut -d. -f2
+ K8S_SVC_NAME=appc-dbhost
+ echo 'Using service name: appc-dbhost'
+ cp /usr/share/container-scripts/mysql/galera.cnf /etc/my.cnf.d/galera.cnf
Using service name: appc-dbhost
+ /usr/bin/peer-finder -on-start=/usr/share/container-scripts/mysql/configure-galera.sh -service=appc-dbhost
2021/05/31 01:55:11 Peer list updated
was []
now [onap-appc-db-0.appc-dbhost.onap.svc.cluster.local]
2021/05/31 01:55:11 execing: /usr/share/container-scripts/mysql/configure-galera.sh with stdin: onap-appc-db-0.appc-dbhost.onap.svc.cluster.local
2021/05/31 01:55:11
2021/05/31 01:55:12 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-05-31 1:55:12 139870158354688 [Note] /usr/sbin/mysqld (mysqld 10.1.24-MariaDB) starting as process 50 ...
2021-05-31 1:55:12 139870158354688 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-05-31 1:55:12 139870158354688 [Note] WSREP: wsrep_load(): loading provider library 'none'
2021-05-31 1:55:12 139870158354688 [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-05-31 1:55:13 139870158354688 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: The InnoDB memory heap is disabled
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Using Linux native AIO
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Using SSE crc32 instructions
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Completed initialization of buffer pool
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: The first specified data file ./ibdata1 did not exist: a new database to be created!
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Setting file ./ibdata1 size to 12 MB
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Setting log file ./ib_logfile101 size to 48 MB
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Setting log file ./ib_logfile1 size to 48 MB
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Renaming log file ./ib_logfile101 to ./ib_logfile0
2021-05-31 1:55:13 139870158354688 [Warning] InnoDB: New log files created, LSN=45883
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Doublewrite buffer not found: creating new
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Doublewrite buffer created
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: 128 rollback segment(s) are active.
2021-05-31 1:55:13 139870158354688 [Warning] InnoDB: Creating foreign key constraint system tables.
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Foreign key constraint system tables created
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Creating tablespace and datafile system tables.
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Tablespace and datafile system tables created.
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Waiting for purge to start
2021-05-31 1:55:13 139870158354688 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 0
2021-05-31 1:55:13 139869368088320 [Note] InnoDB: Dumping buffer pool(s) not yet started
OK
Filling help tables...
2021-05-31 1:55:17 139996274616576 [Note] /usr/sbin/mysqld (mysqld 10.1.24-MariaDB) starting as process 79 ...
2021-05-31 1:55:17 139996274616576 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-05-31 1:55:17 139996274616576 [Note] WSREP: wsrep_load(): loading provider library 'none'
2021-05-31 1:55:17 139996274616576 [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-05-31 1:55:17 139996274616576 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-05-31 1:55:17 139996274616576 [Note] InnoDB: The InnoDB memory heap is disabled
2021-05-31 1:55:17 139996274616576 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-05-31 1:55:17 139996274616576 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-05-31 1:55:17 139996274616576 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-05-31 1:55:17 139996274616576 [Note] InnoDB: Using Linux native AIO
2021-05-31 1:55:17 139996274616576 [Note] InnoDB: Using SSE crc32 instructions
2021-05-31 1:55:17 139996274616576 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-05-31 1:55:17 139996274616576 [Note] InnoDB: Completed initialization of buffer pool
2021-05-31 1:55:17 139996274616576 [Note] InnoDB: Highest supported file format is Barracuda.
2021-05-31 1:55:17 139996274616576 [Note] InnoDB: 128 rollback segment(s) are active.
2021-05-31 1:55:17 139996274616576 [Note] InnoDB: Waiting for purge to start
2021-05-31 1:55:17 139996274616576 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616799
2021-05-31 1:55:17 139995495003904 [Note] InnoDB: Dumping buffer pool(s) not yet started
OK
Creating OpenGIS required SP-s...
2021-05-31 1:55:21 139942138951936 [Note] /usr/sbin/mysqld (mysqld 10.1.24-MariaDB) starting as process 108 ...
2021-05-31 1:55:21 139942138951936 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-05-31 1:55:21 139942138951936 [Note] WSREP: wsrep_load(): loading provider library 'none'
2021-05-31 1:55:21 139942138951936 [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-05-31 1:55:22 139942138951936 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-05-31 1:55:22 139942138951936 [Note] InnoDB: The InnoDB memory heap is disabled
2021-05-31 1:55:22 139942138951936 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-05-31 1:55:22 139942138951936 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-05-31 1:55:22 139942138951936 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-05-31 1:55:22 139942138951936 [Note] InnoDB: Using Linux native AIO
2021-05-31 1:55:22 139942138951936 [Note] InnoDB: Using SSE crc32 instructions
2021-05-31 1:55:22 139942138951936 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-05-31 1:55:22 139942138951936 [Note] InnoDB: Completed initialization of buffer pool
2021-05-31 1:55:22 139942138951936 [Note] InnoDB: Highest supported file format is Barracuda.
2021-05-31 1:55:22 139942138951936 [Note] InnoDB: 128 rollback segment(s) are active.
2021-05-31 1:55:22 139942138951936 [Note] InnoDB: Waiting for purge to start
2021-05-31 1:55:22 139942138951936 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616809
2021-05-31 1:55:22 139941359122176 [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-appc-db-0 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
+ echo 'Finished mysql_install_db'
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/
Finished mysql_install_db
+ pid=136
+ 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-05-31 1:55:26 140567503968512 [Note] mysqld (mysqld 10.1.24-MariaDB) starting as process 136 ...
2021-05-31 1:55:26 140567503968512 [Warning] You need to use --log-bin to make --binlog-format work.
2021-05-31 1:55:26 140567503968512 [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-05-31 1:55:26 140567503968512 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-05-31 1:55:26 140567503968512 [Note] InnoDB: The InnoDB memory heap is disabled
2021-05-31 1:55:26 140567503968512 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-05-31 1:55:26 140567503968512 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-05-31 1:55:26 140567503968512 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-05-31 1:55:26 140567503968512 [Note] InnoDB: Using Linux native AIO
2021-05-31 1:55:26 140567503968512 [Note] InnoDB: Using SSE crc32 instructions
2021-05-31 1:55:26 140567503968512 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-05-31 1:55:26 140567503968512 [Note] InnoDB: Completed initialization of buffer pool
2021-05-31 1:55:26 140567503968512 [Note] InnoDB: Highest supported file format is Barracuda.
2021-05-31 1:55:26 140567503968512 [Note] InnoDB: 128 rollback segment(s) are active.
2021-05-31 1:55:26 140567503968512 [Note] InnoDB: Waiting for purge to start
2021-05-31 1:55:26 140567503968512 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616819
2021-05-31 1:55:26 140566725654272 [Note] InnoDB: Dumping buffer pool(s) not yet started
2021-05-31 1:55:26 140567503968512 [Note] Plugin 'FEEDBACK' is disabled.
2021-05-31 1:55:26 140567503968512 [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 'Pedo3^LuyeRaro'
++ echo 'Pedo3^LuyeRaro'
++ sed -e 's/'\''/\\'\''/g; s/"/\\"/g'
+ mysql_root_password='Pedo3^LuyeRaro'
+ mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock
+ '[' '!' -z 'Pedo3^LuyeRaro' ']'
+ mysql+=(-p"${MYSQL_ROOT_PASSWORD}")
+ mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock '-pPedo3^LuyeRaro'
+ '[' '' ']'
+ '[' my-user -a PesiBiqa5#Puji ']'
++ prepare_password PesiBiqa5#Puji
++ echo PesiBiqa5#Puji
++ sed -e 's/'\''/\\'\''/g; s/"/\\"/g'
+ mysql_password=PesiBiqa5#Puji
+ echo 'CREATE USER '\''my-user'\''@'\''%'\'' IDENTIFIED BY '\''PesiBiqa5#Puji'\'' ;'
+ mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock '-pPedo3^LuyeRaro'
+ '[' '' ']'
+ echo 'FLUSH PRIVILEGES ;'
+ mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock '-pPedo3^LuyeRaro'
+ kill -s TERM 136
+ wait 136
2021-05-31 1:55:31 140567503117056 [Note] mysqld: Normal shutdown
2021-05-31 1:55:31 140567503117056 [Note] Event Scheduler: Purging the queue. 0 events
2021-05-31 1:55:31 140566708868864 [Note] InnoDB: FTS optimize thread exiting.
2021-05-31 1:55:31 140567503117056 [Note] InnoDB: Starting shutdown...
2021-05-31 1:55:31 140567503117056 [Note] InnoDB: Waiting for page_cleaner to finish flushing of buffer pool
2021-05-31 1:55:33 140567503117056 [Note] InnoDB: Shutdown completed; log sequence number 1616829
2021-05-31 1:55:33 140567503117056 [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-05-31 1:55:33 140178589772032 [Note] mysqld (mysqld 10.1.24-MariaDB) starting as process 1 ...
2021-05-31 1:55:33 140178589772032 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-05-31 1:55:33 140178589772032 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib64/galera/libgalera_smm.so'
2021-05-31 1:55:33 140178589772032 [Note] WSREP: wsrep_load(): Galera 25.3.20(r3703) by Codership Oy loaded successfully.
2021-05-31 1:55:33 140178589772032 [Note] WSREP: CRC-32C: using hardware acceleration.
2021-05-31 1:55:33 140178589772032 [Warning] WSREP: Could not open state file for reading: '/var/lib/mysql//grastate.dat'
2021-05-31 1:55:33 140178589772032 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1, safe_to_bootsrap: 1
2021-05-31 1:55:33 140178589772032 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = onap-appc-db-0.appc-dbhost.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_time
2021-05-31 1:55:34 140178589772032 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(00000000-0000-0000-0000-000000000000:-1)
2021-05-31 1:55:34 140178589772032 [Note] WSREP: Assign initial position for certification: -1, protocol version: -1
2021-05-31 1:55:34 140178589772032 [Note] WSREP: wsrep_sst_grab()
2021-05-31 1:55:34 140178589772032 [Note] WSREP: Start replication
2021-05-31 1:55:34 140178589772032 [Note] WSREP: Setting initial position to 00000000-0000-0000-0000-000000000000:-1
2021-05-31 1:55:34 140178589772032 [Note] WSREP: protonet asio version 0
2021-05-31 1:55:34 140178589772032 [Note] WSREP: Using CRC-32C for message checksums.
2021-05-31 1:55:34 140178589772032 [Note] WSREP: backend: asio
2021-05-31 1:55:34 140178589772032 [Note] WSREP: gcomm thread scheduling priority set to other:0
2021-05-31 1:55:34 140178589772032 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)
2021-05-31 1:55:34 140178589772032 [Note] WSREP: restore pc from disk failed
2021-05-31 1:55:34 140178589772032 [Note] WSREP: GMCast version 0
2021-05-31 1:55:34 140178589772032 [Note] WSREP: (496c71f7, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2021-05-31 1:55:34 140178589772032 [Note] WSREP: (496c71f7, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2021-05-31 1:55:34 140178589772032 [Note] WSREP: EVS version 0
2021-05-31 1:55:34 140178589772032 [Note] WSREP: gcomm: connecting to group 'appc-dbhost', peer ''
2021-05-31 1:55:34 140178589772032 [Note] WSREP: start_prim is enabled, turn off pc_recovery
2021-05-31 1:55:34 140178589772032 [Note] WSREP: Node 496c71f7 state prim
2021-05-31 1:55:34 140178589772032 [Note] WSREP: view(view_id(PRIM,496c71f7,1) memb {
496c71f7,0
} joined {
} left {
} partitioned {
})
2021-05-31 1:55:34 140178589772032 [Note] WSREP: save pc into disk
2021-05-31 1:55:34 140178589772032 [Note] WSREP: gcomm: connected
2021-05-31 1:55:34 140178589772032 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2021-05-31 1:55:34 140178589772032 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2021-05-31 1:55:34 140178589772032 [Note] WSREP: Opened channel 'appc-dbhost'
2021-05-31 1:55:34 140178589772032 [Note] WSREP: Waiting for SST to complete.
2021-05-31 1:55:34 140178265990912 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
2021-05-31 1:55:34 140178265990912 [Note] WSREP: Starting new group from scratch: 496d3d6b-c1b3-11eb-8c26-9bbcdd85ad92
2021-05-31 1:55:34 140178265990912 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 496d41d1-c1b3-11eb-9edb-d7d5b3f6790a
2021-05-31 1:55:34 140178265990912 [Note] WSREP: STATE EXCHANGE: sent state msg: 496d41d1-c1b3-11eb-9edb-d7d5b3f6790a
2021-05-31 1:55:34 140178265990912 [Note] WSREP: STATE EXCHANGE: got state msg: 496d41d1-c1b3-11eb-9edb-d7d5b3f6790a from 0 (onap-appc-db-0)
2021-05-31 1:55:34 140178265990912 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 0,
members = 1/1 (joined/total),
act_id = 0,
last_appl. = -1,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 496d3d6b-c1b3-11eb-8c26-9bbcdd85ad92
2021-05-31 1:55:34 140178265990912 [Note] WSREP: Flow-control interval: [16, 16]
2021-05-31 1:55:34 140178265990912 [Note] WSREP: Restored state OPEN -> JOINED (0)
2021-05-31 1:55:34 140178265990912 [Note] WSREP: Member 0.0 (onap-appc-db-0) synced with group.
2021-05-31 1:55:34 140178265990912 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 0)
2021-05-31 1:55:34 140178589321984 [Note] WSREP: New cluster view: global state: 496d3d6b-c1b3-11eb-8c26-9bbcdd85ad92:0, view# 1: Primary, number of nodes: 1, my index: 0, protocol version 3
2021-05-31 1:55:34 140178589772032 [Note] WSREP: SST complete, seqno: 0
2021-05-31 1:55:34 140178589772032 [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-05-31 1:55:34 140178589772032 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-05-31 1:55:34 140178589772032 [Note] InnoDB: The InnoDB memory heap is disabled
2021-05-31 1:55:34 140178589772032 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-05-31 1:55:34 140178589772032 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-05-31 1:55:34 140178589772032 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-05-31 1:55:34 140178589772032 [Note] InnoDB: Using Linux native AIO
2021-05-31 1:55:34 140178589772032 [Note] InnoDB: Using SSE crc32 instructions
2021-05-31 1:55:34 140178589772032 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-05-31 1:55:34 140178589772032 [Note] InnoDB: Completed initialization of buffer pool
2021-05-31 1:55:34 140178589772032 [Note] InnoDB: Highest supported file format is Barracuda.
2021-05-31 1:55:34 140178589772032 [Note] InnoDB: 128 rollback segment(s) are active.
2021-05-31 1:55:34 140178589772032 [Note] InnoDB: Waiting for purge to start
2021-05-31 1:55:34 140178589772032 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616829
2021-05-31 1:55:34 140177582323456 [Note] InnoDB: Dumping buffer pool(s) not yet started
2021-05-31 1:55:34 140178589772032 [Note] Plugin 'FEEDBACK' is disabled.
2021-05-31 1:55:34 140178589772032 [Note] Server socket created on IP: '0.0.0.0'.
2021-05-31 1:55:34 140178589321984 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-05-31 1:55:34 140178589321984 [Note] WSREP: REPL Protocols: 7 (3, 2)
2021-05-31 1:55:34 140178589321984 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
2021-05-31 1:55:34 140178324297472 [Note] WSREP: Service thread queue flushed.
2021-05-31 1:55:34 140178589321984 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(496d3d6b-c1b3-11eb-8c26-9bbcdd85ad92:0)
2021-05-31 1:55:34 140178589321984 [Note] WSREP: Synchronized with group, ready for connections
2021-05-31 1:55:34 140178589321984 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-05-31 1:55:34 140178589772032 [Note] mysqld: ready for connections.
Version: '10.1.24-MariaDB' socket: '/var/lib/mysql/mysql.sock' port: 3306 MariaDB Server
2021-05-31 2:01:54 140178274383616 [Note] WSREP: (496c71f7, 'tcp://0.0.0.0:4567') connection established to 2c7d8b6b tcp://10.233.72.135:4567
2021-05-31 2:01:54 140178274383616 [Note] WSREP: (496c71f7, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2021-05-31 2:01:55 140178274383616 [Note] WSREP: declaring 2c7d8b6b at tcp://10.233.72.135:4567 stable
2021-05-31 2:01:55 140178274383616 [Note] WSREP: Node 496c71f7 state prim
2021-05-31 2:01:55 140178274383616 [Note] WSREP: view(view_id(PRIM,2c7d8b6b,2) memb {
2c7d8b6b,0
496c71f7,0
} joined {
} left {
} partitioned {
})
2021-05-31 2:01:55 140178274383616 [Note] WSREP: save pc into disk
2021-05-31 2:01:55 140178265990912 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 1, memb_num = 2
2021-05-31 2:01:55 140178265990912 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
2021-05-31 2:01:55 140178265990912 [Note] WSREP: STATE EXCHANGE: sent state msg: 2ccaf9ce-c1b4-11eb-9545-dea291c71f8e
2021-05-31 2:01:55 140178265990912 [Note] WSREP: STATE EXCHANGE: got state msg: 2ccaf9ce-c1b4-11eb-9545-dea291c71f8e from 1 (onap-appc-db-0)
2021-05-31 2:01:55 140178265990912 [Note] WSREP: STATE EXCHANGE: got state msg: 2ccaf9ce-c1b4-11eb-9545-dea291c71f8e from 0 (onap-appc-db-1)
2021-05-31 2:01:55 140178265990912 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 1,
members = 1/2 (joined/total),
act_id = 0,
last_appl. = 0,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 496d3d6b-c1b3-11eb-8c26-9bbcdd85ad92
2021-05-31 2:01:55 140178265990912 [Note] WSREP: Flow-control interval: [23, 23]
2021-05-31 2:01:55 140178589321984 [Note] WSREP: New cluster view: global state: 496d3d6b-c1b3-11eb-8c26-9bbcdd85ad92:0, view# 2: Primary, number of nodes: 2, my index: 1, protocol version 3
2021-05-31 2:01:55 140178589321984 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-05-31 2:01:55 140178589321984 [Note] WSREP: REPL Protocols: 7 (3, 2)
2021-05-31 2:01:55 140178589321984 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
2021-05-31 2:01:55 140178324297472 [Note] WSREP: Service thread queue flushed.
2021-05-31 2:01:58 140178274383616 [Note] WSREP: (496c71f7, 'tcp://0.0.0.0:4567') turning message relay requesting off
2021-05-31 2:01:59 140178265990912 [Note] WSREP: Member 0.0 (onap-appc-db-1) requested state transfer from '*any*'. Selected 1.0 (onap-appc-db-0)(SYNCED) as donor.
2021-05-31 2:01:59 140178265990912 [Note] WSREP: Shifting SYNCED -> DONOR/DESYNCED (TO: 0)
2021-05-31 2:01:59 140178589321984 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-05-31 2:01:59 140177502631680 [Note] WSREP: Running: 'wsrep_sst_xtrabackup-v2 --role 'donor' --address 'onap-appc-db-1.appc-dbhost.onap.svc.cluster.local:4444/xtrabackup_sst//1' --socket '/var/lib/mysql/mysql.sock' --datadir '/var/lib/mysql/' '' --gtid '496d3d6b-c1b3-11eb-8c26-9bbcdd85ad92:0' --gtid-domain-id '0''
2021-05-31 2:01:59 140178589321984 [Note] WSREP: sst_donor_thread signaled with 0
WSREP_SST: [INFO] Streaming with xbstream (20210531 02:02:00.512)
WSREP_SST: [INFO] Using socat as streamer (20210531 02:02:00.516)
WSREP_SST: [INFO] Using /tmp/tmp.cDmUZ3xFJ9 as xtrabackup temporary directory (20210531 02:02:00.614)
WSREP_SST: [INFO] Using /tmp/tmp.OqPvycThIq as innobackupex temporary directory (20210531 02:02:00.620)
WSREP_SST: [INFO] Streaming GTID file before SST (20210531 02:02:00.629)
WSREP_SST: [INFO] Evaluating xbstream -c ${INFO_FILE} | socat -u stdio TCP:onap-appc-db-1.appc-dbhost.onap.svc.cluster.local:4444; RC=( ${PIPESTATUS[@]} ) (20210531 02:02:00.638)
WSREP_SST: [INFO] Sleeping before data transfer for SST (20210531 02:02:00.709)
WSREP_SST: [INFO] Streaming the backup to joiner at onap-appc-db-1.appc-dbhost.onap.svc.cluster.local 4444 (20210531 02:02:10.717)
WSREP_SST: [INFO] Evaluating innobackupex --no-version-check $tmpopts $INNOEXTRA --galera-info --stream=$sfmt $itmpdir 2>${DATA}/innobackup.backup.log | socat -u stdio TCP:onap-appc-db-1.appc-dbhost.onap.svc.cluster.local:4444; RC=( ${PIPESTATUS[@]} ) (20210531 02:02:10.721)
2021-05-31 2:02:12 140178509949696 [Note] WSREP: Provider paused at 496d3d6b-c1b3-11eb-8c26-9bbcdd85ad92:0 (5)
2021-05-31 2:02:12 140178509949696 [Note] WSREP: resuming provider at 5
2021-05-31 2:02:12 140178509949696 [Note] WSREP: Provider resumed.
WSREP_SST: [INFO] Total time on donor: 0 seconds (20210531 02:02:12.827)
WSREP_SST: [INFO] Cleaning up temporary directories (20210531 02:02:12.833)
2021-05-31 2:02:12 140178265990912 [Note] WSREP: 1.0 (onap-appc-db-0): State transfer to 0.0 (onap-appc-db-1) complete.
2021-05-31 2:02:12 140178265990912 [Note] WSREP: Shifting DONOR/DESYNCED -> JOINED (TO: 0)
2021-05-31 2:02:12 140178265990912 [Note] WSREP: Member 1.0 (onap-appc-db-0) synced with group.
2021-05-31 2:02:12 140178265990912 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 0)
2021-05-31 2:02:12 140178589321984 [Note] WSREP: Synchronized with group, ready for connections
2021-05-31 2:02:12 140178589321984 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-05-31 2:02:17 140178265990912 [Note] WSREP: 0.0 (onap-appc-db-1): State transfer from 1.0 (onap-appc-db-0) complete.
2021-05-31 2:02:17 140178265990912 [Note] WSREP: Member 0.0 (onap-appc-db-1) synced with group.
2021-05-31 2:02:57 140178274383616 [Note] WSREP: (496c71f7, 'tcp://0.0.0.0:4567') connection established to 51baa3da tcp://10.233.73.116:4567
2021-05-31 2:02:57 140178274383616 [Note] WSREP: (496c71f7, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2021-05-31 2:02:57 140178274383616 [Note] WSREP: declaring 2c7d8b6b at tcp://10.233.72.135:4567 stable
2021-05-31 2:02:57 140178274383616 [Note] WSREP: declaring 51baa3da at tcp://10.233.73.116:4567 stable
2021-05-31 2:02:57 140178274383616 [Note] WSREP: Node 2c7d8b6b state prim
2021-05-31 2:02:57 140178274383616 [Note] WSREP: view(view_id(PRIM,2c7d8b6b,3) memb {
2c7d8b6b,0
496c71f7,0
51baa3da,0
} joined {
} left {
} partitioned {
})
2021-05-31 2:02:57 140178274383616 [Note] WSREP: save pc into disk
2021-05-31 2:02:58 140178265990912 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 1, memb_num = 3
2021-05-31 2:02:58 140178265990912 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
2021-05-31 2:02:58 140178265990912 [Note] WSREP: STATE EXCHANGE: sent state msg: 52152fe2-c1b4-11eb-a839-e7ef63b1945e
2021-05-31 2:02:58 140178265990912 [Note] WSREP: STATE EXCHANGE: got state msg: 52152fe2-c1b4-11eb-a839-e7ef63b1945e from 0 (onap-appc-db-1)
2021-05-31 2:02:58 140178265990912 [Note] WSREP: STATE EXCHANGE: got state msg: 52152fe2-c1b4-11eb-a839-e7ef63b1945e from 1 (onap-appc-db-0)
2021-05-31 2:02:58 140178265990912 [Note] WSREP: STATE EXCHANGE: got state msg: 52152fe2-c1b4-11eb-a839-e7ef63b1945e from 2 (onap-appc-db-2)
2021-05-31 2:02:58 140178265990912 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 2,
members = 2/3 (joined/total),
act_id = 0,
last_appl. = 0,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 496d3d6b-c1b3-11eb-8c26-9bbcdd85ad92
2021-05-31 2:02:58 140178265990912 [Note] WSREP: Flow-control interval: [28, 28]
2021-05-31 2:02:58 140178589321984 [Note] WSREP: New cluster view: global state: 496d3d6b-c1b3-11eb-8c26-9bbcdd85ad92:0, view# 3: Primary, number of nodes: 3, my index: 1, protocol version 3
2021-05-31 2:02:58 140178589321984 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-05-31 2:02:58 140178589321984 [Note] WSREP: REPL Protocols: 7 (3, 2)
2021-05-31 2:02:58 140178589321984 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
2021-05-31 2:02:58 140178324297472 [Note] WSREP: Service thread queue flushed.
2021-05-31 2:03:00 140178274383616 [Note] WSREP: (496c71f7, 'tcp://0.0.0.0:4567') turning message relay requesting off
2021-05-31 2:03:01 140178265990912 [Note] WSREP: Member 2.0 (onap-appc-db-2) requested state transfer from '*any*'. Selected 0.0 (onap-appc-db-1)(SYNCED) as donor.
2021-05-31 2:03:14 140178265990912 [Note] WSREP: 0.0 (onap-appc-db-1): State transfer to 2.0 (onap-appc-db-2) complete.
2021-05-31 2:03:14 140178265990912 [Note] WSREP: Member 0.0 (onap-appc-db-1) synced with group.
2021-05-31 2:03:19 140178265990912 [Note] WSREP: 2.0 (onap-appc-db-2): State transfer from 0.0 (onap-appc-db-1) complete.
2021-05-31 2:03:19 140178265990912 [Note] WSREP: Member 2.0 (onap-appc-db-2) synced with group.