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
Using service name: appc-dbhost
+ 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
+ /usr/bin/peer-finder -on-start=/usr/share/container-scripts/mysql/configure-galera.sh -service=appc-dbhost
2021/04/15 02:05:20 Peer list updated
was []
now [onap-appc-db-0.appc-dbhost.onap.svc.cluster.local]
2021/04/15 02:05:20 execing: /usr/share/container-scripts/mysql/configure-galera.sh with stdin: onap-appc-db-0.appc-dbhost.onap.svc.cluster.local
2021/04/15 02:05:20
2021/04/15 02:05:21 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
Running mysql_install_db ...
+ echo 'Running mysql_install_db ...'
+ mysql_install_db --datadir=/var/lib/mysql
Installing MariaDB/MySQL system tables in '/var/lib/mysql' ...
2021-04-15 2:05:21 140700578973952 [Note] /usr/sbin/mysqld (mysqld 10.1.24-MariaDB) starting as process 51 ...
2021-04-15 2:05:21 140700578973952 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-04-15 2:05:21 140700578973952 [Note] WSREP: wsrep_load(): loading provider library 'none'
2021-04-15 2:05:21 140700578973952 [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:05:21 140700578973952 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-04-15 2:05:21 140700578973952 [Note] InnoDB: The InnoDB memory heap is disabled
2021-04-15 2:05:21 140700578973952 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-04-15 2:05:21 140700578973952 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-04-15 2:05:21 140700578973952 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-04-15 2:05:21 140700578973952 [Note] InnoDB: Using Linux native AIO
2021-04-15 2:05:21 140700578973952 [Note] InnoDB: Using SSE crc32 instructions
2021-04-15 2:05:21 140700578973952 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-04-15 2:05:21 140700578973952 [Note] InnoDB: Completed initialization of buffer pool
2021-04-15 2:05:21 140700578973952 [Note] InnoDB: The first specified data file ./ibdata1 did not exist: a new database to be created!
2021-04-15 2:05:21 140700578973952 [Note] InnoDB: Setting file ./ibdata1 size to 12 MB
2021-04-15 2:05:21 140700578973952 [Note] InnoDB: Setting log file ./ib_logfile101 size to 48 MB
2021-04-15 2:05:22 140700578973952 [Note] InnoDB: Setting log file ./ib_logfile1 size to 48 MB
2021-04-15 2:05:22 140700578973952 [Note] InnoDB: Renaming log file ./ib_logfile101 to ./ib_logfile0
2021-04-15 2:05:22 140700578973952 [Warning] InnoDB: New log files created, LSN=45883
2021-04-15 2:05:22 140700578973952 [Note] InnoDB: Doublewrite buffer not found: creating new
2021-04-15 2:05:22 140700578973952 [Note] InnoDB: Doublewrite buffer created
2021-04-15 2:05:22 140700578973952 [Note] InnoDB: 128 rollback segment(s) are active.
2021-04-15 2:05:22 140700578973952 [Warning] InnoDB: Creating foreign key constraint system tables.
2021-04-15 2:05:22 140700578973952 [Note] InnoDB: Foreign key constraint system tables created
2021-04-15 2:05:22 140700578973952 [Note] InnoDB: Creating tablespace and datafile system tables.
2021-04-15 2:05:22 140700578973952 [Note] InnoDB: Tablespace and datafile system tables created.
2021-04-15 2:05:22 140700578973952 [Note] InnoDB: Waiting for purge to start
2021-04-15 2:05:22 140700578973952 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 0
2021-04-15 2:05:22 140699794142976 [Note] InnoDB: Dumping buffer pool(s) not yet started
OK
Filling help tables...
2021-04-15 2:05:26 139888272812288 [Note] /usr/sbin/mysqld (mysqld 10.1.24-MariaDB) starting as process 80 ...
2021-04-15 2:05:26 139888272812288 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-04-15 2:05:26 139888272812288 [Note] WSREP: wsrep_load(): loading provider library 'none'
2021-04-15 2:05:26 139888272812288 [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:05:26 139888272812288 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-04-15 2:05:26 139888272812288 [Note] InnoDB: The InnoDB memory heap is disabled
2021-04-15 2:05:26 139888272812288 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-04-15 2:05:26 139888272812288 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-04-15 2:05:26 139888272812288 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-04-15 2:05:26 139888272812288 [Note] InnoDB: Using Linux native AIO
2021-04-15 2:05:26 139888272812288 [Note] InnoDB: Using SSE crc32 instructions
2021-04-15 2:05:26 139888272812288 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-04-15 2:05:26 139888272812288 [Note] InnoDB: Completed initialization of buffer pool
2021-04-15 2:05:26 139888272812288 [Note] InnoDB: Highest supported file format is Barracuda.
2021-04-15 2:05:26 139888272812288 [Note] InnoDB: 128 rollback segment(s) are active.
2021-04-15 2:05:26 139888272812288 [Note] InnoDB: Waiting for purge to start
2021-04-15 2:05:26 139888272812288 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616799
2021-04-15 2:05:26 139887491675904 [Note] InnoDB: Dumping buffer pool(s) not yet started
OK
Creating OpenGIS required SP-s...
2021-04-15 2:05:30 140436044810496 [Note] /usr/sbin/mysqld (mysqld 10.1.24-MariaDB) starting as process 110 ...
2021-04-15 2:05:30 140436044810496 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-04-15 2:05:30 140436044810496 [Note] WSREP: wsrep_load(): loading provider library 'none'
2021-04-15 2:05:30 140436044810496 [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:05:30 140436044810496 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-04-15 2:05:30 140436044810496 [Note] InnoDB: The InnoDB memory heap is disabled
2021-04-15 2:05:30 140436044810496 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-04-15 2:05:30 140436044810496 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-04-15 2:05:30 140436044810496 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-04-15 2:05:30 140436044810496 [Note] InnoDB: Using Linux native AIO
2021-04-15 2:05:30 140436044810496 [Note] InnoDB: Using SSE crc32 instructions
2021-04-15 2:05:30 140436044810496 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-04-15 2:05:30 140436044810496 [Note] InnoDB: Completed initialization of buffer pool
2021-04-15 2:05:30 140436044810496 [Note] InnoDB: Highest supported file format is Barracuda.
2021-04-15 2:05:30 140436044810496 [Note] InnoDB: 128 rollback segment(s) are active.
2021-04-15 2:05:30 140436044810496 [Note] InnoDB: Waiting for purge to start
2021-04-15 2:05:30 140436044810496 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616809
2021-04-15 2:05:30 140435263584000 [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
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
MySQL init process in progress...
+ echo '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
2021-04-15 2:05:34 139843265538304 [Note] mysqld (mysqld 10.1.24-MariaDB) starting as process 137 ...
2021-04-15 2:05:34 139843265538304 [Warning] You need to use --log-bin to make --binlog-format work.
2021-04-15 2:05:34 139843265538304 [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:05:34 139843265538304 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-04-15 2:05:34 139843265538304 [Note] InnoDB: The InnoDB memory heap is disabled
2021-04-15 2:05:34 139843265538304 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-04-15 2:05:34 139843265538304 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-04-15 2:05:34 139843265538304 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-04-15 2:05:34 139843265538304 [Note] InnoDB: Using Linux native AIO
2021-04-15 2:05:34 139843265538304 [Note] InnoDB: Using SSE crc32 instructions
2021-04-15 2:05:34 139843265538304 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-04-15 2:05:34 139843265538304 [Note] InnoDB: Completed initialization of buffer pool
2021-04-15 2:05:35 139843265538304 [Note] InnoDB: Highest supported file format is Barracuda.
2021-04-15 2:05:35 139843265538304 [Note] InnoDB: 128 rollback segment(s) are active.
2021-04-15 2:05:35 139843265538304 [Note] InnoDB: Waiting for purge to start
2021-04-15 2:05:35 139843265538304 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616819
2021-04-15 2:05:35 139842486793984 [Note] InnoDB: Dumping buffer pool(s) not yet started
2021-04-15 2:05:35 139843265538304 [Note] Plugin 'FEEDBACK' is disabled.
2021-04-15 2:05:35 139843265538304 [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 137
+ wait 137
2021-04-15 2:05:39 139843264686848 [Note] mysqld: Normal shutdown
2021-04-15 2:05:39 139843264686848 [Note] Event Scheduler: Purging the queue. 0 events
2021-04-15 2:05:39 139842470008576 [Note] InnoDB: FTS optimize thread exiting.
2021-04-15 2:05:39 139843264686848 [Note] InnoDB: Starting shutdown...
2021-04-15 2:05:40 139843264686848 [Note] InnoDB: Waiting for page_cleaner to finish flushing of buffer pool
2021-04-15 2:05:41 139843264686848 [Note] InnoDB: Shutdown completed; log sequence number 1616829
2021-04-15 2:05:41 139843264686848 [Note] mysqld: Shutdown complete
MySQL init process done. Ready for start up.
+ echo
+ echo 'MySQL init process done. Ready for start up.'
+ echo
+ exec mysqld
2021-04-15 2:05:42 139883880323328 [Note] mysqld (mysqld 10.1.24-MariaDB) starting as process 1 ...
2021-04-15 2:05:42 139883880323328 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-04-15 2:05:42 139883880323328 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib64/galera/libgalera_smm.so'
2021-04-15 2:05:42 139883880323328 [Note] WSREP: wsrep_load(): Galera 25.3.20(r3703) by Codership Oy loaded successfully.
2021-04-15 2:05:42 139883880323328 [Note] WSREP: CRC-32C: using hardware acceleration.
2021-04-15 2:05:42 139883880323328 [Warning] WSREP: Could not open state file for reading: '/var/lib/mysql//grastate.dat'
2021-04-15 2:05:42 139883880323328 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1, safe_to_bootsrap: 1
2021-04-15 2:05:42 139883880323328 [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-04-15 2:05:42 139883880323328 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(00000000-0000-0000-0000-000000000000:-1)
2021-04-15 2:05:42 139883880323328 [Note] WSREP: Assign initial position for certification: -1, protocol version: -1
2021-04-15 2:05:42 139883880323328 [Note] WSREP: wsrep_sst_grab()
2021-04-15 2:05:42 139883880323328 [Note] WSREP: Start replication
2021-04-15 2:05:42 139883880323328 [Note] WSREP: Setting initial position to 00000000-0000-0000-0000-000000000000:-1
2021-04-15 2:05:42 139883880323328 [Note] WSREP: protonet asio version 0
2021-04-15 2:05:42 139883880323328 [Note] WSREP: Using CRC-32C for message checksums.
2021-04-15 2:05:42 139883880323328 [Note] WSREP: backend: asio
2021-04-15 2:05:42 139883880323328 [Note] WSREP: gcomm thread scheduling priority set to other:0
2021-04-15 2:05:42 139883880323328 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)
2021-04-15 2:05:42 139883880323328 [Note] WSREP: restore pc from disk failed
2021-04-15 2:05:42 139883880323328 [Note] WSREP: GMCast version 0
2021-04-15 2:05:42 139883880323328 [Note] WSREP: (1519bbe0, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2021-04-15 2:05:42 139883880323328 [Note] WSREP: (1519bbe0, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2021-04-15 2:05:42 139883880323328 [Note] WSREP: EVS version 0
2021-04-15 2:05:42 139883880323328 [Note] WSREP: gcomm: connecting to group 'appc-dbhost', peer ''
2021-04-15 2:05:42 139883880323328 [Note] WSREP: start_prim is enabled, turn off pc_recovery
2021-04-15 2:05:42 139883880323328 [Note] WSREP: Node 1519bbe0 state prim
2021-04-15 2:05:42 139883880323328 [Note] WSREP: view(view_id(PRIM,1519bbe0,1) memb {
1519bbe0,0
} joined {
} left {
} partitioned {
})
2021-04-15 2:05:42 139883880323328 [Note] WSREP: save pc into disk
2021-04-15 2:05:42 139883880323328 [Note] WSREP: gcomm: connected
2021-04-15 2:05:42 139883880323328 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2021-04-15 2:05:42 139883880323328 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2021-04-15 2:05:42 139883880323328 [Note] WSREP: Opened channel 'appc-dbhost'
2021-04-15 2:05:42 139883880323328 [Note] WSREP: Waiting for SST to complete.
2021-04-15 2:05:42 139883557414656 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
2021-04-15 2:05:42 139883557414656 [Note] WSREP: Starting new group from scratch: 151a4868-9d8f-11eb-8e88-bed4a5d51196
2021-04-15 2:05:42 139883557414656 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 151a4a49-9d8f-11eb-a957-0661a493e51a
2021-04-15 2:05:42 139883557414656 [Note] WSREP: STATE EXCHANGE: sent state msg: 151a4a49-9d8f-11eb-a957-0661a493e51a
2021-04-15 2:05:42 139883557414656 [Note] WSREP: STATE EXCHANGE: got state msg: 151a4a49-9d8f-11eb-a957-0661a493e51a from 0 (onap-appc-db-0)
2021-04-15 2:05:42 139883557414656 [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 = 151a4868-9d8f-11eb-8e88-bed4a5d51196
2021-04-15 2:05:42 139883557414656 [Note] WSREP: Flow-control interval: [16, 16]
2021-04-15 2:05:42 139883557414656 [Note] WSREP: Restored state OPEN -> JOINED (0)
2021-04-15 2:05:42 139883557414656 [Note] WSREP: Member 0.0 (onap-appc-db-0) synced with group.
2021-04-15 2:05:42 139883557414656 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 0)
2021-04-15 2:05:42 139883879873280 [Note] WSREP: New cluster view: global state: 151a4868-9d8f-11eb-8e88-bed4a5d51196:0, view# 1: Primary, number of nodes: 1, my index: 0, protocol version 3
2021-04-15 2:05:42 139883880323328 [Note] WSREP: SST complete, seqno: 0
2021-04-15 2:05:42 139883880323328 [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:05:42 139883880323328 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-04-15 2:05:42 139883880323328 [Note] InnoDB: The InnoDB memory heap is disabled
2021-04-15 2:05:42 139883880323328 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-04-15 2:05:42 139883880323328 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-04-15 2:05:42 139883880323328 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-04-15 2:05:42 139883880323328 [Note] InnoDB: Using Linux native AIO
2021-04-15 2:05:42 139883880323328 [Note] InnoDB: Using SSE crc32 instructions
2021-04-15 2:05:42 139883880323328 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-04-15 2:05:42 139883880323328 [Note] InnoDB: Completed initialization of buffer pool
2021-04-15 2:05:42 139883880323328 [Note] InnoDB: Highest supported file format is Barracuda.
2021-04-15 2:05:42 139883880323328 [Note] InnoDB: 128 rollback segment(s) are active.
2021-04-15 2:05:42 139883880323328 [Note] InnoDB: Waiting for purge to start
2021-04-15 2:05:42 139883880323328 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616829
2021-04-15 2:05:42 139882873747200 [Note] InnoDB: Dumping buffer pool(s) not yet started
2021-04-15 2:05:42 139883880323328 [Note] Plugin 'FEEDBACK' is disabled.
2021-04-15 2:05:42 139883880323328 [Note] Server socket created on IP: '0.0.0.0'.
2021-04-15 2:05:42 139883879873280 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-04-15 2:05:42 139883879873280 [Note] WSREP: REPL Protocols: 7 (3, 2)
2021-04-15 2:05:42 139883879873280 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
2021-04-15 2:05:42 139883615721216 [Note] WSREP: Service thread queue flushed.
2021-04-15 2:05:42 139883879873280 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(151a4868-9d8f-11eb-8e88-bed4a5d51196:0)
2021-04-15 2:05:42 139883879873280 [Note] WSREP: Synchronized with group, ready for connections
2021-04-15 2:05:42 139883879873280 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-04-15 2:05:42 139883880323328 [Note] mysqld: ready for connections.
Version: '10.1.24-MariaDB' socket: '/var/lib/mysql/mysql.sock' port: 3306 MariaDB Server
2021-04-15 2:15:19 139883565807360 [Note] WSREP: (1519bbe0, 'tcp://0.0.0.0:4567') connection established to 6d4ca0cd tcp://10.233.76.242:4567
2021-04-15 2:15:19 139883565807360 [Note] WSREP: (1519bbe0, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2021-04-15 2:15:20 139883565807360 [Note] WSREP: declaring 6d4ca0cd at tcp://10.233.76.242:4567 stable
2021-04-15 2:15:20 139883565807360 [Note] WSREP: Node 1519bbe0 state prim
2021-04-15 2:15:20 139883565807360 [Note] WSREP: view(view_id(PRIM,1519bbe0,2) memb {
1519bbe0,0
6d4ca0cd,0
} joined {
} left {
} partitioned {
})
2021-04-15 2:15:20 139883565807360 [Note] WSREP: save pc into disk
2021-04-15 2:15:20 139883557414656 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 2
2021-04-15 2:15:20 139883557414656 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 6d9a66d1-9d90-11eb-b4cb-fa362e291c94
2021-04-15 2:15:20 139883557414656 [Note] WSREP: STATE EXCHANGE: sent state msg: 6d9a66d1-9d90-11eb-b4cb-fa362e291c94
2021-04-15 2:15:20 139883557414656 [Note] WSREP: STATE EXCHANGE: got state msg: 6d9a66d1-9d90-11eb-b4cb-fa362e291c94 from 0 (onap-appc-db-0)
2021-04-15 2:15:20 139883557414656 [Note] WSREP: STATE EXCHANGE: got state msg: 6d9a66d1-9d90-11eb-b4cb-fa362e291c94 from 1 (onap-appc-db-1)
2021-04-15 2:15:20 139883557414656 [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 = 151a4868-9d8f-11eb-8e88-bed4a5d51196
2021-04-15 2:15:20 139883557414656 [Note] WSREP: Flow-control interval: [23, 23]
2021-04-15 2:15:20 139883879873280 [Note] WSREP: New cluster view: global state: 151a4868-9d8f-11eb-8e88-bed4a5d51196:0, view# 2: Primary, number of nodes: 2, my index: 0, protocol version 3
2021-04-15 2:15:20 139883879873280 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-04-15 2:15:20 139883879873280 [Note] WSREP: REPL Protocols: 7 (3, 2)
2021-04-15 2:15:20 139883879873280 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
2021-04-15 2:15:20 139883615721216 [Note] WSREP: Service thread queue flushed.
2021-04-15 2:15:23 139883565807360 [Note] WSREP: (1519bbe0, 'tcp://0.0.0.0:4567') turning message relay requesting off
2021-04-15 2:15:24 139883557414656 [Note] WSREP: Member 1.0 (onap-appc-db-1) requested state transfer from '*any*'. Selected 0.0 (onap-appc-db-0)(SYNCED) as donor.
2021-04-15 2:15:24 139883557414656 [Note] WSREP: Shifting SYNCED -> DONOR/DESYNCED (TO: 0)
2021-04-15 2:15:24 139883879873280 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-04-15 2:15:24 139882798249728 [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 '151a4868-9d8f-11eb-8e88-bed4a5d51196:0' --gtid-domain-id '0''
2021-04-15 2:15:24 139883879873280 [Note] WSREP: sst_donor_thread signaled with 0
WSREP_SST: [INFO] Streaming with xbstream (20210415 02:15:25.273)
WSREP_SST: [INFO] Using socat as streamer (20210415 02:15:25.276)
WSREP_SST: [INFO] Using /tmp/tmp.cfHYYfCBaF as xtrabackup temporary directory (20210415 02:15:25.371)
WSREP_SST: [INFO] Using /tmp/tmp.G5LmZUpenb as innobackupex temporary directory (20210415 02:15:25.375)
WSREP_SST: [INFO] Streaming GTID file before SST (20210415 02:15:25.380)
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[@]} ) (20210415 02:15:25.387)
WSREP_SST: [INFO] Sleeping before data transfer for SST (20210415 02:15:25.395)
WSREP_SST: [INFO] Streaming the backup to joiner at onap-appc-db-1.appc-dbhost.onap.svc.cluster.local 4444 (20210415 02:15:35.401)
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[@]} ) (20210415 02:15:35.469)
2021-04-15 2:15:36 139883802659584 [Note] WSREP: Provider paused at 151a4868-9d8f-11eb-8e88-bed4a5d51196:0 (5)
2021-04-15 2:15:37 139883802659584 [Note] WSREP: resuming provider at 5
2021-04-15 2:15:37 139883802659584 [Note] WSREP: Provider resumed.
2021-04-15 2:15:37 139883557414656 [Note] WSREP: 0.0 (onap-appc-db-0): State transfer to 1.0 (onap-appc-db-1) complete.
2021-04-15 2:15:37 139883557414656 [Note] WSREP: Shifting DONOR/DESYNCED -> JOINED (TO: 0)
2021-04-15 2:15:37 139883557414656 [Note] WSREP: Member 0.0 (onap-appc-db-0) synced with group.
2021-04-15 2:15:37 139883557414656 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 0)
2021-04-15 2:15:37 139883879873280 [Note] WSREP: Synchronized with group, ready for connections
2021-04-15 2:15:37 139883879873280 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
WSREP_SST: [INFO] Total time on donor: 0 seconds (20210415 02:15:37.470)
WSREP_SST: [INFO] Cleaning up temporary directories (20210415 02:15:37.475)
2021-04-15 2:15:42 139883557414656 [Note] WSREP: 1.0 (onap-appc-db-1): State transfer from 0.0 (onap-appc-db-0) complete.
2021-04-15 2:15:42 139883557414656 [Note] WSREP: Member 1.0 (onap-appc-db-1) synced with group.
2021-04-15 2:17:12 139883565807360 [Note] WSREP: (1519bbe0, 'tcp://0.0.0.0:4567') connection established to b0957988 tcp://10.233.68.103:4567
2021-04-15 2:17:12 139883565807360 [Note] WSREP: (1519bbe0, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2021-04-15 2:17:13 139883565807360 [Note] WSREP: declaring 6d4ca0cd at tcp://10.233.76.242:4567 stable
2021-04-15 2:17:13 139883565807360 [Note] WSREP: declaring b0957988 at tcp://10.233.68.103:4567 stable
2021-04-15 2:17:13 139883565807360 [Note] WSREP: Node 1519bbe0 state prim
2021-04-15 2:17:13 139883565807360 [Note] WSREP: view(view_id(PRIM,1519bbe0,3) memb {
1519bbe0,0
6d4ca0cd,0
b0957988,0
} joined {
} left {
} partitioned {
})
2021-04-15 2:17:13 139883565807360 [Note] WSREP: save pc into disk
2021-04-15 2:17:13 139883557414656 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 3
2021-04-15 2:17:13 139883557414656 [Note] WSREP: STATE_EXCHANGE: sent state UUID: b0ea1ca1-9d90-11eb-a6f0-0bdddcb84ecc
2021-04-15 2:17:13 139883557414656 [Note] WSREP: STATE EXCHANGE: sent state msg: b0ea1ca1-9d90-11eb-a6f0-0bdddcb84ecc
2021-04-15 2:17:13 139883557414656 [Note] WSREP: STATE EXCHANGE: got state msg: b0ea1ca1-9d90-11eb-a6f0-0bdddcb84ecc from 0 (onap-appc-db-0)
2021-04-15 2:17:13 139883557414656 [Note] WSREP: STATE EXCHANGE: got state msg: b0ea1ca1-9d90-11eb-a6f0-0bdddcb84ecc from 1 (onap-appc-db-1)
2021-04-15 2:17:13 139883557414656 [Note] WSREP: STATE EXCHANGE: got state msg: b0ea1ca1-9d90-11eb-a6f0-0bdddcb84ecc from 2 (onap-appc-db-2)
2021-04-15 2:17:13 139883557414656 [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 = 151a4868-9d8f-11eb-8e88-bed4a5d51196
2021-04-15 2:17:13 139883557414656 [Note] WSREP: Flow-control interval: [28, 28]
2021-04-15 2:17:13 139883879873280 [Note] WSREP: New cluster view: global state: 151a4868-9d8f-11eb-8e88-bed4a5d51196:0, view# 3: Primary, number of nodes: 3, my index: 0, protocol version 3
2021-04-15 2:17:13 139883879873280 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-04-15 2:17:13 139883879873280 [Note] WSREP: REPL Protocols: 7 (3, 2)
2021-04-15 2:17:13 139883879873280 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
2021-04-15 2:17:13 139883615721216 [Note] WSREP: Service thread queue flushed.
2021-04-15 2:17:16 139883565807360 [Note] WSREP: (1519bbe0, 'tcp://0.0.0.0:4567') turning message relay requesting off
2021-04-15 2:17:17 139883557414656 [Note] WSREP: Member 2.0 (onap-appc-db-2) requested state transfer from '*any*'. Selected 0.0 (onap-appc-db-0)(SYNCED) as donor.
2021-04-15 2:17:17 139883557414656 [Note] WSREP: Shifting SYNCED -> DONOR/DESYNCED (TO: 0)
2021-04-15 2:17:17 139883879873280 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-04-15 2:17:17 139882781472512 [Note] WSREP: Running: 'wsrep_sst_xtrabackup-v2 --role 'donor' --address 'onap-appc-db-2.appc-dbhost.onap.svc.cluster.local:4444/xtrabackup_sst//1' --socket '/var/lib/mysql/mysql.sock' --datadir '/var/lib/mysql/' '' --gtid '151a4868-9d8f-11eb-8e88-bed4a5d51196:0' --gtid-domain-id '0''
2021-04-15 2:17:17 139883879873280 [Note] WSREP: sst_donor_thread signaled with 0
WSREP_SST: [INFO] Streaming with xbstream (20210415 02:17:18.678)
WSREP_SST: [INFO] Using socat as streamer (20210415 02:17:18.681)
WSREP_SST: [INFO] Using /tmp/tmp.ccuXa0ozwg as xtrabackup temporary directory (20210415 02:17:18.779)
WSREP_SST: [INFO] Using /tmp/tmp.dlWxFiedbg as innobackupex temporary directory (20210415 02:17:18.783)
WSREP_SST: [INFO] Streaming GTID file before SST (20210415 02:17:18.790)
WSREP_SST: [INFO] Evaluating xbstream -c ${INFO_FILE} | socat -u stdio TCP:onap-appc-db-2.appc-dbhost.onap.svc.cluster.local:4444; RC=( ${PIPESTATUS[@]} ) (20210415 02:17:18.876)
WSREP_SST: [INFO] Sleeping before data transfer for SST (20210415 02:17:18.886)
WSREP_SST: [INFO] Streaming the backup to joiner at onap-appc-db-2.appc-dbhost.onap.svc.cluster.local 4444 (20210415 02:17:28.892)
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-2.appc-dbhost.onap.svc.cluster.local:4444; RC=( ${PIPESTATUS[@]} ) (20210415 02:17:28.897)
2021-04-15 2:17:30 139883802659584 [Note] WSREP: Provider paused at 151a4868-9d8f-11eb-8e88-bed4a5d51196:0 (10)
2021-04-15 2:17:30 139883802659584 [Note] WSREP: resuming provider at 10
2021-04-15 2:17:30 139883802659584 [Note] WSREP: Provider resumed.
2021-04-15 2:17:30 139883557414656 [Note] WSREP: 0.0 (onap-appc-db-0): State transfer to 2.0 (onap-appc-db-2) complete.
2021-04-15 2:17:30 139883557414656 [Note] WSREP: Shifting DONOR/DESYNCED -> JOINED (TO: 0)
WSREP_SST: [INFO] Total time on donor: 0 seconds (20210415 02:17:30.758)
WSREP_SST: [INFO] Cleaning up temporary directories (20210415 02:17:30.765)
2021-04-15 2:17:30 139883557414656 [Note] WSREP: Member 0.0 (onap-appc-db-0) synced with group.
2021-04-15 2:17:30 139883557414656 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 0)
2021-04-15 2:17:30 139883879873280 [Note] WSREP: Synchronized with group, ready for connections
2021-04-15 2:17:30 139883879873280 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-04-15 2:17:35 139883557414656 [Note] WSREP: 2.0 (onap-appc-db-2): State transfer from 0.0 (onap-appc-db-0) complete.
2021-04-15 2:17:35 139883557414656 [Note] WSREP: Member 2.0 (onap-appc-db-2) synced with group.