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=appc-dbhost
+ echo 'Using service name: appc-dbhost'
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/05/30 01:53:48 Peer list updated
was []
now [onap-appc-db-0.appc-dbhost.onap.svc.cluster.local]
2021/05/30 01:53:48 execing: /usr/share/container-scripts/mysql/configure-galera.sh with stdin: onap-appc-db-0.appc-dbhost.onap.svc.cluster.local
2021/05/30 01:53:48
2021/05/30 01:53:49 Peer finder exiting
+ '[' '!' -d /var/lib/mysql/mysql ']'
Configure first time mysql
+ echo 'Configure first time mysql'
+ /usr/share/container-scripts/mysql/configure-mysql.sh
+ 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-30 1:53:49 140329916815616 [Note] /usr/sbin/mysqld (mysqld 10.1.24-MariaDB) starting as process 51 ...
2021-05-30 1:53:49 140329916815616 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-05-30 1:53:49 140329916815616 [Note] WSREP: wsrep_load(): loading provider library 'none'
2021-05-30 1:53:49 140329916815616 [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-30 1:53:49 140329916815616 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-05-30 1:53:49 140329916815616 [Note] InnoDB: The InnoDB memory heap is disabled
2021-05-30 1:53:49 140329916815616 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-05-30 1:53:49 140329916815616 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-05-30 1:53:49 140329916815616 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-05-30 1:53:49 140329916815616 [Note] InnoDB: Using Linux native AIO
2021-05-30 1:53:49 140329916815616 [Note] InnoDB: Using SSE crc32 instructions
2021-05-30 1:53:49 140329916815616 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-05-30 1:53:49 140329916815616 [Note] InnoDB: Completed initialization of buffer pool
2021-05-30 1:53:49 140329916815616 [Note] InnoDB: The first specified data file ./ibdata1 did not exist: a new database to be created!
2021-05-30 1:53:49 140329916815616 [Note] InnoDB: Setting file ./ibdata1 size to 12 MB
2021-05-30 1:53:49 140329916815616 [Note] InnoDB: Setting log file ./ib_logfile101 size to 48 MB
2021-05-30 1:53:50 140329916815616 [Note] InnoDB: Setting log file ./ib_logfile1 size to 48 MB
2021-05-30 1:53:50 140329916815616 [Note] InnoDB: Renaming log file ./ib_logfile101 to ./ib_logfile0
2021-05-30 1:53:50 140329916815616 [Warning] InnoDB: New log files created, LSN=45883
2021-05-30 1:53:50 140329916815616 [Note] InnoDB: Doublewrite buffer not found: creating new
2021-05-30 1:53:50 140329916815616 [Note] InnoDB: Doublewrite buffer created
2021-05-30 1:53:50 140329916815616 [Note] InnoDB: 128 rollback segment(s) are active.
2021-05-30 1:53:50 140329916815616 [Warning] InnoDB: Creating foreign key constraint system tables.
2021-05-30 1:53:50 140329916815616 [Note] InnoDB: Foreign key constraint system tables created
2021-05-30 1:53:50 140329916815616 [Note] InnoDB: Creating tablespace and datafile system tables.
2021-05-30 1:53:50 140329916815616 [Note] InnoDB: Tablespace and datafile system tables created.
2021-05-30 1:53:50 140329916815616 [Note] InnoDB: Waiting for purge to start
2021-05-30 1:53:50 140329916815616 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 0
2021-05-30 1:53:50 140329130915584 [Note] InnoDB: Dumping buffer pool(s) not yet started
OK
Filling help tables...
2021-05-30 1:53:54 140132176328960 [Note] /usr/sbin/mysqld (mysqld 10.1.24-MariaDB) starting as process 80 ...
2021-05-30 1:53:54 140132176328960 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-05-30 1:53:54 140132176328960 [Note] WSREP: wsrep_load(): loading provider library 'none'
2021-05-30 1:53:54 140132176328960 [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-30 1:53:54 140132176328960 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-05-30 1:53:54 140132176328960 [Note] InnoDB: The InnoDB memory heap is disabled
2021-05-30 1:53:54 140132176328960 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-05-30 1:53:54 140132176328960 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-05-30 1:53:54 140132176328960 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-05-30 1:53:54 140132176328960 [Note] InnoDB: Using Linux native AIO
2021-05-30 1:53:54 140132176328960 [Note] InnoDB: Using SSE crc32 instructions
2021-05-30 1:53:54 140132176328960 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-05-30 1:53:54 140132176328960 [Note] InnoDB: Completed initialization of buffer pool
2021-05-30 1:53:54 140132176328960 [Note] InnoDB: Highest supported file format is Barracuda.
2021-05-30 1:53:54 140132176328960 [Note] InnoDB: 128 rollback segment(s) are active.
2021-05-30 1:53:54 140132176328960 [Note] InnoDB: Waiting for purge to start
2021-05-30 1:53:54 140132176328960 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616799
2021-05-30 1:53:54 140131394647808 [Note] InnoDB: Dumping buffer pool(s) not yet started
OK
Creating OpenGIS required SP-s...
2021-05-30 1:53:58 139803789797632 [Note] /usr/sbin/mysqld (mysqld 10.1.24-MariaDB) starting as process 110 ...
2021-05-30 1:53:58 139803789797632 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-05-30 1:53:58 139803789797632 [Note] WSREP: wsrep_load(): loading provider library 'none'
2021-05-30 1:53:58 139803789797632 [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-30 1:53:58 139803789797632 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-05-30 1:53:58 139803789797632 [Note] InnoDB: The InnoDB memory heap is disabled
2021-05-30 1:53:58 139803789797632 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-05-30 1:53:58 139803789797632 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-05-30 1:53:58 139803789797632 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-05-30 1:53:58 139803789797632 [Note] InnoDB: Using Linux native AIO
2021-05-30 1:53:58 139803789797632 [Note] InnoDB: Using SSE crc32 instructions
2021-05-30 1:53:58 139803789797632 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-05-30 1:53:58 139803789797632 [Note] InnoDB: Completed initialization of buffer pool
2021-05-30 1:53:58 139803789797632 [Note] InnoDB: Highest supported file format is Barracuda.
2021-05-30 1:53:58 139803789797632 [Note] InnoDB: 128 rollback segment(s) are active.
2021-05-30 1:53:58 139803789797632 [Note] InnoDB: Waiting for purge to start
2021-05-30 1:53:59 139803789797632 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616809
2021-05-30 1:53:59 139803010004736 [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
+ echo 'Finished mysql_install_db'
+ pid=137
+ mysql=(mysql --protocol=socket -uroot -hlocalhost --socket=/var/lib/mysql/mysql-init.sock)
+ mysqld --skip-networking --socket=/var/lib/mysql/mysql-init.sock --wsrep_on=OFF
+ 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-30 1:54:02 140311335766272 [Note] mysqld (mysqld 10.1.24-MariaDB) starting as process 137 ...
2021-05-30 1:54:02 140311335766272 [Warning] You need to use --log-bin to make --binlog-format work.
2021-05-30 1:54:02 140311335766272 [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-30 1:54:03 140311335766272 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-05-30 1:54:03 140311335766272 [Note] InnoDB: The InnoDB memory heap is disabled
2021-05-30 1:54:03 140311335766272 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-05-30 1:54:03 140311335766272 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-05-30 1:54:03 140311335766272 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-05-30 1:54:03 140311335766272 [Note] InnoDB: Using Linux native AIO
2021-05-30 1:54:03 140311335766272 [Note] InnoDB: Using SSE crc32 instructions
2021-05-30 1:54:03 140311335766272 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-05-30 1:54:03 140311335766272 [Note] InnoDB: Completed initialization of buffer pool
2021-05-30 1:54:03 140311335766272 [Note] InnoDB: Highest supported file format is Barracuda.
2021-05-30 1:54:03 140311335766272 [Note] InnoDB: 128 rollback segment(s) are active.
2021-05-30 1:54:03 140311335766272 [Note] InnoDB: Waiting for purge to start
2021-05-30 1:54:03 140311335766272 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616819
2021-05-30 1:54:03 140310554343168 [Note] InnoDB: Dumping buffer pool(s) not yet started
2021-05-30 1:54:03 140311335766272 [Note] Plugin 'FEEDBACK' is disabled.
2021-05-30 1:54:03 140311335766272 [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-05-30 1:54:07 140311334914816 [Note] mysqld: Normal shutdown
2021-05-30 1:54:07 140311334914816 [Note] Event Scheduler: Purging the queue. 0 events
2021-05-30 1:54:07 140310537557760 [Note] InnoDB: FTS optimize thread exiting.
2021-05-30 1:54:07 140311334914816 [Note] InnoDB: Starting shutdown...
2021-05-30 1:54:08 140311334914816 [Note] InnoDB: Waiting for page_cleaner to finish flushing of buffer pool
2021-05-30 1:54:09 140311334914816 [Note] InnoDB: Shutdown completed; log sequence number 1616829
2021-05-30 1:54:09 140311334914816 [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-30 1:54:10 140521859348736 [Note] mysqld (mysqld 10.1.24-MariaDB) starting as process 1 ...
2021-05-30 1:54:10 140521859348736 [Note] WSREP: Read nil XID from storage engines, skipping position init
2021-05-30 1:54:10 140521859348736 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib64/galera/libgalera_smm.so'
2021-05-30 1:54:10 140521859348736 [Note] WSREP: wsrep_load(): Galera 25.3.20(r3703) by Codership Oy loaded successfully.
2021-05-30 1:54:10 140521859348736 [Note] WSREP: CRC-32C: using hardware acceleration.
2021-05-30 1:54:10 140521859348736 [Warning] WSREP: Could not open state file for reading: '/var/lib/mysql//grastate.dat'
2021-05-30 1:54:10 140521859348736 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1, safe_to_bootsrap: 1
2021-05-30 1:54:10 140521859348736 [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-30 1:54:10 140521859348736 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(00000000-0000-0000-0000-000000000000:-1)
2021-05-30 1:54:10 140521859348736 [Note] WSREP: Assign initial position for certification: -1, protocol version: -1
2021-05-30 1:54:10 140521859348736 [Note] WSREP: wsrep_sst_grab()
2021-05-30 1:54:10 140521859348736 [Note] WSREP: Start replication
2021-05-30 1:54:10 140521859348736 [Note] WSREP: Setting initial position to 00000000-0000-0000-0000-000000000000:-1
2021-05-30 1:54:10 140521859348736 [Note] WSREP: protonet asio version 0
2021-05-30 1:54:10 140521859348736 [Note] WSREP: Using CRC-32C for message checksums.
2021-05-30 1:54:10 140521859348736 [Note] WSREP: backend: asio
2021-05-30 1:54:10 140521859348736 [Note] WSREP: gcomm thread scheduling priority set to other:0
2021-05-30 1:54:10 140521859348736 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)
2021-05-30 1:54:10 140521859348736 [Note] WSREP: restore pc from disk failed
2021-05-30 1:54:10 140521859348736 [Note] WSREP: GMCast version 0
2021-05-30 1:54:10 140521859348736 [Note] WSREP: (ed3aaf57, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2021-05-30 1:54:10 140521859348736 [Note] WSREP: (ed3aaf57, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2021-05-30 1:54:10 140521859348736 [Note] WSREP: EVS version 0
2021-05-30 1:54:10 140521859348736 [Note] WSREP: gcomm: connecting to group 'appc-dbhost', peer ''
2021-05-30 1:54:10 140521859348736 [Note] WSREP: start_prim is enabled, turn off pc_recovery
2021-05-30 1:54:10 140521859348736 [Note] WSREP: Node ed3aaf57 state prim
2021-05-30 1:54:10 140521859348736 [Note] WSREP: view(view_id(PRIM,ed3aaf57,1) memb {
ed3aaf57,0
} joined {
} left {
} partitioned {
})
2021-05-30 1:54:10 140521859348736 [Note] WSREP: save pc into disk
2021-05-30 1:54:10 140521859348736 [Note] WSREP: gcomm: connected
2021-05-30 1:54:10 140521859348736 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2021-05-30 1:54:10 140521859348736 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2021-05-30 1:54:10 140521859348736 [Note] WSREP: Opened channel 'appc-dbhost'
2021-05-30 1:54:10 140521859348736 [Note] WSREP: Waiting for SST to complete.
2021-05-30 1:54:10 140521536218880 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
2021-05-30 1:54:10 140521536218880 [Note] WSREP: Starting new group from scratch: ed3b8e13-c0e9-11eb-9e26-5bb5945eb38f
2021-05-30 1:54:10 140521536218880 [Note] WSREP: STATE_EXCHANGE: sent state UUID: ed3b92f1-c0e9-11eb-92fa-9bf1c5e5fd86
2021-05-30 1:54:10 140521536218880 [Note] WSREP: STATE EXCHANGE: sent state msg: ed3b92f1-c0e9-11eb-92fa-9bf1c5e5fd86
2021-05-30 1:54:10 140521536218880 [Note] WSREP: STATE EXCHANGE: got state msg: ed3b92f1-c0e9-11eb-92fa-9bf1c5e5fd86 from 0 (onap-appc-db-0)
2021-05-30 1:54:10 140521536218880 [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 = ed3b8e13-c0e9-11eb-9e26-5bb5945eb38f
2021-05-30 1:54:10 140521536218880 [Note] WSREP: Flow-control interval: [16, 16]
2021-05-30 1:54:10 140521536218880 [Note] WSREP: Restored state OPEN -> JOINED (0)
2021-05-30 1:54:10 140521536218880 [Note] WSREP: Member 0.0 (onap-appc-db-0) synced with group.
2021-05-30 1:54:10 140521536218880 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 0)
2021-05-30 1:54:10 140521858898688 [Note] WSREP: New cluster view: global state: ed3b8e13-c0e9-11eb-9e26-5bb5945eb38f:0, view# 1: Primary, number of nodes: 1, my index: 0, protocol version 3
2021-05-30 1:54:10 140521859348736 [Note] WSREP: SST complete, seqno: 0
2021-05-30 1:54:10 140521859348736 [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-30 1:54:10 140521859348736 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2021-05-30 1:54:10 140521859348736 [Note] InnoDB: The InnoDB memory heap is disabled
2021-05-30 1:54:10 140521859348736 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2021-05-30 1:54:10 140521859348736 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2021-05-30 1:54:10 140521859348736 [Note] InnoDB: Compressed tables use zlib 1.2.7
2021-05-30 1:54:10 140521859348736 [Note] InnoDB: Using Linux native AIO
2021-05-30 1:54:10 140521859348736 [Note] InnoDB: Using SSE crc32 instructions
2021-05-30 1:54:10 140521859348736 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2021-05-30 1:54:10 140521859348736 [Note] InnoDB: Completed initialization of buffer pool
2021-05-30 1:54:10 140521859348736 [Note] InnoDB: Highest supported file format is Barracuda.
2021-05-30 1:54:10 140521859348736 [Note] InnoDB: 128 rollback segment(s) are active.
2021-05-30 1:54:10 140521859348736 [Note] InnoDB: Waiting for purge to start
2021-05-30 1:54:10 140521859348736 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616829
2021-05-30 1:54:10 140520852551424 [Note] InnoDB: Dumping buffer pool(s) not yet started
2021-05-30 1:54:10 140521859348736 [Note] Plugin 'FEEDBACK' is disabled.
2021-05-30 1:54:10 140521859348736 [Note] Server socket created on IP: '0.0.0.0'.
2021-05-30 1:54:11 140521858898688 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-05-30 1:54:11 140521858898688 [Note] WSREP: REPL Protocols: 7 (3, 2)
2021-05-30 1:54:11 140521858898688 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
2021-05-30 1:54:11 140521594525440 [Note] WSREP: Service thread queue flushed.
2021-05-30 1:54:11 140521858898688 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(ed3b8e13-c0e9-11eb-9e26-5bb5945eb38f:0)
2021-05-30 1:54:11 140521858898688 [Note] WSREP: Synchronized with group, ready for connections
2021-05-30 1:54:11 140521858898688 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-05-30 1:54:11 140521859348736 [Note] mysqld: ready for connections.
Version: '10.1.24-MariaDB' socket: '/var/lib/mysql/mysql.sock' port: 3306 MariaDB Server
2021-05-30 1:56:37 140521544611584 [Note] WSREP: (ed3aaf57, 'tcp://0.0.0.0:4567') connection established to 44d4fdcf tcp://10.233.77.241:4567
2021-05-30 1:56:37 140521544611584 [Note] WSREP: (ed3aaf57, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2021-05-30 1:56:37 140521544611584 [Note] WSREP: declaring 44d4fdcf at tcp://10.233.77.241:4567 stable
2021-05-30 1:56:37 140521544611584 [Note] WSREP: Node ed3aaf57 state prim
2021-05-30 1:56:37 140521544611584 [Note] WSREP: view(view_id(PRIM,44d4fdcf,2) memb {
44d4fdcf,0
ed3aaf57,0
} joined {
} left {
} partitioned {
})
2021-05-30 1:56:37 140521544611584 [Note] WSREP: save pc into disk
2021-05-30 1:56:37 140521536218880 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 1, memb_num = 2
2021-05-30 1:56:37 140521536218880 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
2021-05-30 1:56:37 140521536218880 [Note] WSREP: STATE EXCHANGE: sent state msg: 45224f62-c0ea-11eb-b7b6-d698b65d0ac9
2021-05-30 1:56:37 140521536218880 [Note] WSREP: STATE EXCHANGE: got state msg: 45224f62-c0ea-11eb-b7b6-d698b65d0ac9 from 0 (onap-appc-db-1)
2021-05-30 1:56:37 140521536218880 [Note] WSREP: STATE EXCHANGE: got state msg: 45224f62-c0ea-11eb-b7b6-d698b65d0ac9 from 1 (onap-appc-db-0)
2021-05-30 1:56:37 140521536218880 [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 = ed3b8e13-c0e9-11eb-9e26-5bb5945eb38f
2021-05-30 1:56:37 140521536218880 [Note] WSREP: Flow-control interval: [23, 23]
2021-05-30 1:56:37 140521858898688 [Note] WSREP: New cluster view: global state: ed3b8e13-c0e9-11eb-9e26-5bb5945eb38f:0, view# 2: Primary, number of nodes: 2, my index: 1, protocol version 3
2021-05-30 1:56:37 140521858898688 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-05-30 1:56:37 140521858898688 [Note] WSREP: REPL Protocols: 7 (3, 2)
2021-05-30 1:56:37 140521858898688 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
2021-05-30 1:56:37 140521594525440 [Note] WSREP: Service thread queue flushed.
2021-05-30 1:56:40 140521544611584 [Note] WSREP: (ed3aaf57, 'tcp://0.0.0.0:4567') turning message relay requesting off
2021-05-30 1:56:42 140521536218880 [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-30 1:56:42 140521536218880 [Note] WSREP: Shifting SYNCED -> DONOR/DESYNCED (TO: 0)
2021-05-30 1:56:42 140521858898688 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-05-30 1:56:42 140520781248256 [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 'ed3b8e13-c0e9-11eb-9e26-5bb5945eb38f:0' --gtid-domain-id '0''
2021-05-30 1:56:42 140521858898688 [Note] WSREP: sst_donor_thread signaled with 0
WSREP_SST: [INFO] Streaming with xbstream (20210530 01:56:43.432)
WSREP_SST: [INFO] Using socat as streamer (20210530 01:56:43.469)
WSREP_SST: [INFO] Using /tmp/tmp.PJvvk0CVNX as xtrabackup temporary directory (20210530 01:56:43.575)
WSREP_SST: [INFO] Using /tmp/tmp.PGEYZ74idc as innobackupex temporary directory (20210530 01:56:43.580)
WSREP_SST: [INFO] Streaming GTID file before SST (20210530 01:56:43.587)
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[@]} ) (20210530 01:56:43.594)
WSREP_SST: [INFO] Sleeping before data transfer for SST (20210530 01:56:43.677)
WSREP_SST: [INFO] Streaming the backup to joiner at onap-appc-db-1.appc-dbhost.onap.svc.cluster.local 4444 (20210530 01:56:53.686)
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[@]} ) (20210530 01:56:53.769)
2021-05-30 1:56:55 140521741736704 [Note] WSREP: Provider paused at ed3b8e13-c0e9-11eb-9e26-5bb5945eb38f:0 (5)
2021-05-30 1:56:55 140521741736704 [Note] WSREP: resuming provider at 5
2021-05-30 1:56:55 140521741736704 [Note] WSREP: Provider resumed.
2021-05-30 1:56:55 140521536218880 [Note] WSREP: 1.0 (onap-appc-db-0): State transfer to 0.0 (onap-appc-db-1) complete.
2021-05-30 1:56:55 140521536218880 [Note] WSREP: Shifting DONOR/DESYNCED -> JOINED (TO: 0)
2021-05-30 1:56:55 140521536218880 [Note] WSREP: Member 1.0 (onap-appc-db-0) synced with group.
2021-05-30 1:56:55 140521536218880 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 0)
2021-05-30 1:56:55 140521858898688 [Note] WSREP: Synchronized with group, ready for connections
2021-05-30 1:56:55 140521858898688 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
WSREP_SST: [INFO] Total time on donor: 0 seconds (20210530 01:56:55.712)
WSREP_SST: [INFO] Cleaning up temporary directories (20210530 01:56:55.719)
2021-05-30 1:57:00 140521536218880 [Note] WSREP: 0.0 (onap-appc-db-1): State transfer from 1.0 (onap-appc-db-0) complete.
2021-05-30 1:57:00 140521536218880 [Note] WSREP: Member 0.0 (onap-appc-db-1) synced with group.
2021-05-30 1:57:35 140521544611584 [Note] WSREP: (ed3aaf57, 'tcp://0.0.0.0:4567') connection established to 678485e7 tcp://10.233.73.139:4567
2021-05-30 1:57:35 140521544611584 [Note] WSREP: (ed3aaf57, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2021-05-30 1:57:36 140521544611584 [Note] WSREP: declaring 44d4fdcf at tcp://10.233.77.241:4567 stable
2021-05-30 1:57:36 140521544611584 [Note] WSREP: declaring 678485e7 at tcp://10.233.73.139:4567 stable
2021-05-30 1:57:36 140521544611584 [Note] WSREP: Node 44d4fdcf state prim
2021-05-30 1:57:36 140521544611584 [Note] WSREP: view(view_id(PRIM,44d4fdcf,3) memb {
44d4fdcf,0
678485e7,0
ed3aaf57,0
} joined {
} left {
} partitioned {
})
2021-05-30 1:57:36 140521544611584 [Note] WSREP: save pc into disk
2021-05-30 1:57:36 140521536218880 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 2, memb_num = 3
2021-05-30 1:57:36 140521536218880 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
2021-05-30 1:57:36 140521536218880 [Note] WSREP: STATE EXCHANGE: sent state msg: 67db9246-c0ea-11eb-951b-0bb59e58534b
2021-05-30 1:57:36 140521536218880 [Note] WSREP: STATE EXCHANGE: got state msg: 67db9246-c0ea-11eb-951b-0bb59e58534b from 0 (onap-appc-db-1)
2021-05-30 1:57:36 140521536218880 [Note] WSREP: STATE EXCHANGE: got state msg: 67db9246-c0ea-11eb-951b-0bb59e58534b from 2 (onap-appc-db-0)
2021-05-30 1:57:36 140521536218880 [Note] WSREP: STATE EXCHANGE: got state msg: 67db9246-c0ea-11eb-951b-0bb59e58534b from 1 (onap-appc-db-2)
2021-05-30 1:57:36 140521536218880 [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 = ed3b8e13-c0e9-11eb-9e26-5bb5945eb38f
2021-05-30 1:57:36 140521536218880 [Note] WSREP: Flow-control interval: [28, 28]
2021-05-30 1:57:36 140521858898688 [Note] WSREP: New cluster view: global state: ed3b8e13-c0e9-11eb-9e26-5bb5945eb38f:0, view# 3: Primary, number of nodes: 3, my index: 2, protocol version 3
2021-05-30 1:57:36 140521858898688 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2021-05-30 1:57:36 140521858898688 [Note] WSREP: REPL Protocols: 7 (3, 2)
2021-05-30 1:57:36 140521858898688 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
2021-05-30 1:57:36 140521594525440 [Note] WSREP: Service thread queue flushed.
2021-05-30 1:57:39 140521544611584 [Note] WSREP: (ed3aaf57, 'tcp://0.0.0.0:4567') turning message relay requesting off
2021-05-30 1:57:39 140521536218880 [Note] WSREP: Member 1.0 (onap-appc-db-2) requested state transfer from '*any*'. Selected 0.0 (onap-appc-db-1)(SYNCED) as donor.
2021-05-30 1:57:53 140521536218880 [Note] WSREP: 0.0 (onap-appc-db-1): State transfer to 1.0 (onap-appc-db-2) complete.
2021-05-30 1:57:53 140521536218880 [Note] WSREP: Member 0.0 (onap-appc-db-1) synced with group.
2021-05-30 1:57:57 140521536218880 [Note] WSREP: 1.0 (onap-appc-db-2): State transfer from 0.0 (onap-appc-db-1) complete.
2021-05-30 1:57:57 140521536218880 [Note] WSREP: Member 1.0 (onap-appc-db-2) synced with group.