Open neverfox opened 7 years ago
Thanks very much for sharing. Can you provide some error messages?
Upgrading minor version needs some extra work. At least the mysql_upgrade
script should be run always after starting the new version. Please refer to the specific MariaDB docs:
I'm not sure if it's possible to automate the process since procedures are slightly different. What do you think?
There might be another solution: to build a slave. Deploy another Galera cluster with upgraded version. Connect it via MySQL replication and then promote it to master. Haven't tried but seems like a valid approach.
Thanks for the reply. I'm sorry if I wasn't clear but I'm actually just talking about a fresh install using your example, not an upgrade. If you clone this repo and change the version numbers from 10.1 to 10.2, it won't stand up, which is a shame since 10.2 is the current stable release. mysql-0 starts, mysql-1 enters a crash loop and mysql-2 never starts (consistent with how stateful sets launch in order).
Steps to reproduce after cloning this repo and entering the example folder:
$ sed -i -e 's/10\.1/10\.2/g' mysql.yaml
$ minikube start
$ kubectl apply -f .
mysql-0 enters Running state fine. Then mysql-1 starts up and fails with the following logs:
Initializing database
PLEASE REMEMBER TO SET A PASSWORD FOR THE MariaDB root USER !
To do so, start the server, then issue the following commands:
'/usr/bin/mysqladmin' -u root password 'new-password'
'/usr/bin/mysqladmin' -u root -h password 'new-password'
Alternatively you can run:
'/usr/bin/mysql_secure_installation'
which will also give you the option of removing the test
databases and anonymous user created by default. This is
strongly recommended for production servers.
See the MariaDB Knowledgebase at http://mariadb.com/kb or the
MySQL manual for more instructions.
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/
Database initialized
MySQL init process in progress...
2017-07-11 14:36:43 140376456128384 [Note] mysqld (mysqld 10.2.6-MariaDB-10.2.6+maria~jessie) starting as process 101 ...
2017-07-11 14:36:43 140376456128384 [Note] WSREP: Read nil XID from storage engines, skipping position init
2017-07-11 14:36:43 140376456128384 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib/galera/libgalera_smm.so'
2017-07-11 14:36:43 140376456128384 [Note] WSREP: wsrep_load(): Galera 25.3.20(r3703) by Codership Oy <info@codership.com> loaded successfully.
2017-07-11 14:36:43 140376456128384 [Note] WSREP: CRC-32C: using hardware acceleration.
2017-07-11 14:36:43 140376456128384 [Warning] WSREP: Could not open state file for reading: '/var/lib/mysql//grastate.dat'
2017-07-11 14:36:43 140376456128384 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1, safe_to_bootsrap: 1
2017-07-11 14:36:43 140376456128384 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = mysql-1.mysql.default.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_timeout = PT3S
2017-07-11 14:36:43 140376456128384 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(00000000-0000-0000-0000-000000000000:-1)
2017-07-11 14:36:43 140376456128384 [Note] WSREP: Assign initial position for certification: -1, protocol version: -1
2017-07-11 14:36:43 140376456128384 [Note] WSREP: wsrep_sst_grab()
2017-07-11 14:36:43 140376456128384 [Note] WSREP: Start replication
2017-07-11 14:36:43 140376456128384 [Note] WSREP: Setting initial position to 00000000-0000-0000-0000-000000000000:-1
2017-07-11 14:36:43 140376456128384 [Note] WSREP: protonet asio version 0
2017-07-11 14:36:43 140376456128384 [Note] WSREP: Using CRC-32C for message checksums.
2017-07-11 14:36:43 140376456128384 [Note] WSREP: backend: asio
2017-07-11 14:36:43 140376456128384 [Note] WSREP: gcomm thread scheduling priority set to other:0
2017-07-11 14:36:43 140376456128384 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)
2017-07-11 14:36:43 140376456128384 [Note] WSREP: restore pc from disk failed
2017-07-11 14:36:43 140376456128384 [Note] WSREP: GMCast version 0
2017-07-11 14:36:43 140376456128384 [Note] WSREP: (5bce4a9c, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2017-07-11 14:36:43 140376456128384 [Note] WSREP: (5bce4a9c, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2017-07-11 14:36:43 140376456128384 [Note] WSREP: EVS version 0
2017-07-11 14:36:43 140376456128384 [Note] WSREP: gcomm: connecting to group 'mysql', peer 'mysql-0.mysql.default.svc.cluster.local:'
2017-07-11 14:36:43 140376456128384 [Note] WSREP: (5bce4a9c, 'tcp://0.0.0.0:4567') connection established to 4ae4ccbd tcp://172.17.0.4:4567
2017-07-11 14:36:43 140376456128384 [Note] WSREP: (5bce4a9c, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2017-07-11 14:36:43 140376456128384 [Note] WSREP: declaring 4ae4ccbd at tcp://172.17.0.4:4567 stable
2017-07-11 14:36:43 140376456128384 [Note] WSREP: Node 4ae4ccbd state prim
2017-07-11 14:36:43 140376456128384 [Note] WSREP: view(view_id(PRIM,4ae4ccbd,2) memb {
4ae4ccbd,0
5bce4a9c,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:36:43 140376456128384 [Note] WSREP: save pc into disk
MySQL init process in progress...
2017-07-11 14:36:44 140376456128384 [Note] WSREP: gcomm: connected
2017-07-11 14:36:44 140376456128384 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2017-07-11 14:36:44 140376456128384 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2017-07-11 14:36:44 140376456128384 [Note] WSREP: Opened channel 'mysql'
2017-07-11 14:36:44 140376138532608 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 1, memb_num = 2
2017-07-11 14:36:44 140376138532608 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
2017-07-11 14:36:44 140376456128384 [Note] WSREP: Waiting for SST to complete.
2017-07-11 14:36:44 140376138532608 [Note] WSREP: STATE EXCHANGE: sent state msg: 5c1b8527-6646-11e7-a56b-cef03abc3d5c
2017-07-11 14:36:44 140376138532608 [Note] WSREP: STATE EXCHANGE: got state msg: 5c1b8527-6646-11e7-a56b-cef03abc3d5c from 0 (mysql-0)
2017-07-11 14:36:44 140376138532608 [Note] WSREP: STATE EXCHANGE: got state msg: 5c1b8527-6646-11e7-a56b-cef03abc3d5c from 1 (mysql-1)
2017-07-11 14:36:44 140376138532608 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 1,
members = 1/2 (joined/total),
act_id = 6,
last_appl. = -1,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 4875463d-6646-11e7-97c3-ca53f0dbfda2
2017-07-11 14:36:44 140376138532608 [Note] WSREP: Flow-control interval: [23, 23]
2017-07-11 14:36:44 140376138532608 [Note] WSREP: Shifting OPEN -> PRIMARY (TO: 6)
2017-07-11 14:36:44 140376454629120 [Note] WSREP: State transfer required:
Group state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6
Local state: 00000000-0000-0000-0000-000000000000:-1
2017-07-11 14:36:44 140376454629120 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# 2: Primary, number of nodes: 2, my index: 1, protocol version 3
2017-07-11 14:36:44 140376454629120 [Warning] WSREP: Gap in state sequence. Need state transfer.
2017-07-11 14:36:44 140376130139904 [Note] WSREP: Running: 'wsrep_sst_rsync --role 'joiner' --address 'mysql-1.mysql.default.svc.cluster.local' --datadir '/var/lib/mysql/' --parent '101' '' '
MySQL init process in progress...
MySQL init process in progress...
2017-07-11 14:36:46 140376149047040 [Note] WSREP: (5bce4a9c, 'tcp://0.0.0.0:4567') turning message relay requesting off
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process in progress...
MySQL init process failed.
It restarts and produces this the second time around before crashing (and this repeats in a crash loop):
2017-07-11 14:37:16 140176744875904 [Note] mysqld (mysqld 10.2.6-MariaDB-10.2.6+maria~jessie) starting as process 1 ...
2017-07-11 14:37:16 140176744875904 [Note] WSREP: Read nil XID from storage engines, skipping position init
2017-07-11 14:37:16 140176744875904 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib/galera/libgalera_smm.so'
2017-07-11 14:37:16 140176744875904 [Note] WSREP: wsrep_load(): Galera 25.3.20(r3703) by Codership Oy <info@codership.com> loaded successfully.
2017-07-11 14:37:16 140176744875904 [Note] WSREP: CRC-32C: using hardware acceleration.
2017-07-11 14:37:16 140176744875904 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1, safe_to_bootsrap: 1
2017-07-11 14:37:16 140176744875904 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = mysql-1.mysql.default.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_timeout = PT3S
2017-07-11 14:37:16 140176744875904 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(00000000-0000-0000-0000-000000000000:-1)
2017-07-11 14:37:16 140176744875904 [Note] WSREP: Assign initial position for certification: -1, protocol version: -1
2017-07-11 14:37:16 140176744875904 [Note] WSREP: wsrep_sst_grab()
2017-07-11 14:37:16 140176744875904 [Note] WSREP: Start replication
2017-07-11 14:37:16 140176744875904 [Note] WSREP: Setting initial position to 00000000-0000-0000-0000-000000000000:-1
2017-07-11 14:37:16 140176744875904 [Note] WSREP: protonet asio version 0
2017-07-11 14:37:16 140176744875904 [Note] WSREP: Using CRC-32C for message checksums.
2017-07-11 14:37:16 140176744875904 [Note] WSREP: backend: asio
2017-07-11 14:37:16 140176744875904 [Note] WSREP: gcomm thread scheduling priority set to other:0
2017-07-11 14:37:16 140176744875904 [Note] WSREP: restore pc from disk successfully
2017-07-11 14:37:16 140176744875904 [Note] WSREP: GMCast version 0
2017-07-11 14:37:16 140176744875904 [Note] WSREP: (5bce4a9c, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2017-07-11 14:37:16 140176744875904 [Note] WSREP: (5bce4a9c, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2017-07-11 14:37:16 140176744875904 [Note] WSREP: EVS version 0
2017-07-11 14:37:16 140176744875904 [Note] WSREP: gcomm: connecting to group 'mysql', peer 'mysql-0.mysql.default.svc.cluster.local:'
2017-07-11 14:37:16 140176744875904 [Note] WSREP: (5bce4a9c, 'tcp://0.0.0.0:4567') connection established to 4ae4ccbd tcp://172.17.0.4:4567
2017-07-11 14:37:16 140176744875904 [Note] WSREP: (5bce4a9c, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2017-07-11 14:37:16 140176744875904 [Note] WSREP: gcomm: connected
2017-07-11 14:37:16 140176744875904 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2017-07-11 14:37:16 140176744875904 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2017-07-11 14:37:16 140176744875904 [Note] WSREP: Opened channel 'mysql'
2017-07-11 14:37:16 140176744875904 [Note] WSREP: Waiting for SST to complete.
2017-07-11 14:37:18 140176433067776 [Warning] WSREP: no nodes coming from prim view, prim not possible
2017-07-11 14:37:18 140176433067776 [Note] WSREP: view(view_id(NON_PRIM,5bce4a9c,4) memb {
5bce4a9c,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:37:18 140176424675072 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
2017-07-11 14:37:18 140176424675072 [Note] WSREP: Flow-control interval: [16, 16]
2017-07-11 14:37:18 140176424675072 [Note] WSREP: Received NON-PRIMARY.
2017-07-11 14:37:18 140176743376640 [Note] WSREP: New cluster view: global state: :-1, view# -1: non-Primary, number of nodes: 1, my index: 0, protocol version -1
2017-07-11 14:37:18 140176743376640 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:37:19 140176433067776 [Note] WSREP: (5bce4a9c, 'tcp://0.0.0.0:4567') turning message relay requesting off
2017-07-11 14:37:19 140176433067776 [Note] WSREP: declaring 4ae4ccbd at tcp://172.17.0.4:4567 stable
2017-07-11 14:37:19 140176433067776 [Note] WSREP: re-bootstrapping prim from partitioned components
2017-07-11 14:37:19 140176433067776 [Note] WSREP: view(view_id(PRIM,4ae4ccbd,5) memb {
4ae4ccbd,0
5bce4a9c,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:37:19 140176433067776 [Note] WSREP: save pc into disk
2017-07-11 14:37:19 140176433067776 [Note] WSREP: clear restored view
2017-07-11 14:37:19 140176424675072 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 1, memb_num = 2
2017-07-11 14:37:19 140176424675072 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
2017-07-11 14:37:19 140176424675072 [Note] WSREP: STATE EXCHANGE: sent state msg: 71971c90-6646-11e7-b67d-ca2c69e08b05
2017-07-11 14:37:19 140176424675072 [Note] WSREP: STATE EXCHANGE: got state msg: 71971c90-6646-11e7-b67d-ca2c69e08b05 from 0 (mysql-0)
2017-07-11 14:37:19 140176424675072 [Note] WSREP: STATE EXCHANGE: got state msg: 71971c90-6646-11e7-b67d-ca2c69e08b05 from 1 (mysql-1)
2017-07-11 14:37:19 140176424675072 [Warning] WSREP: Quorum: No node with complete state:
Version : 4
Flags : 0x3
Protocols : 0 / 7 / 3
State : NON-PRIMARY
Desync count : 0
Prim state : SYNCED
Prim UUID : 5c1b8527-6646-11e7-a56b-cef03abc3d5c
Prim seqno : 2
First seqno : -1
Last seqno : 6
Prim JOINED : 1
State UUID : 71971c90-6646-11e7-b67d-ca2c69e08b05
Group UUID : 4875463d-6646-11e7-97c3-ca53f0dbfda2
Name : 'mysql-0'
Incoming addr: 'mysql-0.mysql.default.svc.cluster.local:3306'
Version : 4
Flags : 00
Protocols : 0 / 7 / 3
State : NON-PRIMARY
Desync count : 0
Prim state : NON-PRIMARY
Prim UUID : 00000000-0000-0000-0000-000000000000
Prim seqno : -1
First seqno : -1
Last seqno : -1
Prim JOINED : 0
State UUID : 71971c90-6646-11e7-b67d-ca2c69e08b05
Group UUID : 00000000-0000-0000-0000-000000000000
Name : 'mysql-1'
Incoming addr: 'mysql-1.mysql.default.svc.cluster.local:3306'
2017-07-11 14:37:19 140176424675072 [Note] WSREP: Full re-merge of primary 5c1b8527-6646-11e7-a56b-cef03abc3d5c found: 1 of 1.
2017-07-11 14:37:19 140176424675072 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 2,
members = 1/2 (joined/total),
act_id = 6,
last_appl. = -1,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 4875463d-6646-11e7-97c3-ca53f0dbfda2
2017-07-11 14:37:19 140176424675072 [Note] WSREP: Flow-control interval: [23, 23]
2017-07-11 14:37:19 140176424675072 [Note] WSREP: Shifting OPEN -> PRIMARY (TO: 6)
2017-07-11 14:37:19 140176743376640 [Note] WSREP: State transfer required:
Group state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6
Local state: 00000000-0000-0000-0000-000000000000:-1
2017-07-11 14:37:19 140176743376640 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# 3: Primary, number of nodes: 2, my index: 1, protocol version 3
2017-07-11 14:37:19 140176743376640 [Warning] WSREP: Gap in state sequence. Need state transfer.
2017-07-11 14:37:19 140176416282368 [Note] WSREP: Running: 'wsrep_sst_rsync --role 'joiner' --address 'mysql-1.mysql.default.svc.cluster.local' --datadir '/var/lib/mysql/' --parent '1' '' '
Here are the logs from mysql-0 during all of this:
Initializing database
PLEASE REMEMBER TO SET A PASSWORD FOR THE MariaDB root USER !
To do so, start the server, then issue the following commands:
'/usr/bin/mysqladmin' -u root password 'new-password'
'/usr/bin/mysqladmin' -u root -h password 'new-password'
Alternatively you can run:
'/usr/bin/mysql_secure_installation'
which will also give you the option of removing the test
databases and anonymous user created by default. This is
strongly recommended for production servers.
See the MariaDB Knowledgebase at http://mariadb.com/kb or the
MySQL manual for more instructions.
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/
Database initialized
MySQL init process in progress...
2017-07-11 14:36:10 140421855049600 [Note] mysqld (mysqld 10.2.6-MariaDB-10.2.6+maria~jessie) starting as process 101 ...
2017-07-11 14:36:10 140421855049600 [Note] WSREP: Read nil XID from storage engines, skipping position init
2017-07-11 14:36:10 140421855049600 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib/galera/libgalera_smm.so'
2017-07-11 14:36:10 140421855049600 [Note] WSREP: wsrep_load(): Galera 25.3.20(r3703) by Codership Oy <info@codership.com> loaded successfully.
2017-07-11 14:36:10 140421855049600 [Note] WSREP: CRC-32C: using hardware acceleration.
2017-07-11 14:36:10 140421855049600 [Warning] WSREP: Could not open state file for reading: '/var/lib/mysql//grastate.dat'
2017-07-11 14:36:10 140421855049600 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1, safe_to_bootsrap: 1
2017-07-11 14:36:10 140421855049600 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = mysql-0.mysql.default.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_timeout = PT3S
2017-07-11 14:36:10 140421855049600 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(00000000-0000-0000-0000-000000000000:-1)
2017-07-11 14:36:10 140421855049600 [Note] WSREP: Assign initial position for certification: -1, protocol version: -1
2017-07-11 14:36:10 140421855049600 [Note] WSREP: wsrep_sst_grab()
2017-07-11 14:36:10 140421855049600 [Note] WSREP: Start replication
2017-07-11 14:36:10 140421855049600 [Note] WSREP: Setting initial position to 00000000-0000-0000-0000-000000000000:-1
2017-07-11 14:36:10 140421855049600 [Note] WSREP: protonet asio version 0
2017-07-11 14:36:10 140421855049600 [Note] WSREP: Using CRC-32C for message checksums.
2017-07-11 14:36:10 140421855049600 [Note] WSREP: backend: asio
2017-07-11 14:36:10 140421855049600 [Note] WSREP: gcomm thread scheduling priority set to other:0
2017-07-11 14:36:10 140421855049600 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)
2017-07-11 14:36:10 140421855049600 [Note] WSREP: restore pc from disk failed
2017-07-11 14:36:10 140421855049600 [Note] WSREP: GMCast version 0
2017-07-11 14:36:10 140421855049600 [Note] WSREP: (48749526, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2017-07-11 14:36:10 140421855049600 [Note] WSREP: (48749526, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2017-07-11 14:36:10 140421855049600 [Note] WSREP: EVS version 0
2017-07-11 14:36:10 140421855049600 [Note] WSREP: gcomm: connecting to group 'mysql', peer ''
2017-07-11 14:36:10 140421855049600 [Note] WSREP: start_prim is enabled, turn off pc_recovery
2017-07-11 14:36:10 140421855049600 [Note] WSREP: Node 48749526 state prim
2017-07-11 14:36:10 140421855049600 [Note] WSREP: view(view_id(PRIM,48749526,1) memb {
48749526,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:36:10 140421855049600 [Note] WSREP: save pc into disk
2017-07-11 14:36:10 140421855049600 [Note] WSREP: gcomm: connected
2017-07-11 14:36:10 140421855049600 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2017-07-11 14:36:10 140421855049600 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2017-07-11 14:36:10 140421855049600 [Note] WSREP: Opened channel 'mysql'
2017-07-11 14:36:10 140421405599488 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
2017-07-11 14:36:10 140421855049600 [Note] WSREP: Waiting for SST to complete.
2017-07-11 14:36:10 140421405599488 [Note] WSREP: Starting new group from scratch: 4875463d-6646-11e7-97c3-ca53f0dbfda2
2017-07-11 14:36:10 140421405599488 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 487558a2-6646-11e7-9af5-f746d557c41a
2017-07-11 14:36:10 140421405599488 [Note] WSREP: STATE EXCHANGE: sent state msg: 487558a2-6646-11e7-9af5-f746d557c41a
2017-07-11 14:36:10 140421405599488 [Note] WSREP: STATE EXCHANGE: got state msg: 487558a2-6646-11e7-9af5-f746d557c41a from 0 (mysql-0)
2017-07-11 14:36:10 140421405599488 [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 = 4875463d-6646-11e7-97c3-ca53f0dbfda2
2017-07-11 14:36:10 140421405599488 [Note] WSREP: Flow-control interval: [16, 16]
2017-07-11 14:36:10 140421405599488 [Note] WSREP: Restored state OPEN -> JOINED (0)
2017-07-11 14:36:10 140421405599488 [Note] WSREP: Member 0.0 (mysql-0) synced with group.
2017-07-11 14:36:10 140421405599488 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 0)
2017-07-11 14:36:10 140421853550336 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:0, view# 1: Primary, number of nodes: 1, my index: 0, protocol version 3
2017-07-11 14:36:10 140421855049600 [Note] WSREP: SST complete, seqno: 0
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: Uses event mutexes
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: Compressed tables use zlib 1.2.8
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: Using Linux native AIO
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: Number of pools: 1
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: Using SSE2 crc32 instructions
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: Initializing buffer pool, total size = 256M, instances = 1, chunk size = 128M
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: Completed initialization of buffer pool
2017-07-11 14:36:10 140420718741248 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: Highest supported file format is Barracuda.
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: 128 out of 128 rollback segments are active.
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: Creating shared tablespace for temporary tables
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: Waiting for purge to start
2017-07-11 14:36:10 140421855049600 [Note] InnoDB: 5.7.14 started; log sequence number 1620098
2017-07-11 14:36:10 140420575119104 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool
2017-07-11 14:36:10 140420575119104 [Note] InnoDB: Buffer pool(s) load completed at 170711 14:36:10
2017-07-11 14:36:11 140421855049600 [Note] Plugin 'FEEDBACK' is disabled.
2017-07-11 14:36:11 140421855049600 [Warning] 'user' entry 'root@mysql-0' ignored in --skip-name-resolve mode.
2017-07-11 14:36:11 140421855049600 [Warning] 'proxies_priv' entry '@% root@mysql-0' ignored in --skip-name-resolve mode.
2017-07-11 14:36:11 140421853550336 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:36:11 140421853550336 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:36:11 140421853550336 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
2017-07-11 14:36:11 140421783381760 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:36:11 140421853550336 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(4875463d-6646-11e7-97c3-ca53f0dbfda2:0)
2017-07-11 14:36:11 140421855049600 [Note] Reading of all Master_info entries succeded
2017-07-11 14:36:11 140421855049600 [Note] Added new Master_info '' to hash table
2017-07-11 14:36:11 140421855049600 [Note] mysqld: ready for connections.
Version: '10.2.6-MariaDB-10.2.6+maria~jessie' socket: '/var/run/mysqld/mysqld.sock' port: 0 mariadb.org binary distribution
2017-07-11 14:36:11 140421853550336 [Note] WSREP: Synchronized with group, ready for connections
2017-07-11 14:36:11 140421853550336 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:36:11 140421482133248 [Warning] 'proxies_priv' entry '@% root@mysql-0' ignored in --skip-name-resolve mode.
2017-07-11 14:36:11 140421477508864 [Note] mysqld (unknown): Normal shutdown
2017-07-11 14:36:11 140421477508864 [Note] WSREP: Stop replication
2017-07-11 14:36:11 140421477508864 [Note] WSREP: Closing send monitor...
2017-07-11 14:36:11 140421477508864 [Note] WSREP: Closed send monitor.
2017-07-11 14:36:11 140421477508864 [Note] WSREP: gcomm: terminating thread
2017-07-11 14:36:11 140421477508864 [Note] WSREP: gcomm: joining thread
2017-07-11 14:36:11 140421477508864 [Note] WSREP: gcomm: closing backend
2017-07-11 14:36:11 140421477508864 [Note] WSREP: view((empty))
2017-07-11 14:36:11 140421477508864 [Note] WSREP: gcomm: closed
2017-07-11 14:36:11 140421405599488 [Note] WSREP: Received self-leave message.
2017-07-11 14:36:11 140421405599488 [Note] WSREP: Flow-control interval: [0, 0]
2017-07-11 14:36:11 140421405599488 [Note] WSREP: Received SELF-LEAVE. Closing connection.
2017-07-11 14:36:11 140421405599488 [Note] WSREP: Shifting SYNCED -> CLOSED (TO: 6)
2017-07-11 14:36:11 140421405599488 [Note] WSREP: RECV thread exiting 0: Success
2017-07-11 14:36:11 140421477508864 [Note] WSREP: recv_thread() joined.
2017-07-11 14:36:11 140421477508864 [Note] WSREP: Closing replication queue.
2017-07-11 14:36:11 140421477508864 [Note] WSREP: Closing slave action queue.
2017-07-11 14:36:11 140421853550336 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# -1: non-Primary, number of nodes: 0, my index: -1, protocol version 3
2017-07-11 14:36:11 140421853550336 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:36:11 140421853550336 [Note] WSREP: applier thread exiting (code:0)
2017-07-11 14:36:13 140421853853440 [Note] WSREP: rollbacker thread exiting
2017-07-11 14:36:13 140421477508864 [Note] Event Scheduler: Purging the queue. 0 events
2017-07-11 14:36:13 140421477508864 [Note] WSREP: dtor state: CLOSED
2017-07-11 14:36:13 140421477508864 [Note] WSREP: mon: entered 6 oooe fraction 0 oool fraction 0
2017-07-11 14:36:13 140421477508864 [Note] WSREP: mon: entered 6 oooe fraction 0 oool fraction 0
2017-07-11 14:36:13 140421477508864 [Note] WSREP: mon: entered 9 oooe fraction 0 oool fraction 0
2017-07-11 14:36:13 140421477508864 [Note] WSREP: cert index usage at exit 0
2017-07-11 14:36:13 140421477508864 [Note] WSREP: cert trx map usage at exit 6
2017-07-11 14:36:13 140421477508864 [Note] WSREP: deps set usage at exit 0
2017-07-11 14:36:13 140421477508864 [Note] WSREP: avg deps dist 1
2017-07-11 14:36:13 140421477508864 [Note] WSREP: avg cert interval 0
2017-07-11 14:36:13 140421477508864 [Note] WSREP: cert index size 3
2017-07-11 14:36:13 140421783381760 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:36:13 140421477508864 [Note] WSREP: wsdb trx map usage 0 conn query map usage 0
2017-07-11 14:36:13 140421477508864 [Note] WSREP: MemPool(LocalTrxHandle): hit ratio: 0, misses: 6, in use: 0, in pool: 6
2017-07-11 14:36:13 140421477508864 [Note] WSREP: MemPool(SlaveTrxHandle): hit ratio: 0, misses: 0, in use: 0, in pool: 0
2017-07-11 14:36:13 140421477508864 [Note] WSREP: Shifting CLOSED -> DESTROYED (TO: 6)
2017-07-11 14:36:13 140421477508864 [Note] WSREP: Flushing memory map to disk...
2017-07-11 14:36:13 140420558333696 [Note] InnoDB: FTS optimize thread exiting.
2017-07-11 14:36:13 140421477508864 [Note] InnoDB: Starting shutdown...
2017-07-11 14:36:13 140420575119104 [Note] InnoDB: Dumping buffer pool(s) to /var/lib/mysql/ib_buffer_pool
2017-07-11 14:36:13 140420575119104 [Note] InnoDB: Buffer pool(s) dump completed at 170711 14:36:13
2017-07-11 14:36:14 140421477508864 [Note] InnoDB: Shutdown completed; log sequence number 1621255
2017-07-11 14:36:14 140421477508864 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1"
2017-07-11 14:36:14 140421477508864 [Note] mysqld: Shutdown complete
MySQL init process done. Ready for start up.
2017-07-11 14:36:14 140545376614272 [Note] mysqld (mysqld 10.2.6-MariaDB-10.2.6+maria~jessie) starting as process 1 ...
2017-07-11 14:36:14 140545376614272 [Note] WSREP: Read nil XID from storage engines, skipping position init
2017-07-11 14:36:14 140545376614272 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib/galera/libgalera_smm.so'
2017-07-11 14:36:14 140545376614272 [Note] WSREP: wsrep_load(): Galera 25.3.20(r3703) by Codership Oy <info@codership.com> loaded successfully.
2017-07-11 14:36:14 140545376614272 [Note] WSREP: CRC-32C: using hardware acceleration.
2017-07-11 14:36:14 140545376614272 [Note] WSREP: Found saved state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, safe_to_bootsrap: 1
2017-07-11 14:36:14 140545376614272 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = mysql-0.mysql.default.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_timeout = PT3S
2017-07-11 14:36:14 140545376614272 [Note] WSREP: GCache history reset: old(4875463d-6646-11e7-97c3-ca53f0dbfda2:0) -> new(4875463d-6646-11e7-97c3-ca53f0dbfda2:6)
2017-07-11 14:36:14 140545376614272 [Note] WSREP: Assign initial position for certification: 6, protocol version: -1
2017-07-11 14:36:14 140545376614272 [Note] WSREP: wsrep_sst_grab()
2017-07-11 14:36:14 140545376614272 [Note] WSREP: Start replication
2017-07-11 14:36:14 140545376614272 [Note] WSREP: Setting initial position to 4875463d-6646-11e7-97c3-ca53f0dbfda2:6
2017-07-11 14:36:14 140545376614272 [Note] WSREP: protonet asio version 0
2017-07-11 14:36:14 140545376614272 [Note] WSREP: Using CRC-32C for message checksums.
2017-07-11 14:36:14 140545376614272 [Note] WSREP: backend: asio
2017-07-11 14:36:14 140545376614272 [Note] WSREP: gcomm thread scheduling priority set to other:0
2017-07-11 14:36:14 140545376614272 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)
2017-07-11 14:36:14 140545376614272 [Note] WSREP: restore pc from disk failed
2017-07-11 14:36:14 140545376614272 [Note] WSREP: GMCast version 0
2017-07-11 14:36:14 140545376614272 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2017-07-11 14:36:14 140545376614272 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2017-07-11 14:36:14 140545376614272 [Note] WSREP: EVS version 0
2017-07-11 14:36:14 140545376614272 [Note] WSREP: gcomm: connecting to group 'mysql', peer ''
2017-07-11 14:36:14 140545376614272 [Note] WSREP: start_prim is enabled, turn off pc_recovery
2017-07-11 14:36:14 140545376614272 [Note] WSREP: Node 4ae4ccbd state prim
2017-07-11 14:36:14 140545376614272 [Note] WSREP: view(view_id(PRIM,4ae4ccbd,1) memb {
4ae4ccbd,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:36:14 140545376614272 [Note] WSREP: save pc into disk
2017-07-11 14:36:14 140545376614272 [Note] WSREP: gcomm: connected
2017-07-11 14:36:14 140545376614272 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2017-07-11 14:36:14 140545376614272 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2017-07-11 14:36:14 140545376614272 [Note] WSREP: Opened channel 'mysql'
2017-07-11 14:36:14 140545053665024 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
2017-07-11 14:36:14 140545376614272 [Note] WSREP: Waiting for SST to complete.
2017-07-11 14:36:14 140545053665024 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 4ae52709-6646-11e7-badd-b6636eb24186
2017-07-11 14:36:14 140545053665024 [Note] WSREP: STATE EXCHANGE: sent state msg: 4ae52709-6646-11e7-badd-b6636eb24186
2017-07-11 14:36:14 140545053665024 [Note] WSREP: STATE EXCHANGE: got state msg: 4ae52709-6646-11e7-badd-b6636eb24186 from 0 (mysql-0)
2017-07-11 14:36:14 140545053665024 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 0,
members = 1/1 (joined/total),
act_id = 6,
last_appl. = -1,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 4875463d-6646-11e7-97c3-ca53f0dbfda2
2017-07-11 14:36:14 140545053665024 [Note] WSREP: Flow-control interval: [16, 16]
2017-07-11 14:36:14 140545053665024 [Note] WSREP: Restored state OPEN -> JOINED (6)
2017-07-11 14:36:14 140545053665024 [Note] WSREP: Member 0.0 (mysql-0) synced with group.
2017-07-11 14:36:14 140545053665024 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 6)
2017-07-11 14:36:14 140545375115008 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# 1: Primary, number of nodes: 1, my index: 0, protocol version 3
2017-07-11 14:36:14 140545376614272 [Note] WSREP: SST complete, seqno: 6
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: Uses event mutexes
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: Compressed tables use zlib 1.2.8
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: Using Linux native AIO
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: Number of pools: 1
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: Using SSE2 crc32 instructions
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: Initializing buffer pool, total size = 256M, instances = 1, chunk size = 128M
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: Completed initialization of buffer pool
2017-07-11 14:36:14 140544249374464 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: Highest supported file format is Barracuda.
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: 128 out of 128 rollback segments are active.
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: Creating shared tablespace for temporary tables
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
2017-07-11 14:36:14 140545376614272 [Note] InnoDB: Waiting for purge to start
2017-07-11 14:36:15 140545376614272 [Note] InnoDB: 5.7.14 started; log sequence number 1621255
2017-07-11 14:36:15 140544105752320 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool
2017-07-11 14:36:15 140544105752320 [Note] InnoDB: Buffer pool(s) load completed at 170711 14:36:15
2017-07-11 14:36:15 140545376614272 [Note] Plugin 'FEEDBACK' is disabled.
2017-07-11 14:36:15 140545376614272 [Note] Server socket created on IP: '0.0.0.0'.
2017-07-11 14:36:15 140545376614272 [Warning] 'proxies_priv' entry '@% root@mysql-0' ignored in --skip-name-resolve mode.
2017-07-11 14:36:15 140545376614272 [Note] Reading of all Master_info entries succeded
2017-07-11 14:36:15 140545376614272 [Note] Added new Master_info '' to hash table
2017-07-11 14:36:15 140545376614272 [Note] mysqld: ready for connections.
Version: '10.2.6-MariaDB-10.2.6+maria~jessie' socket: '/var/run/mysqld/mysqld.sock' port: 3306 mariadb.org binary distribution
2017-07-11 14:36:15 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:36:15 140545375115008 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:36:15 140545375115008 [Note] WSREP: Assign initial position for certification: 6, protocol version: 3
2017-07-11 14:36:15 140545304946432 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:36:15 140545375115008 [Note] WSREP: GCache history reset: old(4875463d-6646-11e7-97c3-ca53f0dbfda2:0) -> new(4875463d-6646-11e7-97c3-ca53f0dbfda2:6)
2017-07-11 14:36:15 140545375115008 [Note] WSREP: Synchronized with group, ready for connections
2017-07-11 14:36:15 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:36:43 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') connection established to 5bce4a9c tcp://172.17.0.5:4567
2017-07-11 14:36:43 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2017-07-11 14:36:43 140545062057728 [Note] WSREP: declaring 5bce4a9c at tcp://172.17.0.5:4567 stable
2017-07-11 14:36:43 140545062057728 [Note] WSREP: Node 4ae4ccbd state prim
2017-07-11 14:36:43 140545062057728 [Note] WSREP: view(view_id(PRIM,4ae4ccbd,2) memb {
4ae4ccbd,0
5bce4a9c,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:36:43 140545062057728 [Note] WSREP: save pc into disk
2017-07-11 14:36:43 140545053665024 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 2
2017-07-11 14:36:43 140545053665024 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 5c1b8527-6646-11e7-a56b-cef03abc3d5c
2017-07-11 14:36:43 140545053665024 [Note] WSREP: STATE EXCHANGE: sent state msg: 5c1b8527-6646-11e7-a56b-cef03abc3d5c
2017-07-11 14:36:43 140545053665024 [Note] WSREP: STATE EXCHANGE: got state msg: 5c1b8527-6646-11e7-a56b-cef03abc3d5c from 0 (mysql-0)
2017-07-11 14:36:44 140545053665024 [Note] WSREP: STATE EXCHANGE: got state msg: 5c1b8527-6646-11e7-a56b-cef03abc3d5c from 1 (mysql-1)
2017-07-11 14:36:44 140545053665024 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 1,
members = 1/2 (joined/total),
act_id = 6,
last_appl. = 0,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 4875463d-6646-11e7-97c3-ca53f0dbfda2
2017-07-11 14:36:44 140545053665024 [Note] WSREP: Flow-control interval: [23, 23]
2017-07-11 14:36:44 140545375115008 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# 2: Primary, number of nodes: 2, my index: 0, protocol version 3
2017-07-11 14:36:44 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:36:44 140545375115008 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:36:44 140545375115008 [Note] WSREP: Assign initial position for certification: 6, protocol version: 3
2017-07-11 14:36:44 140545304946432 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:36:46 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') turning message relay requesting off
2017-07-11 14:37:14 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers: tcp://172.17.0.5:4567
2017-07-11 14:37:15 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') reconnecting to 5bce4a9c (tcp://172.17.0.5:4567), attempt 0
2017-07-11 14:37:16 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') connection established to 5bce4a9c tcp://172.17.0.5:4567
2017-07-11 14:37:18 140545062057728 [Note] WSREP: evs::proto(4ae4ccbd, OPERATIONAL, view_id(REG,4ae4ccbd,2)) suspecting node: 5bce4a9c
2017-07-11 14:37:18 140545062057728 [Note] WSREP: evs::proto(4ae4ccbd, OPERATIONAL, view_id(REG,4ae4ccbd,2)) suspected node without join message, declaring inactive
2017-07-11 14:37:19 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') turning message relay requesting off
2017-07-11 14:37:19 140545062057728 [Note] WSREP: view(view_id(NON_PRIM,4ae4ccbd,2) memb {
4ae4ccbd,0
} joined {
} left {
} partitioned {
5bce4a9c,0
})
2017-07-11 14:37:19 140545062057728 [Note] WSREP: view(view_id(NON_PRIM,4ae4ccbd,3) memb {
4ae4ccbd,0
} joined {
} left {
} partitioned {
5bce4a9c,0
})
2017-07-11 14:37:19 140545053665024 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
2017-07-11 14:37:19 140545053665024 [Note] WSREP: Flow-control interval: [16, 16]
2017-07-11 14:37:19 140545053665024 [Note] WSREP: Received NON-PRIMARY.
2017-07-11 14:37:19 140545053665024 [Note] WSREP: Shifting SYNCED -> OPEN (TO: 6)
2017-07-11 14:37:19 140545053665024 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
2017-07-11 14:37:19 140545053665024 [Note] WSREP: Flow-control interval: [16, 16]
2017-07-11 14:37:19 140545053665024 [Note] WSREP: Received NON-PRIMARY.
2017-07-11 14:37:19 140545375115008 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# -1: non-Primary, number of nodes: 1, my index: 0, protocol version 3
2017-07-11 14:37:19 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:37:19 140545375115008 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# -1: non-Primary, number of nodes: 1, my index: 0, protocol version 3
2017-07-11 14:37:19 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:37:19 140545062057728 [Note] WSREP: declaring 5bce4a9c at tcp://172.17.0.5:4567 stable
2017-07-11 14:37:19 140545062057728 [Note] WSREP: re-bootstrapping prim from partitioned components
2017-07-11 14:37:19 140545062057728 [Note] WSREP: view(view_id(PRIM,4ae4ccbd,5) memb {
4ae4ccbd,0
5bce4a9c,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:37:19 140545062057728 [Note] WSREP: save pc into disk
2017-07-11 14:37:19 140545053665024 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 2
2017-07-11 14:37:19 140545053665024 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 71971c90-6646-11e7-b67d-ca2c69e08b05
2017-07-11 14:37:19 140545053665024 [Note] WSREP: STATE EXCHANGE: sent state msg: 71971c90-6646-11e7-b67d-ca2c69e08b05
2017-07-11 14:37:19 140545053665024 [Note] WSREP: STATE EXCHANGE: got state msg: 71971c90-6646-11e7-b67d-ca2c69e08b05 from 0 (mysql-0)
2017-07-11 14:37:19 140545053665024 [Note] WSREP: STATE EXCHANGE: got state msg: 71971c90-6646-11e7-b67d-ca2c69e08b05 from 1 (mysql-1)
2017-07-11 14:37:19 140545053665024 [Warning] WSREP: Quorum: No node with complete state:
Version : 4
Flags : 0x3
Protocols : 0 / 7 / 3
State : NON-PRIMARY
Desync count : 0
Prim state : SYNCED
Prim UUID : 5c1b8527-6646-11e7-a56b-cef03abc3d5c
Prim seqno : 2
First seqno : -1
Last seqno : 6
Prim JOINED : 1
State UUID : 71971c90-6646-11e7-b67d-ca2c69e08b05
Group UUID : 4875463d-6646-11e7-97c3-ca53f0dbfda2
Name : 'mysql-0'
Incoming addr: 'mysql-0.mysql.default.svc.cluster.local:3306'
Version : 4
Flags : 00
Protocols : 0 / 7 / 3
State : NON-PRIMARY
Desync count : 0
Prim state : NON-PRIMARY
Prim UUID : 00000000-0000-0000-0000-000000000000
Prim seqno : -1
First seqno : -1
Last seqno : -1
Prim JOINED : 0
State UUID : 71971c90-6646-11e7-b67d-ca2c69e08b05
Group UUID : 00000000-0000-0000-0000-000000000000
Name : 'mysql-1'
Incoming addr: 'mysql-1.mysql.default.svc.cluster.local:3306'
2017-07-11 14:37:19 140545053665024 [Note] WSREP: Full re-merge of primary 5c1b8527-6646-11e7-a56b-cef03abc3d5c found: 1 of 1.
2017-07-11 14:37:19 140545053665024 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 2,
members = 1/2 (joined/total),
act_id = 6,
last_appl. = 0,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 4875463d-6646-11e7-97c3-ca53f0dbfda2
2017-07-11 14:37:19 140545053665024 [Note] WSREP: Flow-control interval: [23, 23]
2017-07-11 14:37:19 140545053665024 [Note] WSREP: Restored state OPEN -> SYNCED (6)
2017-07-11 14:37:19 140545375115008 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# 3: Primary, number of nodes: 2, my index: 0, protocol version 3
2017-07-11 14:37:19 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:37:19 140545375115008 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:37:19 140545375115008 [Note] WSREP: Assign initial position for certification: 6, protocol version: 3
2017-07-11 14:37:19 140545304946432 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:37:19 140545375115008 [Note] WSREP: Synchronized with group, ready for connections
2017-07-11 14:37:19 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:38:52 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers: tcp://172.17.0.5:4567
2017-07-11 14:38:53 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') reconnecting to 5bce4a9c (tcp://172.17.0.5:4567), attempt 0
2017-07-11 14:38:56 140545062057728 [Note] WSREP: evs::proto(4ae4ccbd, OPERATIONAL, view_id(REG,4ae4ccbd,5)) suspecting node: 5bce4a9c
2017-07-11 14:38:56 140545062057728 [Note] WSREP: evs::proto(4ae4ccbd, OPERATIONAL, view_id(REG,4ae4ccbd,5)) suspected node without join message, declaring inactive
2017-07-11 14:38:57 140545062057728 [Note] WSREP: view(view_id(NON_PRIM,4ae4ccbd,5) memb {
4ae4ccbd,0
} joined {
} left {
} partitioned {
5bce4a9c,0
})
2017-07-11 14:38:57 140545053665024 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
2017-07-11 14:38:57 140545053665024 [Note] WSREP: Flow-control interval: [16, 16]
2017-07-11 14:38:57 140545053665024 [Note] WSREP: Received NON-PRIMARY.
2017-07-11 14:38:57 140545053665024 [Note] WSREP: Shifting SYNCED -> OPEN (TO: 6)
2017-07-11 14:38:57 140545062057728 [Note] WSREP: view(view_id(NON_PRIM,4ae4ccbd,6) memb {
4ae4ccbd,0
} joined {
} left {
} partitioned {
5bce4a9c,0
})
2017-07-11 14:38:57 140545053665024 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
2017-07-11 14:38:57 140545053665024 [Note] WSREP: Flow-control interval: [16, 16]
2017-07-11 14:38:57 140545053665024 [Note] WSREP: Received NON-PRIMARY.
2017-07-11 14:38:57 140545375115008 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# -1: non-Primary, number of nodes: 1, my index: 0, protocol version 3
2017-07-11 14:38:57 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:38:57 140545375115008 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# -1: non-Primary, number of nodes: 1, my index: 0, protocol version 3
2017-07-11 14:38:57 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:39:08 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') connection established to 5bce4a9c tcp://172.17.0.5:4567
2017-07-11 14:39:08 140545062057728 [Note] WSREP: declaring 5bce4a9c at tcp://172.17.0.5:4567 stable
2017-07-11 14:39:08 140545062057728 [Note] WSREP: re-bootstrapping prim from partitioned components
2017-07-11 14:39:08 140545062057728 [Note] WSREP: view(view_id(PRIM,4ae4ccbd,7) memb {
4ae4ccbd,0
5bce4a9c,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:39:08 140545062057728 [Note] WSREP: save pc into disk
2017-07-11 14:39:08 140545053665024 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 2
2017-07-11 14:39:08 140545053665024 [Note] WSREP: STATE_EXCHANGE: sent state UUID: b2b03944-6646-11e7-bcf6-466c62a51890
2017-07-11 14:39:08 140545053665024 [Note] WSREP: STATE EXCHANGE: sent state msg: b2b03944-6646-11e7-bcf6-466c62a51890
2017-07-11 14:39:08 140545053665024 [Note] WSREP: STATE EXCHANGE: got state msg: b2b03944-6646-11e7-bcf6-466c62a51890 from 0 (mysql-0)
2017-07-11 14:39:08 140545053665024 [Note] WSREP: STATE EXCHANGE: got state msg: b2b03944-6646-11e7-bcf6-466c62a51890 from 1 (mysql-1)
2017-07-11 14:39:08 140545053665024 [Warning] WSREP: Quorum: No node with complete state:
Version : 4
Flags : 0x3
Protocols : 0 / 7 / 3
State : NON-PRIMARY
Desync count : 0
Prim state : SYNCED
Prim UUID : 71971c90-6646-11e7-b67d-ca2c69e08b05
Prim seqno : 3
First seqno : -1
Last seqno : 6
Prim JOINED : 1
State UUID : b2b03944-6646-11e7-bcf6-466c62a51890
Group UUID : 4875463d-6646-11e7-97c3-ca53f0dbfda2
Name : 'mysql-0'
Incoming addr: 'mysql-0.mysql.default.svc.cluster.local:3306'
Version : 4
Flags : 00
Protocols : 0 / 7 / 3
State : NON-PRIMARY
Desync count : 0
Prim state : NON-PRIMARY
Prim UUID : 00000000-0000-0000-0000-000000000000
Prim seqno : -1
First seqno : -1
Last seqno : -1
Prim JOINED : 0
State UUID : b2b03944-6646-11e7-bcf6-466c62a51890
Group UUID : 00000000-0000-0000-0000-000000000000
Name : 'mysql-1'
Incoming addr: 'mysql-1.mysql.default.svc.cluster.local:3306'
2017-07-11 14:39:08 140545053665024 [Note] WSREP: Full re-merge of primary 71971c90-6646-11e7-b67d-ca2c69e08b05 found: 1 of 1.
2017-07-11 14:39:08 140545053665024 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 3,
members = 1/2 (joined/total),
act_id = 6,
last_appl. = 0,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 4875463d-6646-11e7-97c3-ca53f0dbfda2
2017-07-11 14:39:08 140545053665024 [Note] WSREP: Flow-control interval: [23, 23]
2017-07-11 14:39:08 140545053665024 [Note] WSREP: Restored state OPEN -> SYNCED (6)
2017-07-11 14:39:08 140545375115008 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# 4: Primary, number of nodes: 2, my index: 0, protocol version 3
2017-07-11 14:39:08 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:39:08 140545375115008 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:39:08 140545375115008 [Note] WSREP: Assign initial position for certification: 6, protocol version: 3
2017-07-11 14:39:08 140545304946432 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:39:08 140545375115008 [Note] WSREP: Synchronized with group, ready for connections
2017-07-11 14:39:08 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:39:11 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') turning message relay requesting off
2017-07-11 14:40:22 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers: tcp://172.17.0.5:4567
2017-07-11 14:40:23 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') reconnecting to 5bce4a9c (tcp://172.17.0.5:4567), attempt 0
2017-07-11 14:40:27 140545062057728 [Note] WSREP: evs::proto(4ae4ccbd, OPERATIONAL, view_id(REG,4ae4ccbd,7)) suspecting node: 5bce4a9c
2017-07-11 14:40:27 140545062057728 [Note] WSREP: evs::proto(4ae4ccbd, OPERATIONAL, view_id(REG,4ae4ccbd,7)) suspected node without join message, declaring inactive
2017-07-11 14:40:28 140545062057728 [Note] WSREP: view(view_id(NON_PRIM,4ae4ccbd,7) memb {
4ae4ccbd,0
} joined {
} left {
} partitioned {
5bce4a9c,0
})
2017-07-11 14:40:28 140545062057728 [Note] WSREP: view(view_id(NON_PRIM,4ae4ccbd,8) memb {
4ae4ccbd,0
} joined {
} left {
} partitioned {
5bce4a9c,0
})
2017-07-11 14:40:28 140545053665024 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
2017-07-11 14:40:28 140545053665024 [Note] WSREP: Flow-control interval: [16, 16]
2017-07-11 14:40:28 140545053665024 [Note] WSREP: Received NON-PRIMARY.
2017-07-11 14:40:28 140545053665024 [Note] WSREP: Shifting SYNCED -> OPEN (TO: 6)
2017-07-11 14:40:28 140545053665024 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
2017-07-11 14:40:28 140545053665024 [Note] WSREP: Flow-control interval: [16, 16]
2017-07-11 14:40:28 140545053665024 [Note] WSREP: Received NON-PRIMARY.
2017-07-11 14:40:28 140545375115008 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# -1: non-Primary, number of nodes: 1, my index: 0, protocol version 3
2017-07-11 14:40:28 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:40:28 140545375115008 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# -1: non-Primary, number of nodes: 1, my index: 0, protocol version 3
2017-07-11 14:40:28 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:40:49 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') connection established to 5bce4a9c tcp://172.17.0.5:4567
2017-07-11 14:40:49 140545062057728 [Note] WSREP: declaring 5bce4a9c at tcp://172.17.0.5:4567 stable
2017-07-11 14:40:49 140545062057728 [Note] WSREP: re-bootstrapping prim from partitioned components
2017-07-11 14:40:49 140545062057728 [Note] WSREP: view(view_id(PRIM,4ae4ccbd,9) memb {
4ae4ccbd,0
5bce4a9c,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:40:49 140545062057728 [Note] WSREP: save pc into disk
2017-07-11 14:40:49 140545053665024 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 2
2017-07-11 14:40:49 140545053665024 [Note] WSREP: STATE_EXCHANGE: sent state UUID: eed9f76e-6646-11e7-b963-6396ba3d106c
2017-07-11 14:40:49 140545053665024 [Note] WSREP: STATE EXCHANGE: sent state msg: eed9f76e-6646-11e7-b963-6396ba3d106c
2017-07-11 14:40:49 140545053665024 [Note] WSREP: STATE EXCHANGE: got state msg: eed9f76e-6646-11e7-b963-6396ba3d106c from 0 (mysql-0)
2017-07-11 14:40:50 140545053665024 [Note] WSREP: STATE EXCHANGE: got state msg: eed9f76e-6646-11e7-b963-6396ba3d106c from 1 (mysql-1)
2017-07-11 14:40:50 140545053665024 [Warning] WSREP: Quorum: No node with complete state:
Version : 4
Flags : 0x3
Protocols : 0 / 7 / 3
State : NON-PRIMARY
Desync count : 0
Prim state : SYNCED
Prim UUID : b2b03944-6646-11e7-bcf6-466c62a51890
Prim seqno : 4
First seqno : -1
Last seqno : 6
Prim JOINED : 1
State UUID : eed9f76e-6646-11e7-b963-6396ba3d106c
Group UUID : 4875463d-6646-11e7-97c3-ca53f0dbfda2
Name : 'mysql-0'
Incoming addr: 'mysql-0.mysql.default.svc.cluster.local:3306'
Version : 4
Flags : 00
Protocols : 0 / 7 / 3
State : NON-PRIMARY
Desync count : 0
Prim state : NON-PRIMARY
Prim UUID : 00000000-0000-0000-0000-000000000000
Prim seqno : -1
First seqno : -1
Last seqno : -1
Prim JOINED : 0
State UUID : eed9f76e-6646-11e7-b963-6396ba3d106c
Group UUID : 00000000-0000-0000-0000-000000000000
Name : 'mysql-1'
Incoming addr: 'mysql-1.mysql.default.svc.cluster.local:3306'
2017-07-11 14:40:50 140545053665024 [Note] WSREP: Full re-merge of primary b2b03944-6646-11e7-bcf6-466c62a51890 found: 1 of 1.
2017-07-11 14:40:50 140545053665024 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 4,
members = 1/2 (joined/total),
act_id = 6,
last_appl. = 0,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 4875463d-6646-11e7-97c3-ca53f0dbfda2
2017-07-11 14:40:50 140545053665024 [Note] WSREP: Flow-control interval: [23, 23]
2017-07-11 14:40:50 140545053665024 [Note] WSREP: Restored state OPEN -> SYNCED (6)
2017-07-11 14:40:50 140545375115008 [Note] WSREP: New cluster view: global state: 4875463d-6646-11e7-97c3-ca53f0dbfda2:6, view# 5: Primary, number of nodes: 2, my index: 0, protocol version 3
2017-07-11 14:40:50 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:40:50 140545375115008 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:40:50 140545375115008 [Note] WSREP: Assign initial position for certification: 6, protocol version: 3
2017-07-11 14:40:50 140545304946432 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:40:50 140545375115008 [Note] WSREP: Synchronized with group, ready for connections
2017-07-11 14:40:50 140545375115008 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:40:52 140545062057728 [Note] WSREP: (4ae4ccbd, 'tcp://0.0.0.0:4567') turning message relay requesting off
Meanwhile, with 10.1, you get the same initial failure for mysql-1 (and mysql-2) but the second starts work:
2017-07-11 14:49:35 140315252537280 [Note] mysqld (mysqld 10.1.25-MariaDB-1~jessie) starting as process 1 ...
2017-07-11 14:49:35 140315252537280 [Note] WSREP: Read nil XID from storage engines, skipping position init
2017-07-11 14:49:35 140315252537280 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib/galera/libgalera_smm.so'
2017-07-11 14:49:35 140315252537280 [Note] WSREP: wsrep_load(): Galera 25.3.20(r3703) by Codership Oy <info@codership.com> loaded successfully.
2017-07-11 14:49:35 140315252537280 [Note] WSREP: CRC-32C: using hardware acceleration.
2017-07-11 14:49:35 140315252537280 [Note] WSREP: Found saved state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:-1, safe_to_bootsrap: 0
2017-07-11 14:49:35 140315252537280 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = mysql-1.mysql.default.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_timeout = PT3S
2017-07-11 14:49:35 140315252537280 [Note] WSREP: GCache history reset: old(01ccd89d-6648-11e7-8238-9a58e864dd8b:0) -> new(01ccd89d-6648-11e7-8238-9a58e864dd8b:-1)
2017-07-11 14:49:35 140315252537280 [Note] WSREP: Assign initial position for certification: -1, protocol version: -1
2017-07-11 14:49:35 140315252537280 [Note] WSREP: wsrep_sst_grab()
2017-07-11 14:49:35 140315252537280 [Note] WSREP: Start replication
2017-07-11 14:49:35 140315252537280 [Note] WSREP: Setting initial position to 00000000-0000-0000-0000-000000000000:-1
2017-07-11 14:49:35 140315252537280 [Note] WSREP: protonet asio version 0
2017-07-11 14:49:35 140315252537280 [Note] WSREP: Using CRC-32C for message checksums.
2017-07-11 14:49:35 140315252537280 [Note] WSREP: backend: asio
2017-07-11 14:49:35 140315252537280 [Note] WSREP: gcomm thread scheduling priority set to other:0
2017-07-11 14:49:35 140315252537280 [Note] WSREP: restore pc from disk successfully
2017-07-11 14:49:35 140315252537280 [Note] WSREP: GMCast version 0
2017-07-11 14:49:35 140315252537280 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2017-07-11 14:49:35 140315252537280 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2017-07-11 14:49:35 140315252537280 [Note] WSREP: EVS version 0
2017-07-11 14:49:35 140315252537280 [Note] WSREP: gcomm: connecting to group 'mysql', peer 'mysql-0.mysql.default.svc.cluster.local:'
2017-07-11 14:49:35 140315252537280 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') connection established to 04d3794f tcp://172.17.0.4:4567
2017-07-11 14:49:35 140315252537280 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers: tcp://172.17.0.6:4567
2017-07-11 14:49:35 140315252537280 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') connection established to 263d09bf tcp://172.17.0.6:4567
2017-07-11 14:49:36 140315252537280 [Note] WSREP: gcomm: connected
2017-07-11 14:49:36 140315252537280 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2017-07-11 14:49:36 140315252537280 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2017-07-11 14:49:36 140315252537280 [Note] WSREP: Opened channel 'mysql'
2017-07-11 14:49:36 140315252537280 [Note] WSREP: Waiting for SST to complete.
2017-07-11 14:49:38 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') turning message relay requesting off
2017-07-11 14:49:39 140314979333888 [Warning] WSREP: no nodes coming from prim view, prim not possible
2017-07-11 14:49:39 140314979333888 [Note] WSREP: view(view_id(NON_PRIM,1469dcce,5) memb {
1469dcce,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:49:39 140314970941184 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
2017-07-11 14:49:39 140314970941184 [Note] WSREP: Flow-control interval: [16, 16]
2017-07-11 14:49:39 140314970941184 [Note] WSREP: Received NON-PRIMARY.
2017-07-11 14:49:39 140315252222720 [Note] WSREP: New cluster view: global state: :-1, view# -1: non-Primary, number of nodes: 1, my index: 0, protocol version -1
2017-07-11 14:49:39 140315252222720 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:40 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers: tcp://172.17.0.6:4567
2017-07-11 14:49:41 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') reconnecting to 263d09bf (tcp://172.17.0.6:4567), attempt 0
2017-07-11 14:49:43 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') connection to peer 04d3794f with addr tcp://172.17.0.4:4567 timed out, no messages seen in PT3S
2017-07-11 14:49:44 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') connection to peer 263d09bf with addr tcp://172.17.0.6:4567 timed out, no messages seen in PT3S
2017-07-11 14:49:44 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') reconnecting to 04d3794f (tcp://172.17.0.4:4567), attempt 0
2017-07-11 14:49:44 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') connection established to 04d3794f tcp://172.17.0.4:4567
2017-07-11 14:49:44 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') connection established to 263d09bf tcp://172.17.0.6:4567
2017-07-11 14:49:46 140314979333888 [Note] WSREP: declaring 04d3794f at tcp://172.17.0.4:4567 stable
2017-07-11 14:49:46 140314979333888 [Note] WSREP: declaring 263d09bf at tcp://172.17.0.6:4567 stable
2017-07-11 14:49:46 140314979333888 [Note] WSREP: Node 04d3794f state prim
2017-07-11 14:49:46 140314979333888 [Note] WSREP: view(view_id(PRIM,04d3794f,6) memb {
04d3794f,0
1469dcce,0
263d09bf,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:49:46 140314979333888 [Note] WSREP: save pc into disk
2017-07-11 14:49:46 140314979333888 [Note] WSREP: clear restored view
2017-07-11 14:49:46 140314970941184 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 1, memb_num = 3
2017-07-11 14:49:46 140314970941184 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
2017-07-11 14:49:46 140314970941184 [Warning] WSREP: SYNC message from member 2 in non-primary configuration. Ignored.
2017-07-11 14:49:46 140314970941184 [Warning] WSREP: SYNC message from member 0 in non-primary configuration. Ignored.
2017-07-11 14:49:46 140314970941184 [Note] WSREP: STATE EXCHANGE: sent state msg: 2ee4e078-6648-11e7-9f30-7660a921dd6a
2017-07-11 14:49:46 140314970941184 [Note] WSREP: STATE EXCHANGE: got state msg: 2ee4e078-6648-11e7-9f30-7660a921dd6a from 2 (mysql-2)
2017-07-11 14:49:46 140314970941184 [Note] WSREP: STATE EXCHANGE: got state msg: 2ee4e078-6648-11e7-9f30-7660a921dd6a from 0 (mysql-0)
2017-07-11 14:49:46 140314970941184 [Note] WSREP: STATE EXCHANGE: got state msg: 2ee4e078-6648-11e7-9f30-7660a921dd6a from 1 (mysql-1)
2017-07-11 14:49:46 140314970941184 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 3,
members = 2/3 (joined/total),
act_id = 6,
last_appl. = -1,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 01ccd89d-6648-11e7-8238-9a58e864dd8b
2017-07-11 14:49:46 140314970941184 [Note] WSREP: Flow-control interval: [28, 28]
2017-07-11 14:49:46 140314970941184 [Note] WSREP: Shifting OPEN -> PRIMARY (TO: 6)
2017-07-11 14:49:46 140315252222720 [Note] WSREP: State transfer required:
Group state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:6
Local state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:-1
2017-07-11 14:49:46 140315252222720 [Note] WSREP: New cluster view: global state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:6, view# 4: Primary, number of nodes: 3, my index: 1, protocol version 3
2017-07-11 14:49:46 140315252222720 [Warning] WSREP: Gap in state sequence. Need state transfer.
2017-07-11 14:49:46 140314941585152 [Note] WSREP: Running: 'wsrep_sst_rsync --role 'joiner' --address 'mysql-1.mysql.default.svc.cluster.local' --datadir '/var/lib/mysql/' --parent '1' '' '
2017-07-11 14:49:46 140314970941184 [Note] WSREP: Member 2.0 (mysql-2) synced with group.
2017-07-11 14:49:46 140314970941184 [Note] WSREP: Member 0.0 (mysql-0) synced with group.
2017-07-11 14:49:46 140315252222720 [Note] WSREP: Prepared SST request: rsync|mysql-1.mysql.default.svc.cluster.local:4444/rsync_sst
2017-07-11 14:49:46 140315252222720 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:46 140315252222720 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:49:46 140315252222720 [Note] WSREP: Assign initial position for certification: 6, protocol version: 3
2017-07-11 14:49:46 140315028977408 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:49:46 140315252222720 [Warning] WSREP: Failed to prepare for incremental state transfer: Local state seqno is undefined: 1 (Operation not permitted)
at galera/src/replicator_str.cpp:prepare_for_IST():491. IST will be unavailable.
2017-07-11 14:49:46 140314970941184 [Note] WSREP: Member 1.0 (mysql-1) requested state transfer from '*any*'. Selected 0.0 (mysql-0)(SYNCED) as donor.
2017-07-11 14:49:46 140314970941184 [Note] WSREP: Shifting PRIMARY -> JOINER (TO: 6)
2017-07-11 14:49:46 140315252222720 [Note] WSREP: Requesting state transfer: success, donor: 0
2017-07-11 14:49:46 140315252222720 [Note] WSREP: GCache history reset: old(01ccd89d-6648-11e7-8238-9a58e864dd8b:0) -> new(01ccd89d-6648-11e7-8238-9a58e864dd8b:6)
2017-07-11 14:49:47 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') turning message relay requesting off
2017-07-11 14:49:48 140314970941184 [Note] WSREP: 0.0 (mysql-0): State transfer to 1.0 (mysql-1) complete.
2017-07-11 14:49:48 140314970941184 [Note] WSREP: Member 0.0 (mysql-0) synced with group.
WSREP_SST: [INFO] Joiner cleanup. rsync PID: 72 (20170711 14:49:48.929)
WSREP_SST: [INFO] Joiner cleanup done. (20170711 14:49:49.437)
2017-07-11 14:49:49 140315252537280 [Note] WSREP: SST complete, seqno: 6
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: The InnoDB memory heap is disabled
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: Compressed tables use zlib 1.2.8
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: Using Linux native AIO
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: Using SSE crc32 instructions
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: Initializing buffer pool, size = 256.0M
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: Completed initialization of buffer pool
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: Highest supported file format is Barracuda.
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: The log sequence number 1617965 in ibdata file do not match the log sequence number 1618129 in the ib_logfiles!
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: Restoring possible half-written data pages from the doublewrite buffer...
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: 128 rollback segment(s) are active.
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: Waiting for purge to start
2017-07-11 14:49:49 140315252537280 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1618129
2017-07-11 14:49:49 140314295625472 [Note] InnoDB: Dumping buffer pool(s) not yet started
2017-07-11 14:49:49 140315252537280 [Note] Plugin 'FEEDBACK' is disabled.
2017-07-11 14:49:49 140315252537280 [Note] Recovering after a crash using tc.log
2017-07-11 14:49:49 140315252537280 [Note] Starting crash recovery...
2017-07-11 14:49:49 140315252537280 [Note] Crash recovery finished.
2017-07-11 14:49:50 140315252537280 [Note] Server socket created on IP: '0.0.0.0'.
2017-07-11 14:49:50 140315252537280 [Warning] 'proxies_priv' entry '@% root@mysql-0' ignored in --skip-name-resolve mode.
2017-07-11 14:49:50 140315252537280 [Note] WSREP: Signalling provider to continue.
2017-07-11 14:49:50 140315252537280 [Note] WSREP: SST received: 01ccd89d-6648-11e7-8238-9a58e864dd8b:6
2017-07-11 14:49:50 140314970941184 [Note] WSREP: 1.0 (mysql-1): State transfer from 0.0 (mysql-0) complete.
2017-07-11 14:49:50 140314970941184 [Note] WSREP: Shifting JOINER -> JOINED (TO: 6)
2017-07-11 14:49:50 140314970941184 [Note] WSREP: Member 1.0 (mysql-1) synced with group.
2017-07-11 14:49:50 140314970941184 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 6)
2017-07-11 14:49:50 140315252222720 [Note] WSREP: Synchronized with group, ready for connections
2017-07-11 14:49:50 140315252222720 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:50 140315252537280 [Note] mysqld: ready for connections.
Version: '10.1.25-MariaDB-1~jessie' socket: '/var/run/mysqld/mysqld.sock' port: 3306 mariadb.org binary distribution
2017-07-11 14:50:03 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers: tcp://172.17.0.6:4567
2017-07-11 14:50:04 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') reconnecting to 263d09bf (tcp://172.17.0.6:4567), attempt 0
2017-07-11 14:50:05 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') connection established to 263d09bf tcp://172.17.0.6:4567
2017-07-11 14:50:07 140314979333888 [Note] WSREP: evs::proto(1469dcce, OPERATIONAL, view_id(REG,04d3794f,6)) suspecting node: 263d09bf
2017-07-11 14:50:07 140314979333888 [Note] WSREP: evs::proto(1469dcce, OPERATIONAL, view_id(REG,04d3794f,6)) suspected node without join message, declaring inactive
2017-07-11 14:50:08 140314979333888 [Note] WSREP: (1469dcce, 'tcp://0.0.0.0:4567') turning message relay requesting off
2017-07-11 14:50:08 140314979333888 [Note] WSREP: declaring 04d3794f at tcp://172.17.0.4:4567 stable
2017-07-11 14:50:08 140314979333888 [Note] WSREP: Node 04d3794f state prim
2017-07-11 14:50:08 140314979333888 [Note] WSREP: declaring 04d3794f at tcp://172.17.0.4:4567 stable
2017-07-11 14:50:08 140314979333888 [Note] WSREP: declaring 263d09bf at tcp://172.17.0.6:4567 stable
2017-07-11 14:50:09 140314979333888 [Note] WSREP: Node 04d3794f state prim
2017-07-11 14:50:09 140314979333888 [Note] WSREP: view(view_id(PRIM,04d3794f,9) memb {
04d3794f,0
1469dcce,0
263d09bf,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:50:09 140314979333888 [Note] WSREP: save pc into disk
2017-07-11 14:50:09 140314970941184 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 1, memb_num = 3
2017-07-11 14:50:09 140314970941184 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
2017-07-11 14:50:09 140314970941184 [Note] WSREP: STATE EXCHANGE: sent state msg: 3c9b785d-6648-11e7-b973-371547992b6b
2017-07-11 14:50:09 140314970941184 [Note] WSREP: STATE EXCHANGE: got state msg: 3c9b785d-6648-11e7-b973-371547992b6b from 0 (mysql-0)
2017-07-11 14:50:09 140314970941184 [Note] WSREP: STATE EXCHANGE: got state msg: 3c9b785d-6648-11e7-b973-371547992b6b from 1 (mysql-1)
2017-07-11 14:50:09 140314970941184 [Note] WSREP: STATE EXCHANGE: got state msg: 3c9b785d-6648-11e7-b973-371547992b6b from 2 (mysql-2)
2017-07-11 14:50:09 140314970941184 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 4,
members = 2/3 (joined/total),
act_id = 6,
last_appl. = 0,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 01ccd89d-6648-11e7-8238-9a58e864dd8b
2017-07-11 14:50:09 140314970941184 [Note] WSREP: Flow-control interval: [28, 28]
2017-07-11 14:50:09 140315252222720 [Note] WSREP: New cluster view: global state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:6, view# 5: Primary, number of nodes: 3, my index: 1, protocol version 3
2017-07-11 14:50:09 140315252222720 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:50:09 140315252222720 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:50:09 140315252222720 [Note] WSREP: Assign initial position for certification: 6, protocol version: 3
2017-07-11 14:50:09 140315028977408 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:50:09 140314970941184 [Note] WSREP: Member 2.0 (mysql-2) requested state transfer from '*any*'. Selected 0.0 (mysql-0)(SYNCED) as donor.
2017-07-11 14:50:11 140314970941184 [Note] WSREP: 0.0 (mysql-0): State transfer to 2.0 (mysql-2) complete.
2017-07-11 14:50:11 140314970941184 [Note] WSREP: Member 0.0 (mysql-0) synced with group.
2017-07-11 14:50:12 140314970941184 [Note] WSREP: 2.0 (mysql-2): State transfer from 0.0 (mysql-0) complete.
2017-07-11 14:50:12 140314970941184 [Note] WSREP: Member 2.0 (mysql-2) synced with group.
mysql-0:
Initializing database
2017-07-11 14:48:18 140490190305216 [Note] /usr/sbin/mysqld (mysqld 10.1.25-MariaDB-1~jessie) starting as process 66 ...
2017-07-11 14:48:18 140490190305216 [Note] WSREP: Read nil XID from storage engines, skipping position init
2017-07-11 14:48:18 140490190305216 [Note] WSREP: wsrep_load(): loading provider library 'none'
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: The InnoDB memory heap is disabled
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: Compressed tables use zlib 1.2.8
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: Using Linux native AIO
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: Using SSE crc32 instructions
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: Initializing buffer pool, size = 256.0M
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: Completed initialization of buffer pool
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: The first specified data file ./ibdata1 did not exist: a new database to be created!
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: Setting file ./ibdata1 size to 12 MB
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: Setting log file ./ib_logfile101 size to 64 MB
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: Setting log file ./ib_logfile1 size to 64 MB
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: Renaming log file ./ib_logfile101 to ./ib_logfile0
2017-07-11 14:48:18 140490190305216 [Warning] InnoDB: New log files created, LSN=45883
2017-07-11 14:48:18 140490190305216 [Note] InnoDB: Doublewrite buffer not found: creating new
2017-07-11 14:48:19 140490190305216 [Note] InnoDB: Doublewrite buffer created
2017-07-11 14:48:19 140490190305216 [Note] InnoDB: 128 rollback segment(s) are active.
2017-07-11 14:48:19 140490190305216 [Warning] InnoDB: Creating foreign key constraint system tables.
2017-07-11 14:48:19 140490190305216 [Note] InnoDB: Foreign key constraint system tables created
2017-07-11 14:48:19 140490190305216 [Note] InnoDB: Creating tablespace and datafile system tables.
2017-07-11 14:48:19 140490190305216 [Note] InnoDB: Tablespace and datafile system tables created.
2017-07-11 14:48:19 140490190305216 [Note] InnoDB: Waiting for purge to start
2017-07-11 14:48:19 140490190305216 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 0
2017-07-11 14:48:19 140489433020160 [Note] InnoDB: Dumping buffer pool(s) not yet started
2017-07-11 14:48:22 140626002864064 [Note] /usr/sbin/mysqld (mysqld 10.1.25-MariaDB-1~jessie) starting as process 94 ...
2017-07-11 14:48:22 140626002864064 [Note] WSREP: Read nil XID from storage engines, skipping position init
2017-07-11 14:48:22 140626002864064 [Note] WSREP: wsrep_load(): loading provider library 'none'
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: The InnoDB memory heap is disabled
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: Compressed tables use zlib 1.2.8
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: Using Linux native AIO
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: Using SSE crc32 instructions
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: Initializing buffer pool, size = 256.0M
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: Completed initialization of buffer pool
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: Highest supported file format is Barracuda.
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: 128 rollback segment(s) are active.
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: Waiting for purge to start
2017-07-11 14:48:23 140626002864064 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616799
2017-07-11 14:48:23 140625265555200 [Note] InnoDB: Dumping buffer pool(s) not yet started
2017-07-11 14:48:26 139804555442112 [Note] /usr/sbin/mysqld (mysqld 10.1.25-MariaDB-1~jessie) starting as process 123 ...
2017-07-11 14:48:26 139804555442112 [Note] WSREP: Read nil XID from storage engines, skipping position init
2017-07-11 14:48:26 139804555442112 [Note] WSREP: wsrep_load(): loading provider library 'none'
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: The InnoDB memory heap is disabled
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: Compressed tables use zlib 1.2.8
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: Using Linux native AIO
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: Using SSE crc32 instructions
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: Initializing buffer pool, size = 256.0M
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: Completed initialization of buffer pool
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: Highest supported file format is Barracuda.
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: 128 rollback segment(s) are active.
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: Waiting for purge to start
2017-07-11 14:48:27 139804555442112 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616809
2017-07-11 14:48:27 139803815311104 [Note] InnoDB: Dumping buffer pool(s) not yet started
PLEASE REMEMBER TO SET A PASSWORD FOR THE MariaDB root USER !
To do so, start the server, then issue the following commands:
'/usr/bin/mysqladmin' -u root password 'new-password'
'/usr/bin/mysqladmin' -u root -h password 'new-password'
Alternatively you can run:
'/usr/bin/mysql_secure_installation'
which will also give you the option of removing the test
databases and anonymous user created by default. This is
strongly recommended for production servers.
See the MariaDB Knowledgebase at http://mariadb.com/kb or the
MySQL manual for more instructions.
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/
Database initialized
MySQL init process in progress...
2017-07-11 14:48:31 140646287587264 [Note] mysqld (mysqld 10.1.25-MariaDB-1~jessie) starting as process 156 ...
2017-07-11 14:48:31 140646287587264 [Note] WSREP: Read nil XID from storage engines, skipping position init
2017-07-11 14:48:31 140646287587264 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib/galera/libgalera_smm.so'
2017-07-11 14:48:31 140646287587264 [Note] WSREP: wsrep_load(): Galera 25.3.20(r3703) by Codership Oy <info@codership.com> loaded successfully.
2017-07-11 14:48:31 140646287587264 [Note] WSREP: CRC-32C: using hardware acceleration.
2017-07-11 14:48:31 140646287587264 [Warning] WSREP: Could not open state file for reading: '/var/lib/mysql//grastate.dat'
2017-07-11 14:48:31 140646287587264 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1, safe_to_bootsrap: 1
2017-07-11 14:48:31 140646287587264 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = mysql-0.mysql.default.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_timeout = PT3S
2017-07-11 14:48:31 140646287587264 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(00000000-0000-0000-0000-000000000000:-1)
2017-07-11 14:48:31 140646287587264 [Note] WSREP: Assign initial position for certification: -1, protocol version: -1
2017-07-11 14:48:31 140646287587264 [Note] WSREP: wsrep_sst_grab()
2017-07-11 14:48:31 140646287587264 [Note] WSREP: Start replication
2017-07-11 14:48:31 140646287587264 [Note] WSREP: Setting initial position to 00000000-0000-0000-0000-000000000000:-1
2017-07-11 14:48:31 140646287587264 [Note] WSREP: protonet asio version 0
2017-07-11 14:48:31 140646287587264 [Note] WSREP: Using CRC-32C for message checksums.
2017-07-11 14:48:31 140646287587264 [Note] WSREP: backend: asio
2017-07-11 14:48:31 140646287587264 [Note] WSREP: gcomm thread scheduling priority set to other:0
2017-07-11 14:48:31 140646287587264 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)
2017-07-11 14:48:31 140646287587264 [Note] WSREP: restore pc from disk failed
2017-07-11 14:48:31 140646287587264 [Note] WSREP: GMCast version 0
2017-07-11 14:48:31 140646287587264 [Note] WSREP: (01cc668d, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2017-07-11 14:48:31 140646287587264 [Note] WSREP: (01cc668d, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2017-07-11 14:48:31 140646287587264 [Note] WSREP: EVS version 0
2017-07-11 14:48:31 140646287587264 [Note] WSREP: gcomm: connecting to group 'mysql', peer ''
2017-07-11 14:48:31 140646287587264 [Note] WSREP: start_prim is enabled, turn off pc_recovery
2017-07-11 14:48:31 140646287587264 [Note] WSREP: Node 01cc668d state prim
2017-07-11 14:48:31 140646287587264 [Note] WSREP: view(view_id(PRIM,01cc668d,1) memb {
01cc668d,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:48:31 140646287587264 [Note] WSREP: save pc into disk
2017-07-11 14:48:31 140646287587264 [Note] WSREP: gcomm: connected
2017-07-11 14:48:31 140646287587264 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2017-07-11 14:48:31 140646287587264 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2017-07-11 14:48:31 140646287587264 [Note] WSREP: Opened channel 'mysql'
2017-07-11 14:48:31 140646287587264 [Note] WSREP: Waiting for SST to complete.
2017-07-11 14:48:31 140646006384384 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
2017-07-11 14:48:31 140646006384384 [Note] WSREP: Starting new group from scratch: 01ccd89d-6648-11e7-8238-9a58e864dd8b
2017-07-11 14:48:31 140646006384384 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 01ccde55-6648-11e7-afb1-2b0278c92aac
2017-07-11 14:48:31 140646006384384 [Note] WSREP: STATE EXCHANGE: sent state msg: 01ccde55-6648-11e7-afb1-2b0278c92aac
2017-07-11 14:48:31 140646006384384 [Note] WSREP: STATE EXCHANGE: got state msg: 01ccde55-6648-11e7-afb1-2b0278c92aac from 0 (mysql-0)
2017-07-11 14:48:31 140646006384384 [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 = 01ccd89d-6648-11e7-8238-9a58e864dd8b
2017-07-11 14:48:31 140646006384384 [Note] WSREP: Flow-control interval: [16, 16]
2017-07-11 14:48:31 140646006384384 [Note] WSREP: Restored state OPEN -> JOINED (0)
2017-07-11 14:48:31 140646287272704 [Note] WSREP: New cluster view: global state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:0, view# 1: Primary, number of nodes: 1, my index: 0, protocol version 3
2017-07-11 14:48:31 140646287587264 [Note] WSREP: SST complete, seqno: 0
2017-07-11 14:48:31 140646006384384 [Note] WSREP: Member 0.0 (mysql-0) synced with group.
2017-07-11 14:48:31 140646006384384 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 0)
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: The InnoDB memory heap is disabled
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: Compressed tables use zlib 1.2.8
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: Using Linux native AIO
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: Using SSE crc32 instructions
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: Initializing buffer pool, size = 256.0M
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: Completed initialization of buffer pool
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: Highest supported file format is Barracuda.
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: 128 rollback segment(s) are active.
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: Waiting for purge to start
2017-07-11 14:48:31 140646287587264 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1616819
2017-07-11 14:48:31 140645343651584 [Note] InnoDB: Dumping buffer pool(s) not yet started
2017-07-11 14:48:31 140646287587264 [Note] Plugin 'FEEDBACK' is disabled.
2017-07-11 14:48:31 140646287587264 [Warning] 'user' entry 'root@mysql-0' ignored in --skip-name-resolve mode.
2017-07-11 14:48:31 140646287587264 [Warning] 'proxies_priv' entry '@% root@mysql-0' ignored in --skip-name-resolve mode.
2017-07-11 14:48:31 140646287272704 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:48:31 140646287272704 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:48:31 140646287272704 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
2017-07-11 14:48:31 140646064420608 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:48:31 140646287272704 [Note] WSREP: GCache history reset: old(00000000-0000-0000-0000-000000000000:0) -> new(01ccd89d-6648-11e7-8238-9a58e864dd8b:0)
2017-07-11 14:48:31 140646287272704 [Note] WSREP: Synchronized with group, ready for connections
2017-07-11 14:48:31 140646287272704 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:48:31 140646287587264 [Note] mysqld: ready for connections.
Version: '10.1.25-MariaDB-1~jessie' socket: '/var/run/mysqld/mysqld.sock' port: 0 mariadb.org binary distribution
2017-07-11 14:48:32 140646286109440 [Warning] 'proxies_priv' entry '@% root@mysql-0' ignored in --skip-name-resolve mode.
2017-07-11 14:48:32 140646234401536 [Note] mysqld: Normal shutdown
2017-07-11 14:48:32 140646234401536 [Note] WSREP: Stop replication
2017-07-11 14:48:32 140646234401536 [Note] WSREP: Closing send monitor...
2017-07-11 14:48:32 140646234401536 [Note] WSREP: Closed send monitor.
2017-07-11 14:48:32 140646234401536 [Note] WSREP: gcomm: terminating thread
2017-07-11 14:48:32 140646234401536 [Note] WSREP: gcomm: joining thread
2017-07-11 14:48:32 140646234401536 [Note] WSREP: gcomm: closing backend
2017-07-11 14:48:32 140646234401536 [Note] WSREP: view((empty))
2017-07-11 14:48:32 140646234401536 [Note] WSREP: gcomm: closed
2017-07-11 14:48:32 140646006384384 [Note] WSREP: Received self-leave message.
2017-07-11 14:48:32 140646006384384 [Note] WSREP: Flow-control interval: [0, 0]
2017-07-11 14:48:32 140646006384384 [Note] WSREP: Received SELF-LEAVE. Closing connection.
2017-07-11 14:48:32 140646006384384 [Note] WSREP: Shifting SYNCED -> CLOSED (TO: 6)
2017-07-11 14:48:32 140646287272704 [Note] WSREP: New cluster view: global state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:6, view# -1: non-Primary, number of nodes: 0, my index: -1, protocol version 3
2017-07-11 14:48:32 140646287272704 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:48:32 140646287272704 [Note] WSREP: applier thread exiting (code:0)
2017-07-11 14:48:32 140646006384384 [Note] WSREP: RECV thread exiting 0: Success
2017-07-11 14:48:32 140646234401536 [Note] WSREP: recv_thread() joined.
2017-07-11 14:48:32 140646234401536 [Note] WSREP: Closing replication queue.
2017-07-11 14:48:32 140646234401536 [Note] WSREP: Closing slave action queue.
2017-07-11 14:48:34 140646287575808 [Note] WSREP: rollbacker thread exiting
2017-07-11 14:48:34 140646234401536 [Note] Event Scheduler: Purging the queue. 0 events
2017-07-11 14:48:34 140646234401536 [Note] WSREP: dtor state: CLOSED
2017-07-11 14:48:34 140646234401536 [Note] WSREP: mon: entered 6 oooe fraction 0 oool fraction 0
2017-07-11 14:48:34 140646234401536 [Note] WSREP: mon: entered 6 oooe fraction 0 oool fraction 0
2017-07-11 14:48:34 140646234401536 [Note] WSREP: mon: entered 9 oooe fraction 0 oool fraction 0
2017-07-11 14:48:34 140646234401536 [Note] WSREP: cert index usage at exit 0
2017-07-11 14:48:34 140646234401536 [Note] WSREP: cert trx map usage at exit 6
2017-07-11 14:48:34 140646234401536 [Note] WSREP: deps set usage at exit 0
2017-07-11 14:48:34 140646234401536 [Note] WSREP: avg deps dist 1
2017-07-11 14:48:34 140646234401536 [Note] WSREP: avg cert interval 0
2017-07-11 14:48:34 140646234401536 [Note] WSREP: cert index size 3
2017-07-11 14:48:34 140646064420608 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:48:34 140646234401536 [Note] WSREP: wsdb trx map usage 0 conn query map usage 0
2017-07-11 14:48:34 140646234401536 [Note] WSREP: MemPool(LocalTrxHandle): hit ratio: 0, misses: 6, in use: 0, in pool: 6
2017-07-11 14:48:34 140646234401536 [Note] WSREP: MemPool(SlaveTrxHandle): hit ratio: 0, misses: 0, in use: 0, in pool: 0
2017-07-11 14:48:34 140646234401536 [Note] WSREP: Shifting CLOSED -> DESTROYED (TO: 6)
2017-07-11 14:48:34 140646234401536 [Note] WSREP: Flushing memory map to disk...
2017-07-11 14:48:34 140645377222400 [Note] InnoDB: FTS optimize thread exiting.
2017-07-11 14:48:34 140646234401536 [Note] InnoDB: Starting shutdown...
2017-07-11 14:48:34 140646234401536 [Note] InnoDB: Waiting for page_cleaner to finish flushing of buffer pool
2017-07-11 14:48:36 140646234401536 [Note] InnoDB: Shutdown completed; log sequence number 1617965
2017-07-11 14:48:36 140646234401536 [Note] mysqld: Shutdown complete
MySQL init process done. Ready for start up.
2017-07-11 14:48:36 139632711940032 [Note] mysqld (mysqld 10.1.25-MariaDB-1~jessie) starting as process 1 ...
2017-07-11 14:48:36 139632711940032 [Note] WSREP: Read nil XID from storage engines, skipping position init
2017-07-11 14:48:36 139632711940032 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib/galera/libgalera_smm.so'
2017-07-11 14:48:36 139632711940032 [Note] WSREP: wsrep_load(): Galera 25.3.20(r3703) by Codership Oy <info@codership.com> loaded successfully.
2017-07-11 14:48:36 139632711940032 [Note] WSREP: CRC-32C: using hardware acceleration.
2017-07-11 14:48:36 139632711940032 [Note] WSREP: Found saved state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:6, safe_to_bootsrap: 1
2017-07-11 14:48:36 139632711940032 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = mysql-0.mysql.default.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_timeout = PT3S
2017-07-11 14:48:36 139632711940032 [Note] WSREP: GCache history reset: old(01ccd89d-6648-11e7-8238-9a58e864dd8b:0) -> new(01ccd89d-6648-11e7-8238-9a58e864dd8b:6)
2017-07-11 14:48:36 139632711940032 [Note] WSREP: Assign initial position for certification: 6, protocol version: -1
2017-07-11 14:48:36 139632711940032 [Note] WSREP: wsrep_sst_grab()
2017-07-11 14:48:36 139632711940032 [Note] WSREP: Start replication
2017-07-11 14:48:36 139632711940032 [Note] WSREP: Setting initial position to 01ccd89d-6648-11e7-8238-9a58e864dd8b:6
2017-07-11 14:48:36 139632711940032 [Note] WSREP: protonet asio version 0
2017-07-11 14:48:36 139632711940032 [Note] WSREP: Using CRC-32C for message checksums.
2017-07-11 14:48:36 139632711940032 [Note] WSREP: backend: asio
2017-07-11 14:48:36 139632711940032 [Note] WSREP: gcomm thread scheduling priority set to other:0
2017-07-11 14:48:36 139632711940032 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)
2017-07-11 14:48:36 139632711940032 [Note] WSREP: restore pc from disk failed
2017-07-11 14:48:36 139632711940032 [Note] WSREP: GMCast version 0
2017-07-11 14:48:36 139632711940032 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
2017-07-11 14:48:36 139632711940032 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
2017-07-11 14:48:36 139632711940032 [Note] WSREP: EVS version 0
2017-07-11 14:48:36 139632711940032 [Note] WSREP: gcomm: connecting to group 'mysql', peer ''
2017-07-11 14:48:36 139632711940032 [Note] WSREP: start_prim is enabled, turn off pc_recovery
2017-07-11 14:48:36 139632711940032 [Note] WSREP: Node 04d3794f state prim
2017-07-11 14:48:36 139632711940032 [Note] WSREP: view(view_id(PRIM,04d3794f,1) memb {
04d3794f,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:48:36 139632711940032 [Note] WSREP: save pc into disk
2017-07-11 14:48:36 139632711940032 [Note] WSREP: gcomm: connected
2017-07-11 14:48:36 139632711940032 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
2017-07-11 14:48:36 139632711940032 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
2017-07-11 14:48:36 139632711940032 [Note] WSREP: Opened channel 'mysql'
2017-07-11 14:48:36 139632711940032 [Note] WSREP: Waiting for SST to complete.
2017-07-11 14:48:36 139632431851264 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
2017-07-11 14:48:36 139632431851264 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 04d4c928-6648-11e7-bf6f-52e02cb6c194
2017-07-11 14:48:36 139632431851264 [Note] WSREP: STATE EXCHANGE: sent state msg: 04d4c928-6648-11e7-bf6f-52e02cb6c194
2017-07-11 14:48:36 139632431851264 [Note] WSREP: STATE EXCHANGE: got state msg: 04d4c928-6648-11e7-bf6f-52e02cb6c194 from 0 (mysql-0)
2017-07-11 14:48:36 139632431851264 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 0,
members = 1/1 (joined/total),
act_id = 6,
last_appl. = -1,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 01ccd89d-6648-11e7-8238-9a58e864dd8b
2017-07-11 14:48:36 139632431851264 [Note] WSREP: Flow-control interval: [16, 16]
2017-07-11 14:48:36 139632431851264 [Note] WSREP: Restored state OPEN -> JOINED (6)
2017-07-11 14:48:36 139632431851264 [Note] WSREP: Member 0.0 (mysql-0) synced with group.
2017-07-11 14:48:36 139632431851264 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 6)
2017-07-11 14:48:36 139632711625472 [Note] WSREP: New cluster view: global state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:6, view# 1: Primary, number of nodes: 1, my index: 0, protocol version 3
2017-07-11 14:48:36 139632711940032 [Note] WSREP: SST complete, seqno: 6
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: The InnoDB memory heap is disabled
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: Compressed tables use zlib 1.2.8
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: Using Linux native AIO
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: Using SSE crc32 instructions
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: Initializing buffer pool, size = 256.0M
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: Completed initialization of buffer pool
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: Highest supported file format is Barracuda.
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: 128 rollback segment(s) are active.
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: Waiting for purge to start
2017-07-11 14:48:36 139632711940032 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.36-82.0 started; log sequence number 1617965
2017-07-11 14:48:36 139631769118464 [Note] InnoDB: Dumping buffer pool(s) not yet started
2017-07-11 14:48:36 139632711940032 [Note] Plugin 'FEEDBACK' is disabled.
2017-07-11 14:48:36 139632711940032 [Note] Server socket created on IP: '0.0.0.0'.
2017-07-11 14:48:36 139632711940032 [Warning] 'proxies_priv' entry '@% root@mysql-0' ignored in --skip-name-resolve mode.
2017-07-11 14:48:36 139632711940032 [Note] mysqld: ready for connections.
Version: '10.1.25-MariaDB-1~jessie' socket: '/var/run/mysqld/mysqld.sock' port: 3306 mariadb.org binary distribution
2017-07-11 14:48:36 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:48:36 139632711625472 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:48:36 139632711625472 [Note] WSREP: Assign initial position for certification: 6, protocol version: 3
2017-07-11 14:48:36 139632489887488 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:48:36 139632711625472 [Note] WSREP: GCache history reset: old(01ccd89d-6648-11e7-8238-9a58e864dd8b:0) -> new(01ccd89d-6648-11e7-8238-9a58e864dd8b:6)
2017-07-11 14:48:36 139632711625472 [Note] WSREP: Synchronized with group, ready for connections
2017-07-11 14:48:36 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:02 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') connection established to 1469dcce tcp://172.17.0.5:4567
2017-07-11 14:49:02 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2017-07-11 14:49:02 139632440243968 [Note] WSREP: declaring 1469dcce at tcp://172.17.0.5:4567 stable
2017-07-11 14:49:02 139632440243968 [Note] WSREP: Node 04d3794f state prim
2017-07-11 14:49:02 139632440243968 [Note] WSREP: view(view_id(PRIM,04d3794f,2) memb {
04d3794f,0
1469dcce,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:49:02 139632440243968 [Note] WSREP: save pc into disk
2017-07-11 14:49:02 139632431851264 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 2
2017-07-11 14:49:02 139632431851264 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 14b6f952-6648-11e7-b605-0f9c2a108542
2017-07-11 14:49:02 139632431851264 [Note] WSREP: STATE EXCHANGE: sent state msg: 14b6f952-6648-11e7-b605-0f9c2a108542
2017-07-11 14:49:02 139632431851264 [Note] WSREP: STATE EXCHANGE: got state msg: 14b6f952-6648-11e7-b605-0f9c2a108542 from 0 (mysql-0)
2017-07-11 14:49:03 139632431851264 [Note] WSREP: STATE EXCHANGE: got state msg: 14b6f952-6648-11e7-b605-0f9c2a108542 from 1 (mysql-1)
2017-07-11 14:49:03 139632431851264 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 1,
members = 1/2 (joined/total),
act_id = 6,
last_appl. = 0,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 01ccd89d-6648-11e7-8238-9a58e864dd8b
2017-07-11 14:49:03 139632431851264 [Note] WSREP: Flow-control interval: [23, 23]
2017-07-11 14:49:03 139632711625472 [Note] WSREP: New cluster view: global state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:6, view# 2: Primary, number of nodes: 2, my index: 0, protocol version 3
2017-07-11 14:49:03 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:03 139632711625472 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:49:03 139632711625472 [Note] WSREP: Assign initial position for certification: 6, protocol version: 3
2017-07-11 14:49:03 139632489887488 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:49:03 139632431851264 [Note] WSREP: Member 1.0 (mysql-1) requested state transfer from '*any*'. Selected 0.0 (mysql-0)(SYNCED) as donor.
2017-07-11 14:49:03 139632431851264 [Note] WSREP: Shifting SYNCED -> DONOR/DESYNCED (TO: 6)
2017-07-11 14:49:03 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:03 139631576217344 [Note] WSREP: Running: 'wsrep_sst_rsync --role 'donor' --address 'mysql-1.mysql.default.svc.cluster.local:4444/rsync_sst' --socket '/var/run/mysqld/mysqld.sock' --datadir '/var/lib/mysql/' '' --gtid '01ccd89d-6648-11e7-8238-9a58e864dd8b:6' --gtid-domain-id '0''
2017-07-11 14:49:03 139632711625472 [Note] WSREP: sst_donor_thread signaled with 0
2017-07-11 14:49:03 139631576217344 [Note] WSREP: Flushing tables for SST...
2017-07-11 14:49:03 139631576217344 [Note] WSREP: Provider paused at 01ccd89d-6648-11e7-8238-9a58e864dd8b:6 (5)
2017-07-11 14:49:03 139631576217344 [Note] WSREP: Tables flushed.
2017-07-11 14:49:05 139631576217344 [Note] WSREP: resuming provider at 5
2017-07-11 14:49:05 139631576217344 [Note] WSREP: Provider resumed.
2017-07-11 14:49:05 139632431851264 [Note] WSREP: 0.0 (mysql-0): State transfer to 1.0 (mysql-1) complete.
2017-07-11 14:49:05 139632431851264 [Note] WSREP: Shifting DONOR/DESYNCED -> JOINED (TO: 6)
2017-07-11 14:49:05 139632431851264 [Note] WSREP: Member 0.0 (mysql-0) synced with group.
2017-07-11 14:49:05 139632431851264 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 6)
2017-07-11 14:49:05 139632711625472 [Note] WSREP: Synchronized with group, ready for connections
2017-07-11 14:49:05 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:05 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') turning message relay requesting off
2017-07-11 14:49:06 139632431851264 [Note] WSREP: 1.0 (mysql-1): State transfer from 0.0 (mysql-0) complete.
2017-07-11 14:49:06 139632431851264 [Note] WSREP: Member 1.0 (mysql-1) synced with group.
2017-07-11 14:49:32 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') connection established to 263d09bf tcp://172.17.0.6:4567
2017-07-11 14:49:32 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2017-07-11 14:49:32 139632440243968 [Note] WSREP: declaring 1469dcce at tcp://172.17.0.5:4567 stable
2017-07-11 14:49:32 139632440243968 [Note] WSREP: declaring 263d09bf at tcp://172.17.0.6:4567 stable
2017-07-11 14:49:32 139632440243968 [Note] WSREP: Node 04d3794f state prim
2017-07-11 14:49:32 139632440243968 [Note] WSREP: view(view_id(PRIM,04d3794f,3) memb {
04d3794f,0
1469dcce,0
263d09bf,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:49:32 139632440243968 [Note] WSREP: save pc into disk
2017-07-11 14:49:32 139632431851264 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 3
2017-07-11 14:49:32 139632431851264 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 268ac26f-6648-11e7-8010-226139e6369e
2017-07-11 14:49:32 139632431851264 [Note] WSREP: STATE EXCHANGE: sent state msg: 268ac26f-6648-11e7-8010-226139e6369e
2017-07-11 14:49:32 139632431851264 [Note] WSREP: STATE EXCHANGE: got state msg: 268ac26f-6648-11e7-8010-226139e6369e from 0 (mysql-0)
2017-07-11 14:49:32 139632431851264 [Note] WSREP: STATE EXCHANGE: got state msg: 268ac26f-6648-11e7-8010-226139e6369e from 1 (mysql-1)
2017-07-11 14:49:33 139632431851264 [Note] WSREP: STATE EXCHANGE: got state msg: 268ac26f-6648-11e7-8010-226139e6369e from 2 (mysql-2)
2017-07-11 14:49:33 139632431851264 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 2,
members = 2/3 (joined/total),
act_id = 6,
last_appl. = 0,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 01ccd89d-6648-11e7-8238-9a58e864dd8b
2017-07-11 14:49:33 139632431851264 [Note] WSREP: Flow-control interval: [28, 28]
2017-07-11 14:49:33 139632711625472 [Note] WSREP: New cluster view: global state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:6, view# 3: Primary, number of nodes: 3, my index: 0, protocol version 3
2017-07-11 14:49:33 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:33 139632711625472 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:49:33 139632711625472 [Note] WSREP: Assign initial position for certification: 6, protocol version: 3
2017-07-11 14:49:33 139632489887488 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:49:33 139632431851264 [Note] WSREP: Member 2.0 (mysql-2) requested state transfer from '*any*'. Selected 0.0 (mysql-0)(SYNCED) as donor.
2017-07-11 14:49:33 139632431851264 [Note] WSREP: Shifting SYNCED -> DONOR/DESYNCED (TO: 6)
2017-07-11 14:49:33 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:33 139631567824640 [Note] WSREP: Running: 'wsrep_sst_rsync --role 'donor' --address 'mysql-2.mysql.default.svc.cluster.local:4444/rsync_sst' --socket '/var/run/mysqld/mysqld.sock' --datadir '/var/lib/mysql/' '' --gtid '01ccd89d-6648-11e7-8238-9a58e864dd8b:6' --gtid-domain-id '0''
2017-07-11 14:49:33 139632711625472 [Note] WSREP: sst_donor_thread signaled with 0
2017-07-11 14:49:33 139631567824640 [Note] WSREP: Flushing tables for SST...
2017-07-11 14:49:33 139631567824640 [Note] WSREP: Provider paused at 01ccd89d-6648-11e7-8238-9a58e864dd8b:6 (10)
2017-07-11 14:49:33 139631567824640 [Note] WSREP: Tables flushed.
2017-07-11 14:49:34 139631567824640 [Note] WSREP: resuming provider at 10
2017-07-11 14:49:34 139631567824640 [Note] WSREP: Provider resumed.
2017-07-11 14:49:35 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') reconnecting to 1469dcce (tcp://172.17.0.5:4567), attempt 0
2017-07-11 14:49:35 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') connection established to 1469dcce tcp://172.17.0.5:4567
2017-07-11 14:49:38 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') turning message relay requesting off
2017-07-11 14:49:39 139632440243968 [Note] WSREP: evs::proto(04d3794f, GATHER, view_id(REG,04d3794f,3)) suspecting node: 1469dcce
2017-07-11 14:49:39 139632440243968 [Note] WSREP: evs::proto(04d3794f, GATHER, view_id(REG,04d3794f,3)) suspected node without join message, declaring inactive
2017-07-11 14:49:39 139632431851264 [Note] WSREP: 0.0 (mysql-0): State transfer to 2.0 (mysql-2) complete.
2017-07-11 14:49:39 139632431851264 [Note] WSREP: Shifting DONOR/DESYNCED -> JOINED (TO: 6)
2017-07-11 14:49:39 139632440243968 [Note] WSREP: declaring 263d09bf at tcp://172.17.0.6:4567 stable
2017-07-11 14:49:39 139632440243968 [Note] WSREP: Node 04d3794f state prim
2017-07-11 14:49:39 139632440243968 [Note] WSREP: view(view_id(PRIM,04d3794f,4) memb {
04d3794f,0
263d09bf,0
} joined {
} left {
} partitioned {
1469dcce,0
})
2017-07-11 14:49:39 139632440243968 [Note] WSREP: save pc into disk
2017-07-11 14:49:39 139632440243968 [Note] WSREP: forgetting 1469dcce (tcp://172.17.0.5:4567)
2017-07-11 14:49:42 139632440243968 [Note] WSREP: cleaning up 1469dcce (tcp://172.17.0.5:4567)
2017-07-11 14:49:44 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') connection established to 1469dcce tcp://172.17.0.5:4567
2017-07-11 14:49:44 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers:
2017-07-11 14:49:46 139632440243968 [Note] WSREP: declaring 1469dcce at tcp://172.17.0.5:4567 stable
2017-07-11 14:49:46 139632440243968 [Note] WSREP: declaring 263d09bf at tcp://172.17.0.6:4567 stable
2017-07-11 14:49:46 139632440243968 [Note] WSREP: Node 04d3794f state prim
2017-07-11 14:49:46 139632440243968 [Note] WSREP: view(view_id(PRIM,04d3794f,6) memb {
04d3794f,0
1469dcce,0
263d09bf,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:49:46 139632440243968 [Note] WSREP: save pc into disk
2017-07-11 14:49:46 139632431851264 [Note] WSREP: 2.0 (mysql-2): State transfer from 0.0 (mysql-0) complete.
2017-07-11 14:49:46 139632431851264 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 2
2017-07-11 14:49:46 139632431851264 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 2ee4e078-6648-11e7-9f30-7660a921dd6a
2017-07-11 14:49:46 139632431851264 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 3
2017-07-11 14:49:46 139632431851264 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 2ee4e6b0-6648-11e7-a5f0-b21f52dc3148
2017-07-11 14:49:46 139632431851264 [Warning] WSREP: SYNC message from member 2 in non-primary configuration. Ignored.
2017-07-11 14:49:46 139632431851264 [Warning] WSREP: SYNC message from member 0 in non-primary configuration. Ignored.
2017-07-11 14:49:46 139632431851264 [Note] WSREP: STATE EXCHANGE: sent state msg: 2ee4e078-6648-11e7-9f30-7660a921dd6a
2017-07-11 14:49:46 139632431851264 [Note] WSREP: STATE EXCHANGE: got state msg: 2ee4e078-6648-11e7-9f30-7660a921dd6a from 2 (mysql-2)
2017-07-11 14:49:46 139632431851264 [Note] WSREP: STATE EXCHANGE: got state msg: 2ee4e078-6648-11e7-9f30-7660a921dd6a from 0 (mysql-0)
2017-07-11 14:49:46 139632431851264 [Note] WSREP: STATE EXCHANGE: got state msg: 2ee4e078-6648-11e7-9f30-7660a921dd6a from 1 (mysql-1)
2017-07-11 14:49:46 139632431851264 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 3,
members = 2/3 (joined/total),
act_id = 6,
last_appl. = 0,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 01ccd89d-6648-11e7-8238-9a58e864dd8b
2017-07-11 14:49:46 139632431851264 [Note] WSREP: Flow-control interval: [28, 28]
2017-07-11 14:49:46 139632711625472 [Note] WSREP: New cluster view: global state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:6, view# 4: Primary, number of nodes: 3, my index: 0, protocol version 3
2017-07-11 14:49:46 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:46 139632711625472 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:49:46 139632711625472 [Note] WSREP: Assign initial position for certification: 6, protocol version: 3
2017-07-11 14:49:46 139632489887488 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:49:46 139632431851264 [Note] WSREP: Member 2.0 (mysql-2) synced with group.
2017-07-11 14:49:46 139632431851264 [Note] WSREP: Member 0.0 (mysql-0) synced with group.
2017-07-11 14:49:46 139632431851264 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 6)
2017-07-11 14:49:46 139632711625472 [Note] WSREP: Synchronized with group, ready for connections
2017-07-11 14:49:46 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:46 139632431851264 [Note] WSREP: Member 1.0 (mysql-1) requested state transfer from '*any*'. Selected 0.0 (mysql-0)(SYNCED) as donor.
2017-07-11 14:49:46 139632431851264 [Note] WSREP: Shifting SYNCED -> DONOR/DESYNCED (TO: 6)
2017-07-11 14:49:46 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:46 139631559431936 [Note] WSREP: Running: 'wsrep_sst_rsync --role 'donor' --address 'mysql-1.mysql.default.svc.cluster.local:4444/rsync_sst' --socket '/var/run/mysqld/mysqld.sock' --datadir '/var/lib/mysql/' '' --gtid '01ccd89d-6648-11e7-8238-9a58e864dd8b:6' --gtid-domain-id '0''
2017-07-11 14:49:46 139632711625472 [Note] WSREP: sst_donor_thread signaled with 0
2017-07-11 14:49:46 139631559431936 [Note] WSREP: Flushing tables for SST...
2017-07-11 14:49:46 139631559431936 [Note] WSREP: Provider paused at 01ccd89d-6648-11e7-8238-9a58e864dd8b:6 (15)
2017-07-11 14:49:46 139631559431936 [Note] WSREP: Tables flushed.
2017-07-11 14:49:47 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') turning message relay requesting off
2017-07-11 14:49:48 139631559431936 [Note] WSREP: resuming provider at 15
2017-07-11 14:49:48 139631559431936 [Note] WSREP: Provider resumed.
2017-07-11 14:49:48 139632431851264 [Note] WSREP: 0.0 (mysql-0): State transfer to 1.0 (mysql-1) complete.
2017-07-11 14:49:48 139632431851264 [Note] WSREP: Shifting DONOR/DESYNCED -> JOINED (TO: 6)
2017-07-11 14:49:48 139632431851264 [Note] WSREP: Member 0.0 (mysql-0) synced with group.
2017-07-11 14:49:48 139632431851264 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 6)
2017-07-11 14:49:48 139632711625472 [Note] WSREP: Synchronized with group, ready for connections
2017-07-11 14:49:48 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:49:50 139632431851264 [Note] WSREP: 1.0 (mysql-1): State transfer from 0.0 (mysql-0) complete.
2017-07-11 14:49:50 139632431851264 [Note] WSREP: Member 1.0 (mysql-1) synced with group.
2017-07-11 14:50:03 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers: tcp://172.17.0.6:4567
2017-07-11 14:50:04 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') reconnecting to 263d09bf (tcp://172.17.0.6:4567), attempt 0
2017-07-11 14:50:05 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') connection established to 263d09bf tcp://172.17.0.6:4567
2017-07-11 14:50:08 139632440243968 [Note] WSREP: evs::proto(04d3794f, GATHER, view_id(REG,04d3794f,6)) suspecting node: 263d09bf
2017-07-11 14:50:08 139632440243968 [Note] WSREP: evs::proto(04d3794f, GATHER, view_id(REG,04d3794f,6)) suspected node without join message, declaring inactive
2017-07-11 14:50:08 139632440243968 [Note] WSREP: (04d3794f, 'tcp://0.0.0.0:4567') turning message relay requesting off
2017-07-11 14:50:08 139632440243968 [Note] WSREP: declaring 1469dcce at tcp://172.17.0.5:4567 stable
2017-07-11 14:50:08 139632440243968 [Note] WSREP: Node 04d3794f state prim
2017-07-11 14:50:08 139632440243968 [Warning] WSREP: 04d3794f sending install message failed: Resource temporarily unavailable
2017-07-11 14:50:08 139632440243968 [Note] WSREP: declaring 1469dcce at tcp://172.17.0.5:4567 stable
2017-07-11 14:50:08 139632440243968 [Note] WSREP: declaring 263d09bf at tcp://172.17.0.6:4567 stable
2017-07-11 14:50:09 139632440243968 [Note] WSREP: Node 04d3794f state prim
2017-07-11 14:50:09 139632440243968 [Note] WSREP: view(view_id(PRIM,04d3794f,9) memb {
04d3794f,0
1469dcce,0
263d09bf,0
} joined {
} left {
} partitioned {
})
2017-07-11 14:50:09 139632440243968 [Note] WSREP: save pc into disk
2017-07-11 14:50:09 139632431851264 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 3
2017-07-11 14:50:09 139632431851264 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 3c9b785d-6648-11e7-b973-371547992b6b
2017-07-11 14:50:09 139632431851264 [Note] WSREP: STATE EXCHANGE: sent state msg: 3c9b785d-6648-11e7-b973-371547992b6b
2017-07-11 14:50:09 139632431851264 [Note] WSREP: STATE EXCHANGE: got state msg: 3c9b785d-6648-11e7-b973-371547992b6b from 0 (mysql-0)
2017-07-11 14:50:09 139632431851264 [Note] WSREP: STATE EXCHANGE: got state msg: 3c9b785d-6648-11e7-b973-371547992b6b from 1 (mysql-1)
2017-07-11 14:50:09 139632431851264 [Note] WSREP: STATE EXCHANGE: got state msg: 3c9b785d-6648-11e7-b973-371547992b6b from 2 (mysql-2)
2017-07-11 14:50:09 139632431851264 [Note] WSREP: Quorum results:
version = 4,
component = PRIMARY,
conf_id = 4,
members = 2/3 (joined/total),
act_id = 6,
last_appl. = 0,
protocols = 0/7/3 (gcs/repl/appl),
group UUID = 01ccd89d-6648-11e7-8238-9a58e864dd8b
2017-07-11 14:50:09 139632431851264 [Note] WSREP: Flow-control interval: [28, 28]
2017-07-11 14:50:09 139632711625472 [Note] WSREP: New cluster view: global state: 01ccd89d-6648-11e7-8238-9a58e864dd8b:6, view# 5: Primary, number of nodes: 3, my index: 0, protocol version 3
2017-07-11 14:50:09 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:50:09 139632711625472 [Note] WSREP: REPL Protocols: 7 (3, 2)
2017-07-11 14:50:09 139632711625472 [Note] WSREP: Assign initial position for certification: 6, protocol version: 3
2017-07-11 14:50:09 139632489887488 [Note] WSREP: Service thread queue flushed.
2017-07-11 14:50:09 139632431851264 [Note] WSREP: Member 2.0 (mysql-2) requested state transfer from '*any*'. Selected 0.0 (mysql-0)(SYNCED) as donor.
2017-07-11 14:50:09 139632431851264 [Note] WSREP: Shifting SYNCED -> DONOR/DESYNCED (TO: 6)
2017-07-11 14:50:09 139632711625472 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
2017-07-11 14:50:09 139631551039232 [Note] WSREP: Running: 'wsrep_sst_rsync --role 'donor' --address 'mysql-2.mysql.default.svc.cluster.local:4444/rsync_sst' --socket '/var/run/mysqld/mysqld.sock' --datadir '/var/lib/mysql/' '' --gtid '01ccd89d-6648-11e7-8238-9a58e864dd8b:6' --gtid-domain-id '0''
2017-07-11 14:50:09 139632711625472 [Note] WSREP: sst_donor_thread signaled with 0
2017-07-11 14:50:09 139631551039232 [Note] WSREP: Flushing tables for SST...
2
Thank you for the clarification. I'll look into this one.
I'm not well versed in the changes these versions introduced but I have confirmed locally that they aren't drop-in replacements in this project. Do you know what would be needed for that to work?