Attachment 925288 Details for Bug 1128285 – mariadb.log where the error happens.

mariadb.log where the error happens.

mariadb.log (text/x-log), 54.64 KB, created by Alexander Chuzhoy on 2014-08-08 19:34:17 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Alexander Chuzhoy

Created: 2014-08-08 19:34:17 UTC

Size: 54.64 KB

patch

obsolete

>140808 14:56:26 [Note] WSREP: Read nil XID from storage engines, skipping position init
>140808 14:56:26 [Note] WSREP: wsrep_load(): loading provider library 'none'
>140808 14:56:26 [Note] WSREP: Service disconnected.
>140808 14:56:27 [Note] WSREP: Some threads may fail to exit.
>140808 14:56:27 [Note] WSREP: Read nil XID from storage engines, skipping position init
>140808 14:56:27 [Note] WSREP: wsrep_load(): loading provider library 'none'
>140808 14:56:27 [Note] WSREP: Service disconnected.
>140808 14:56:28 [Note] WSREP: Some threads may fail to exit.
>140808 14:56:29 mysqld_safe Starting mysqld daemon with databases from /var/lib/mysql
>140808 14:56:29 mysqld_safe WSREP: Running position recovery with --log_error='/var/lib/mysql/wsrep_recovery.29hlr6' --pid-file='/var/lib/mysql/maca25400702876.example.com-recover.pid'
>140808 14:56:29 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 14:56:29 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 14:56:29 [Warning] Could not increase number of max_open_files to more than 1024 (request: 1835)
>/usr/libexec/mysqld: Query cache is disabled (resize or similar command in progress); repeat this command later
>140808 14:56:32 mysqld_safe WSREP: Recovered position 00000000-0000-0000-0000-000000000000:-1
>140808 14:56:32 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 14:56:32 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 14:56:32 [Note] WSREP: wsrep_start_position var submitted: '00000000-0000-0000-0000-000000000000:-1'
>140808 14:56:32 [Warning] Could not increase number of max_open_files to more than 1024 (request: 1835)
>/usr/libexec/mysqld: Query cache is disabled (resize or similar command in progress); repeat this command later
>140808 14:56:32 [Note] WSREP: Read nil XID from storage engines, skipping position init
>140808 14:56:32 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib64/galera/libgalera_smm.so'
>140808 14:56:32 [Note] WSREP: wsrep_load(): Galera 3.5(rXXXX) by Codership Oy <info@codership.com> loaded successfully.
>140808 14:56:32 [Note] WSREP: CRC-32C: using "slicing-by-8" algorithm.
>140808 14:56:32 [Warning] WSREP: Could not open saved state file for reading: /var/lib/mysql//grastate.dat
>140808 14:56:32 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1
>140808 14:56:32 [Note] WSREP: Passing config to GCS: base_host = 192.168.100.137; base_port = 4567; cert.log_conflicts = no; debug = no; evs.inactive_check_period = PT0.5S; evs.inactive_timeout = PT15S; evs.join_retrans_period = PT1S; evs.max_install_timeouts = 1; 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.size = 128M; 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; pc.checksum = false; pc.ignore_quorum = false; pc.ignore_sb = false; pc.npvo = false; pc.version = 0; pc.wait_prim = true; pc.wait_prim_timeout = P30S; pc.weight = 1; prot
>140808 14:56:32 [Note] WSREP: Service thread queue flushed.
>140808 14:56:32 [Note] WSREP: Assign initial position for certification: -1, protocol version: -1
>140808 14:56:32 [Note] WSREP: wsrep_sst_grab()
>140808 14:56:32 [Note] WSREP: Start replication
>140808 14:56:32 [Note] WSREP: Setting initial position to 00000000-0000-0000-0000-000000000000:-1
>140808 14:56:32 [Note] WSREP: protonet asio version 0
>140808 14:56:32 [Note] WSREP: Using CRC-32C (optimized) for message checksums.
>140808 14:56:32 [Note] WSREP: backend: asio
>140808 14:56:32 [Note] WSREP: GMCast version 0
>140808 14:56:32 [Note] WSREP: (2f5233f1-1f0c-11e4-a30e-c39679970199, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
>140808 14:56:32 [Note] WSREP: (2f5233f1-1f0c-11e4-a30e-c39679970199, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
>140808 14:56:32 [Note] WSREP: EVS version 0
>140808 14:56:32 [Note] WSREP: PC version 0
>140808 14:56:32 [Note] WSREP: gcomm: connecting to group 'galera_cluster', peer '192.168.0.9:,192.168.0.10:,192.168.0.11:'
>140808 14:56:32 [Warning] WSREP: (2f5233f1-1f0c-11e4-a30e-c39679970199, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' points to own listening address, blacklisting
>140808 14:56:32 [Note] WSREP: (2f5233f1-1f0c-11e4-a30e-c39679970199, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 2f5233f1-1f0c-11e4-a30e-c39679970199 is blacklisted, skipping
>140808 14:56:32 [Note] WSREP: (2f5233f1-1f0c-11e4-a30e-c39679970199, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 2f5233f1-1f0c-11e4-a30e-c39679970199 is blacklisted, skipping
>140808 14:56:32 [Note] WSREP: (2f5233f1-1f0c-11e4-a30e-c39679970199, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 2f5233f1-1f0c-11e4-a30e-c39679970199 is blacklisted, skipping
>140808 14:56:32 [Note] WSREP: (2f5233f1-1f0c-11e4-a30e-c39679970199, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 2f5233f1-1f0c-11e4-a30e-c39679970199 is blacklisted, skipping
>140808 14:56:32 [Note] WSREP: declaring 1ab429f8-1f0c-11e4-81b4-9b83bc6b872d stable
>140808 14:56:32 [Note] WSREP: declaring 30183b32-1f0c-11e4-9b57-3231a5272aa4 stable
>140808 14:56:32 [Note] WSREP: Node 1ab429f8-1f0c-11e4-81b4-9b83bc6b872d state prim
>140808 14:56:32 [Note] WSREP: view(view_id(PRIM,1ab429f8-1f0c-11e4-81b4-9b83bc6b872d,2) memb {
>	1ab429f8-1f0c-11e4-81b4-9b83bc6b872d,0
>	2f5233f1-1f0c-11e4-a30e-c39679970199,0
>	30183b32-1f0c-11e4-9b57-3231a5272aa4,0
>} joined {
>} left {
>} partitioned {
>})
>140808 14:56:33 [Note] WSREP: gcomm: connected
>140808 14:56:33 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
>140808 14:56:33 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
>140808 14:56:33 [Note] WSREP: Opened channel 'galera_cluster'
>140808 14:56:33 [Note] WSREP: Waiting for SST to complete.
>140808 14:56:33 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 1, memb_num = 3
>140808 14:56:33 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
>140808 14:56:33 [Note] WSREP: STATE EXCHANGE: sent state msg: 308cf795-1f0c-11e4-ba18-f28b99370e89
>140808 14:56:33 [Note] WSREP: STATE EXCHANGE: got state msg: 308cf795-1f0c-11e4-ba18-f28b99370e89 from 0 (maca25400702877.example.com)
>140808 14:56:33 [Note] WSREP: STATE EXCHANGE: got state msg: 308cf795-1f0c-11e4-ba18-f28b99370e89 from 2 (maca25400702875.example.com)
>140808 14:56:33 [Note] WSREP: STATE EXCHANGE: got state msg: 308cf795-1f0c-11e4-ba18-f28b99370e89 from 1 (maca25400702876.example.com)
>140808 14:56:33 [Note] WSREP: Quorum results:
>	version    = 3,
>	component  = PRIMARY,
>	conf_id    = 1,
>	members    = 1/3 (joined/total),
>	act_id     = 20,
>	last_appl. = -1,
>	protocols  = 0/5/2 (gcs/repl/appl),
>	group UUID = 162e206f-1f0c-11e4-a55f-87aae18c99f1
>140808 14:56:33 [Note] WSREP: Flow-control interval: [28, 28]
>140808 14:56:33 [Note] WSREP: Shifting OPEN -> PRIMARY (TO: 20)
>140808 14:56:33 [Note] WSREP: State transfer required: 
>	Group state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>	Local state: 00000000-0000-0000-0000-000000000000:-1
>140808 14:56:33 [Note] WSREP: New cluster view: global state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20, view# 2: Primary, number of nodes: 3, my index: 1, protocol version 2
>140808 14:56:33 [Warning] WSREP: Gap in state sequence. Need state transfer.
>140808 14:56:35 [Note] WSREP: Running: 'wsrep_sst_rsync --role 'joiner' --address '192.168.100.137' --auth 'sst_user:sst_pass' --datadir '/var/lib/mysql/' --defaults-file '/etc/my.cnf' --parent '15963''
>140808 14:56:35 [Note] WSREP: Prepared SST request: rsync|192.168.100.137:4444/rsync_sst
>140808 14:56:35 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>140808 14:56:35 [Note] WSREP: REPL Protocols: 5 (3, 1)
>140808 14:56:35 [Note] WSREP: Service thread queue flushed.
>140808 14:56:35 [Note] WSREP: Assign initial position for certification: 20, protocol version: 3
>140808 14:56:35 [Note] WSREP: Service thread queue flushed.
>140808 14:56:35 [Warning] WSREP: Failed to prepare for incremental state transfer: Local state UUID (00000000-0000-0000-0000-000000000000) does not match group state UUID (162e206f-1f0c-11e4-a55f-87aae18c99f1): 1 (Operation not permitted)
>	 at galera/src/replicator_str.cpp:prepare_for_IST():447. IST will be unavailable.
>140808 14:56:35 [Note] WSREP: Member 1.0 (maca25400702876.example.com) requested state transfer from '*any*'. Selected 0.0 (maca25400702877.example.com)(SYNCED) as donor.
>140808 14:56:35 [Note] WSREP: Shifting PRIMARY -> JOINER (TO: 20)
>140808 14:56:35 [Note] WSREP: Requesting state transfer: success, donor: 0
>140808 14:56:38 [Note] WSREP: 0.0 (maca25400702877.example.com): State transfer to 1.0 (maca25400702876.example.com) complete.
>140808 14:56:38 [Note] WSREP: Member 0.0 (maca25400702877.example.com) synced with group.
>140808 14:56:39 [Note] WSREP: Member 2.0 (maca25400702875.example.com) requested state transfer from '*any*'. Selected 0.0 (maca25400702877.example.com)(SYNCED) as donor.
>WSREP_SST: [INFO] Joiner cleanup. (20140808 14:56:39.398)
>WSREP_SST: [INFO] Joiner cleanup done. (20140808 14:56:39.905)
>140808 14:56:39 [Note] WSREP: SST complete, seqno: 20
>140808 14:56:39 InnoDB: The InnoDB memory heap is disabled
>140808 14:56:39 InnoDB: Mutexes and rw_locks use GCC atomic builtins
>140808 14:56:39 InnoDB: Compressed tables use zlib 1.2.7
>140808 14:56:39 InnoDB: Using Linux native AIO
>140808 14:56:39 InnoDB: Initializing buffer pool, size = 128.0M
>140808 14:56:39 InnoDB: Completed initialization of buffer pool
>140808 14:56:39 InnoDB: highest supported file format is Barracuda.
>InnoDB: The log sequence number in ibdata files does not match
>InnoDB: the log sequence number in the ib_logfiles!
>140808 14:56:39  InnoDB: Database was not shut down normally!
>InnoDB: Starting crash recovery.
>InnoDB: Reading tablespace information from the .ibd files...
>InnoDB: Restoring possible half-written data pages from the doublewrite
>InnoDB: buffer...
>140808 14:56:40  InnoDB: Waiting for the background threads to start
>140808 14:56:41 Percona XtraDB (http://www.percona.com) 5.5.37-MariaDB-34.0 started; log sequence number 1598447
>140808 14:56:41 [Note] Plugin 'FEEDBACK' is disabled.
>140808 14:56:41 [Note] Server socket created on IP: '192.168.100.137'.
>140808 14:56:41 [Note] Event Scheduler: Loaded 0 events
>140808 14:56:41 [Note] WSREP: Signalling provider to continue.
>140808 14:56:41 [Note] WSREP: SST received: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>140808 14:56:41 [Note] /usr/libexec/mysqld: ready for connections.
>Version: '5.5.37-MariaDB-wsrep'  socket: '/var/lib/mysql/mysql.sock'  port: 3306  MariaDB Server, wsrep_25.10.r3980
>140808 14:56:41 [Note] WSREP: 1.0 (maca25400702876.example.com): State transfer from 0.0 (maca25400702877.example.com) complete.
>140808 14:56:41 [Note] WSREP: Shifting JOINER -> JOINED (TO: 20)
>140808 14:56:41 [Note] WSREP: Member 1.0 (maca25400702876.example.com) synced with group.
>140808 14:56:41 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 20)
>140808 14:56:41 [Note] WSREP: Synchronized with group, ready for connections
>140808 14:56:41 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>140808 14:56:42 [Note] /usr/libexec/mysqld: Normal shutdown
>
>140808 14:56:42 [Note] WSREP: Stop replication
>140808 14:56:42 [Note] WSREP: Closing send monitor...
>140808 14:56:42 [Note] WSREP: Closed send monitor.
>140808 14:56:42 [Note] WSREP: gcomm: terminating thread
>140808 14:56:42 [Note] WSREP: gcomm: joining thread
>140808 14:56:42 [Note] WSREP: gcomm: closing backend
>140808 14:56:42 [Note] WSREP: view(view_id(NON_PRIM,1ab429f8-1f0c-11e4-81b4-9b83bc6b872d,2) memb {
>	2f5233f1-1f0c-11e4-a30e-c39679970199,0
>} joined {
>} left {
>} partitioned {
>	1ab429f8-1f0c-11e4-81b4-9b83bc6b872d,0
>	30183b32-1f0c-11e4-9b57-3231a5272aa4,0
>})
>140808 14:56:42 [Note] WSREP: view((empty))
>140808 14:56:42 [Note] WSREP: gcomm: closed
>140808 14:56:42 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
>140808 14:56:42 [Note] WSREP: Flow-control interval: [16, 16]
>140808 14:56:42 [Note] WSREP: Received NON-PRIMARY.
>140808 14:56:42 [Note] WSREP: Shifting SYNCED -> OPEN (TO: 20)
>140808 14:56:42 [Note] WSREP: Received self-leave message.
>140808 14:56:42 [Note] WSREP: Flow-control interval: [0, 0]
>140808 14:56:42 [Note] WSREP: Received SELF-LEAVE. Closing connection.
>140808 14:56:42 [Note] WSREP: Shifting OPEN -> CLOSED (TO: 20)
>140808 14:56:42 [Note] WSREP: RECV thread exiting 0: Success
>140808 14:56:42 [Note] WSREP: New cluster view: global state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20, view# -1: non-Primary, number of nodes: 1, my index: 0, protocol version 2
>140808 14:56:42 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>140808 14:56:42 [Note] WSREP: New cluster view: global state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20, view# -1: non-Primary, number of nodes: 0, my index: -1, protocol version 2
>140808 14:56:42 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>140808 14:56:42 [Note] WSREP: applier thread exiting (code:0)
>140808 14:56:42 [Note] WSREP: recv_thread() joined.
>140808 14:56:42 [Note] WSREP: Closing replication queue.
>140808 14:56:42 [Note] WSREP: Closing slave action queue.
>140808 14:56:44 [Note] WSREP: rollbacker thread exiting
>140808 14:56:44 [Note] Event Scheduler: Purging the queue. 0 events
>140808 14:56:44 [Note] WSREP: dtor state: CLOSED
>140808 14:56:44 [Note] WSREP: apply mon: entered 0
>140808 14:56:44 [Note] WSREP: apply mon: entered 0
>140808 14:56:44 [Note] WSREP: mon: entered 5 oooe fraction 0 oool fraction 0.2
>140808 14:56:44 [Note] WSREP: cert index usage at exit 0
>140808 14:56:44 [Note] WSREP: cert trx map usage at exit 0
>140808 14:56:44 [Note] WSREP: deps set usage at exit 0
>140808 14:56:44 [Note] WSREP: avg deps dist 0
>140808 14:56:44 [Note] WSREP: avg cert interval 0
>140808 14:56:44 [Note] WSREP: cert index size 0
>140808 14:56:44 [Note] WSREP: Service thread queue flushed.
>140808 14:56:44 [Note] WSREP: wsdb trx map usage 0 conn query map usage 0
>140808 14:56:44 [Note] WSREP: Shifting CLOSED -> DESTROYED (TO: 20)
>140808 14:56:44 [Note] WSREP: Flushing memory map to disk...
>140808 14:56:44  InnoDB: Starting shutdown...
>140808 14:56:45  InnoDB: Shutdown completed; log sequence number 1598447
>140808 14:56:45 [Note] /usr/libexec/mysqld: Shutdown complete
>
>140808 14:56:45 mysqld_safe mysqld from pid file /var/run/mariadb/mariadb.pid ended
>140808 14:56:45 mysqld_safe Starting mysqld daemon with databases from /var/lib/mysql
>140808 14:56:45 mysqld_safe WSREP: Running position recovery with --log_error='/var/lib/mysql/wsrep_recovery.QAgvox' --pid-file='/var/lib/mysql/maca25400702876.example.com-recover.pid'
>140808 14:56:45 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 14:56:45 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 14:56:45 [Warning] Could not increase number of max_open_files to more than 1024 (request: 1835)
>/usr/libexec/mysqld: Query cache is disabled (resize or similar command in progress); repeat this command later
>140808 14:56:47 mysqld_safe WSREP: Recovered position 162e206f-1f0c-11e4-a55f-87aae18c99f1:1
>140808 14:56:47 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 14:56:47 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 14:56:47 [Note] WSREP: wsrep_start_position var submitted: '162e206f-1f0c-11e4-a55f-87aae18c99f1:1'
>140808 14:56:47 [Warning] Could not increase number of max_open_files to more than 1024 (request: 1835)
>/usr/libexec/mysqld: Query cache is disabled (resize or similar command in progress); repeat this command later
>140808 14:56:47 [Note] WSREP: Read nil XID from storage engines, skipping position init
>140808 14:56:47 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib64/galera/libgalera_smm.so'
>140808 14:56:47 [Note] WSREP: wsrep_load(): Galera 3.5(rXXXX) by Codership Oy <info@codership.com> loaded successfully.
>140808 14:56:47 [Note] WSREP: CRC-32C: using "slicing-by-8" algorithm.
>140808 14:56:47 [Note] WSREP: Found saved state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>140808 14:56:47 [Note] WSREP: Passing config to GCS: base_host = 192.168.100.137; base_port = 4567; cert.log_conflicts = no; debug = no; evs.inactive_check_period = PT0.5S; evs.inactive_timeout = PT15S; evs.join_retrans_period = PT1S; evs.max_install_timeouts = 1; 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.size = 128M; 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; pc.checksum = false; pc.ignore_quorum = false; pc.ignore_sb = false; pc.npvo = false; pc.version = 0; pc.wait_prim = true; pc.wait_prim_timeout = P30S; pc.weight = 1; prot
>140808 14:56:47 [Note] WSREP: Service thread queue flushed.
>140808 14:56:47 [Note] WSREP: Assign initial position for certification: 20, protocol version: -1
>140808 14:56:47 [Note] WSREP: wsrep_sst_grab()
>140808 14:56:47 [Note] WSREP: Start replication
>140808 14:56:47 [Note] WSREP: Setting initial position to 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>140808 14:56:47 [Note] WSREP: protonet asio version 0
>140808 14:56:47 [Note] WSREP: Using CRC-32C (optimized) for message checksums.
>140808 14:56:47 [Note] WSREP: backend: asio
>140808 14:56:47 [Note] WSREP: GMCast version 0
>140808 14:56:47 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
>140808 14:56:47 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
>140808 14:56:47 [Note] WSREP: EVS version 0
>140808 14:56:47 [Note] WSREP: PC version 0
>140808 14:56:47 [Note] WSREP: gcomm: connecting to group 'galera_cluster', peer '192.168.0.9:,192.168.0.10:,192.168.0.11:'
>140808 14:56:47 [Warning] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' points to own listening address, blacklisting
>140808 14:56:47 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 38907278-1f0c-11e4-8789-22f643be157d is blacklisted, skipping
>140808 14:56:48 [Note] WSREP: declaring 1ab429f8-1f0c-11e4-81b4-9b83bc6b872d stable
>140808 14:56:48 [Note] WSREP: Node 1ab429f8-1f0c-11e4-81b4-9b83bc6b872d state prim
>140808 14:56:48 [Note] WSREP: view(view_id(PRIM,1ab429f8-1f0c-11e4-81b4-9b83bc6b872d,5) memb {
>	1ab429f8-1f0c-11e4-81b4-9b83bc6b872d,0
>	38907278-1f0c-11e4-8789-22f643be157d,0
>} joined {
>} left {
>} partitioned {
>})
>140808 14:56:48 [Note] WSREP: discarding pending addr without UUID: tcp://192.168.0.11:4567
>140808 14:56:48 [Note] WSREP: gcomm: connected
>140808 14:56:48 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
>140808 14:56:48 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
>140808 14:56:48 [Note] WSREP: Opened channel 'galera_cluster'
>140808 14:56:48 [Note] WSREP: Waiting for SST to complete.
>140808 14:56:48 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 1, memb_num = 2
>140808 14:56:48 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
>140808 14:56:48 [Note] WSREP: STATE EXCHANGE: sent state msg: 39cb5c5a-1f0c-11e4-afa3-f6ec18733ff0
>140808 14:56:48 [Note] WSREP: STATE EXCHANGE: got state msg: 39cb5c5a-1f0c-11e4-afa3-f6ec18733ff0 from 0 (maca25400702877.example.com)
>140808 14:56:48 [Note] WSREP: STATE EXCHANGE: got state msg: 39cb5c5a-1f0c-11e4-afa3-f6ec18733ff0 from 1 (maca25400702876.example.com)
>140808 14:56:48 [Note] WSREP: Quorum results:
>	version    = 3,
>	component  = PRIMARY,
>	conf_id    = 4,
>	members    = 2/2 (joined/total),
>	act_id     = 20,
>	last_appl. = -1,
>	protocols  = 0/5/2 (gcs/repl/appl),
>	group UUID = 162e206f-1f0c-11e4-a55f-87aae18c99f1
>140808 14:56:48 [Note] WSREP: Flow-control interval: [23, 23]
>140808 14:56:48 [Note] WSREP: Restored state OPEN -> JOINED (20)
>140808 14:56:48 [Note] WSREP: New cluster view: global state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20, view# 5: Primary, number of nodes: 2, my index: 1, protocol version 2
>140808 14:56:48 [Note] WSREP: SST complete, seqno: 20
>140808 14:56:48 InnoDB: The InnoDB memory heap is disabled
>140808 14:56:48 InnoDB: Mutexes and rw_locks use GCC atomic builtins
>140808 14:56:48 InnoDB: Compressed tables use zlib 1.2.7
>140808 14:56:48 InnoDB: Using Linux native AIO
>140808 14:56:48 [Note] WSREP: Member 1.0 (maca25400702876.example.com) synced with group.
>140808 14:56:48 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 20)
>140808 14:56:48 InnoDB: Initializing buffer pool, size = 128.0M
>140808 14:56:48 InnoDB: Completed initialization of buffer pool
>140808 14:56:48 InnoDB: highest supported file format is Barracuda.
>140808 14:56:48  InnoDB: Waiting for the background threads to start
>140808 14:56:49 Percona XtraDB (http://www.percona.com) 5.5.37-MariaDB-34.0 started; log sequence number 1598447
>140808 14:56:49 [Note] Plugin 'FEEDBACK' is disabled.
>140808 14:56:49 [Note] Server socket created on IP: '192.168.100.137'.
>140808 14:56:49 [Note] Event Scheduler: Loaded 0 events
>140808 14:56:49 [Note] /usr/libexec/mysqld: ready for connections.
>Version: '5.5.37-MariaDB-wsrep'  socket: '/var/lib/mysql/mysql.sock'  port: 3306  MariaDB Server, wsrep_25.10.r3980
>140808 14:56:49 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>140808 14:56:49 [Note] WSREP: REPL Protocols: 5 (3, 1)
>140808 14:56:49 [Note] WSREP: Service thread queue flushed.
>140808 14:56:49 [Note] WSREP: Assign initial position for certification: 20, protocol version: 3
>140808 14:56:49 [Note] WSREP: Service thread queue flushed.
>140808 14:56:49 [Note] WSREP: Synchronized with group, ready for connections
>140808 14:56:49 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>140808 14:56:51 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 38907278-1f0c-11e4-8789-22f643be157d is blacklisted, skipping
>140808 14:56:51 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers: tcp://192.168.0.11:4567 
>140808 14:56:51 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 38907278-1f0c-11e4-8789-22f643be157d is blacklisted, skipping
>140808 14:56:51 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 38907278-1f0c-11e4-8789-22f643be157d is blacklisted, skipping
>140808 14:56:51 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 38907278-1f0c-11e4-8789-22f643be157d is blacklisted, skipping
>140808 14:56:51 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') turning message relay requesting off
>140808 14:56:52 [Note] WSREP: declaring 1ab429f8-1f0c-11e4-81b4-9b83bc6b872d stable
>140808 14:56:52 [Note] WSREP: declaring 3b707958-1f0c-11e4-aeb0-775177669e19 stable
>140808 14:56:53 [Note] WSREP: Node 1ab429f8-1f0c-11e4-81b4-9b83bc6b872d state prim
>140808 14:56:53 [Note] WSREP: view(view_id(PRIM,1ab429f8-1f0c-11e4-81b4-9b83bc6b872d,6) memb {
>	1ab429f8-1f0c-11e4-81b4-9b83bc6b872d,0
>	38907278-1f0c-11e4-8789-22f643be157d,0
>	3b707958-1f0c-11e4-aeb0-775177669e19,0
>} joined {
>} left {
>} partitioned {
>})
>140808 14:56:53 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 1, memb_num = 3
>140808 14:56:53 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
>140808 14:56:53 [Note] WSREP: STATE EXCHANGE: sent state msg: 3d174f61-1f0c-11e4-b49c-47d6f12530d3
>140808 14:56:53 [Note] WSREP: STATE EXCHANGE: got state msg: 3d174f61-1f0c-11e4-b49c-47d6f12530d3 from 0 (maca25400702877.example.com)
>140808 14:56:53 [Note] WSREP: STATE EXCHANGE: got state msg: 3d174f61-1f0c-11e4-b49c-47d6f12530d3 from 1 (maca25400702876.example.com)
>140808 14:56:54 [Note] WSREP: STATE EXCHANGE: got state msg: 3d174f61-1f0c-11e4-b49c-47d6f12530d3 from 2 (maca25400702875.example.com)
>140808 14:56:54 [Note] WSREP: Quorum results:
>	version    = 3,
>	component  = PRIMARY,
>	conf_id    = 5,
>	members    = 3/3 (joined/total),
>	act_id     = 20,
>	last_appl. = 0,
>	protocols  = 0/5/2 (gcs/repl/appl),
>	group UUID = 162e206f-1f0c-11e4-a55f-87aae18c99f1
>140808 14:56:54 [Note] WSREP: Flow-control interval: [28, 28]
>140808 14:56:54 [Note] WSREP: New cluster view: global state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20, view# 6: Primary, number of nodes: 3, my index: 1, protocol version 2
>140808 14:56:54 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>140808 14:56:54 [Note] WSREP: REPL Protocols: 5 (3, 1)
>140808 14:56:54 [Note] WSREP: Service thread queue flushed.
>140808 14:56:54 [Note] WSREP: Assign initial position for certification: 20, protocol version: 3
>140808 14:56:54 [Note] WSREP: Service thread queue flushed.
>140808 14:56:54 [Note] WSREP: Member 2.0 (maca25400702875.example.com) synced with group.
>140808 14:57:03 [Note] WSREP: declaring 3b707958-1f0c-11e4-aeb0-775177669e19 stable
>140808 14:57:03 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 38907278-1f0c-11e4-8789-22f643be157d is blacklisted, skipping
>140808 14:57:03 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 38907278-1f0c-11e4-8789-22f643be157d is blacklisted, skipping
>140808 14:57:03 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 38907278-1f0c-11e4-8789-22f643be157d is blacklisted, skipping
>140808 14:57:03 [Note] WSREP: Node 38907278-1f0c-11e4-8789-22f643be157d state prim
>140808 14:57:03 [Warning] WSREP: 38907278-1f0c-11e4-8789-22f643be157d sending install message failed: Resource temporarily unavailable
>140808 14:57:03 [Note] WSREP: view(view_id(NON_PRIM,38907278-1f0c-11e4-8789-22f643be157d,7) memb {
>	38907278-1f0c-11e4-8789-22f643be157d,0
>} joined {
>} left {
>} partitioned {
>	1ab429f8-1f0c-11e4-81b4-9b83bc6b872d,0
>	3b707958-1f0c-11e4-aeb0-775177669e19,0
>})
>140808 14:57:03 [Note] WSREP: (38907278-1f0c-11e4-8789-22f643be157d, 'tcp://0.0.0.0:4567') turning message relay requesting on, nonlive peers: tcp://192.168.0.9:4567 
>140808 14:57:03 [Note] WSREP: view(view_id(NON_PRIM,38907278-1f0c-11e4-8789-22f643be157d,8) memb {
>	38907278-1f0c-11e4-8789-22f643be157d,0
>} joined {
>} left {
>} partitioned {
>	1ab429f8-1f0c-11e4-81b4-9b83bc6b872d,0
>	3b707958-1f0c-11e4-aeb0-775177669e19,0
>})
>140808 14:57:03 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
>140808 14:57:03 [Note] WSREP: Flow-control interval: [16, 16]
>140808 14:57:03 [Note] WSREP: Received NON-PRIMARY.
>140808 14:57:03 [Note] WSREP: Shifting SYNCED -> OPEN (TO: 20)
>140808 14:57:03 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
>140808 14:57:03 [Note] WSREP: Flow-control interval: [16, 16]
>140808 14:57:03 [Note] WSREP: Received NON-PRIMARY.
>140808 14:57:03 [Note] WSREP: New cluster view: global state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20, view# -1: non-Primary, number of nodes: 1, my index: 0, protocol version 2
>140808 14:57:03 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>140808 14:57:03 [Note] WSREP: New cluster view: global state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20, view# -1: non-Primary, number of nodes: 1, my index: 0, protocol version 2
>140808 14:57:03 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>140808 14:57:03 [Note] /usr/libexec/mysqld: Normal shutdown
>
>140808 14:57:03 [Note] WSREP: Stop replication
>140808 14:57:03 [Note] WSREP: Closing send monitor...
>140808 14:57:03 [Note] WSREP: Closed send monitor.
>140808 14:57:03 [Note] WSREP: gcomm: terminating thread
>140808 14:57:03 [Note] WSREP: gcomm: joining thread
>140808 14:57:03 [Note] WSREP: gcomm: closing backend
>140808 14:57:03 [Note] WSREP: view((empty))
>140808 14:57:03 [Note] WSREP: gcomm: closed
>140808 14:57:03 [Note] WSREP: Received self-leave message.
>140808 14:57:03 [Note] WSREP: Flow-control interval: [0, 0]
>140808 14:57:03 [Note] WSREP: Received SELF-LEAVE. Closing connection.
>140808 14:57:03 [Note] WSREP: Shifting OPEN -> CLOSED (TO: 20)
>140808 14:57:03 [Note] WSREP: RECV thread exiting 0: Success
>140808 14:57:03 [Note] WSREP: New cluster view: global state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20, view# -1: non-Primary, number of nodes: 0, my index: -1, protocol version 2
>140808 14:57:03 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>140808 14:57:03 [Note] WSREP: applier thread exiting (code:0)
>140808 14:57:03 [Note] WSREP: recv_thread() joined.
>140808 14:57:03 [Note] WSREP: Closing replication queue.
>140808 14:57:03 [Note] WSREP: Closing slave action queue.
>140808 14:57:05 [Note] WSREP: rollbacker thread exiting
>140808 14:57:05 [Note] Event Scheduler: Purging the queue. 0 events
>140808 14:57:05 [Note] WSREP: dtor state: CLOSED
>140808 14:57:05 [Note] WSREP: apply mon: entered 0
>140808 14:57:05 [Note] WSREP: apply mon: entered 0
>140808 14:57:05 [Note] WSREP: mon: entered 6 oooe fraction 0 oool fraction 0
>140808 14:57:05 [Note] WSREP: cert index usage at exit 0
>140808 14:57:05 [Note] WSREP: cert trx map usage at exit 0
>140808 14:57:05 [Note] WSREP: deps set usage at exit 0
>140808 14:57:05 [Note] WSREP: avg deps dist 0
>140808 14:57:05 [Note] WSREP: avg cert interval 0
>140808 14:57:05 [Note] WSREP: cert index size 0
>140808 14:57:05 [Note] WSREP: Service thread queue flushed.
>140808 14:57:05 [Note] WSREP: wsdb trx map usage 0 conn query map usage 0
>140808 14:57:05 [Note] WSREP: Shifting CLOSED -> DESTROYED (TO: 20)
>140808 14:57:05 [Note] WSREP: Flushing memory map to disk...
>140808 14:57:05  InnoDB: Starting shutdown...
>140808 14:57:06  InnoDB: Shutdown completed; log sequence number 1598617
>140808 14:57:06 [Note] /usr/libexec/mysqld: Shutdown complete
>
>140808 14:57:06 mysqld_safe mysqld from pid file /var/run/mariadb/mariadb.pid ended
>140808 15:16:10 mysqld_safe Starting mysqld daemon with databases from /var/lib/mysql
>140808 15:16:10 mysqld_safe WSREP: Running position recovery with --log_error='/var/lib/mysql/wsrep_recovery.ZQuEOl' --pid-file='/var/lib/mysql/maca25400702876.example.com-recover.pid'
>140808 15:16:10 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 15:16:10 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 15:16:10 [Warning] Could not increase number of max_open_files to more than 1024 (request: 1835)
>/usr/libexec/mysqld: Query cache is disabled (resize or similar command in progress); repeat this command later
>140808 15:16:11 mysqld_safe WSREP: Recovered position 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>140808 15:16:12 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 15:16:12 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 15:16:12 [Note] WSREP: wsrep_start_position var submitted: '162e206f-1f0c-11e4-a55f-87aae18c99f1:20'
>140808 15:16:12 [Warning] Could not increase number of max_open_files to more than 1024 (request: 1835)
>/usr/libexec/mysqld: Query cache is disabled (resize or similar command in progress); repeat this command later
>140808 15:16:12 [Note] WSREP: Read nil XID from storage engines, skipping position init
>140808 15:16:12 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib64/galera/libgalera_smm.so'
>140808 15:16:12 [Note] WSREP: wsrep_load(): Galera 3.5(rXXXX) by Codership Oy <info@codership.com> loaded successfully.
>140808 15:16:12 [Note] WSREP: CRC-32C: using "slicing-by-8" algorithm.
>140808 15:16:12 [Note] WSREP: Found saved state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>140808 15:16:12 [Note] WSREP: Passing config to GCS: base_host = 10.8.29.214; base_port = 4567; cert.log_conflicts = no; debug = no; evs.inactive_check_period = PT0.5S; evs.inactive_timeout = PT15S; evs.join_retrans_period = PT1S; evs.max_install_timeouts = 1; 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.size = 128M; 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; pc.checksum = false; pc.ignore_quorum = false; pc.ignore_sb = false; pc.npvo = false; pc.version = 0; pc.wait_prim = true; pc.wait_prim_timeout = P30S; pc.weight = 1; protonet
>140808 15:16:12 [Note] WSREP: Service thread queue flushed.
>140808 15:16:12 [Note] WSREP: Assign initial position for certification: 20, protocol version: -1
>140808 15:16:12 [Note] WSREP: wsrep_sst_grab()
>140808 15:16:12 [Note] WSREP: Start replication
>140808 15:16:12 [Note] WSREP: Setting initial position to 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>140808 15:16:12 [Note] WSREP: protonet asio version 0
>140808 15:16:12 [Note] WSREP: Using CRC-32C (optimized) for message checksums.
>140808 15:16:12 [Note] WSREP: backend: asio
>140808 15:16:12 [Note] WSREP: GMCast version 0
>140808 15:16:12 [Note] WSREP: (ee8ef4d2-1f0e-11e4-b699-47f8bf78b910, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
>140808 15:16:12 [Note] WSREP: (ee8ef4d2-1f0e-11e4-b699-47f8bf78b910, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
>140808 15:16:12 [Note] WSREP: EVS version 0
>140808 15:16:12 [Note] WSREP: PC version 0
>140808 15:16:12 [Note] WSREP: gcomm: connecting to group 'galera_cluster', peer '192.168.0.9:,192.168.0.10:,192.168.0.11:'
>140808 15:16:12 [Warning] WSREP: (ee8ef4d2-1f0e-11e4-b699-47f8bf78b910, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' points to own listening address, blacklisting
>140808 15:16:15 [Warning] WSREP: no nodes coming from prim view, prim not possible
>140808 15:16:15 [Note] WSREP: view(view_id(NON_PRIM,ee8ef4d2-1f0e-11e4-b699-47f8bf78b910,1) memb {
>	ee8ef4d2-1f0e-11e4-b699-47f8bf78b910,0
>} joined {
>} left {
>} partitioned {
>})
>140808 15:16:15 [Warning] WSREP: last inactive check more than PT1.5S ago (PT3.5023S), skipping check
>140808 15:16:45 [Note] WSREP: view((empty))
>140808 15:16:45 [ERROR] WSREP: failed to open gcomm backend connection: 110: failed to reach primary view: 110 (Connection timed out)
>	 at gcomm/src/pc.cpp:connect():141
>140808 15:16:45 [ERROR] WSREP: gcs/src/gcs_core.c:gcs_core_open():202: Failed to open backend connection: -110 (Connection timed out)
>140808 15:16:45 [ERROR] WSREP: gcs/src/gcs.c:gcs_open():1291: Failed to open channel 'galera_cluster' at 'gcomm://192.168.0.9,192.168.0.10,192.168.0.11': -110 (Connection timed out)
>140808 15:16:45 [ERROR] WSREP: gcs connect failed: Connection timed out
>140808 15:16:45 [ERROR] WSREP: wsrep::connect() failed: 7
>140808 15:16:45 [ERROR] Aborting
>
>140808 15:16:45 [Note] WSREP: Service disconnected.
>140808 15:16:46 [Note] WSREP: Some threads may fail to exit.
>140808 15:16:46 [Note] /usr/libexec/mysqld: Shutdown complete
>
>140808 15:16:46 mysqld_safe mysqld from pid file /var/run/mariadb/mariadb.pid ended
>140808 15:16:46 mysqld_safe Starting mysqld daemon with databases from /var/lib/mysql
>140808 15:16:46 mysqld_safe WSREP: Running position recovery with --log_error='/var/lib/mysql/wsrep_recovery.agA8Wh' --pid-file='/var/lib/mysql/maca25400702876.example.com-recover.pid'
>140808 15:16:46 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 15:16:46 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 15:16:46 [Warning] Could not increase number of max_open_files to more than 1024 (request: 1835)
>/usr/libexec/mysqld: Query cache is disabled (resize or similar command in progress); repeat this command later
>140808 15:16:48 mysqld_safe WSREP: Recovered position 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>140808 15:16:48 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 15:16:48 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 15:16:48 [Note] WSREP: wsrep_start_position var submitted: '162e206f-1f0c-11e4-a55f-87aae18c99f1:20'
>140808 15:16:48 [Warning] Could not increase number of max_open_files to more than 1024 (request: 1835)
>/usr/libexec/mysqld: Query cache is disabled (resize or similar command in progress); repeat this command later
>140808 15:16:48 [Note] WSREP: Read nil XID from storage engines, skipping position init
>140808 15:16:48 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib64/galera/libgalera_smm.so'
>140808 15:16:48 [Note] WSREP: wsrep_load(): Galera 3.5(rXXXX) by Codership Oy <info@codership.com> loaded successfully.
>140808 15:16:48 [Note] WSREP: CRC-32C: using "slicing-by-8" algorithm.
>140808 15:16:48 [Note] WSREP: Found saved state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:-1
>140808 15:16:48 [Note] WSREP: Passing config to GCS: base_host = 10.8.29.214; base_port = 4567; cert.log_conflicts = no; debug = no; evs.inactive_check_period = PT0.5S; evs.inactive_timeout = PT15S; evs.join_retrans_period = PT1S; evs.max_install_timeouts = 1; 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.size = 128M; 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; pc.checksum = false; pc.ignore_quorum = false; pc.ignore_sb = false; pc.npvo = false; pc.version = 0; pc.wait_prim = true; pc.wait_prim_timeout = P30S; pc.weight = 1; protonet
>140808 15:16:48 [Note] WSREP: Service thread queue flushed.
>140808 15:16:48 [Note] WSREP: Assign initial position for certification: 20, protocol version: -1
>140808 15:16:48 [Note] WSREP: wsrep_sst_grab()
>140808 15:16:48 [Note] WSREP: Start replication
>140808 15:16:48 [Note] WSREP: Setting initial position to 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>140808 15:16:48 [Note] WSREP: protonet asio version 0
>140808 15:16:48 [Note] WSREP: Using CRC-32C (optimized) for message checksums.
>140808 15:16:48 [Note] WSREP: backend: asio
>140808 15:16:48 [Note] WSREP: GMCast version 0
>140808 15:16:48 [Note] WSREP: (04754ae8-1f0f-11e4-a064-76fa7b1d6330, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
>140808 15:16:48 [Note] WSREP: (04754ae8-1f0f-11e4-a064-76fa7b1d6330, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
>140808 15:16:48 [Note] WSREP: EVS version 0
>140808 15:16:48 [Note] WSREP: PC version 0
>140808 15:16:48 [Note] WSREP: gcomm: connecting to group 'galera_cluster', peer '192.168.0.9:,192.168.0.10:,192.168.0.11:'
>140808 15:16:48 [Warning] WSREP: (04754ae8-1f0f-11e4-a064-76fa7b1d6330, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' points to own listening address, blacklisting
>140808 15:16:51 [Warning] WSREP: no nodes coming from prim view, prim not possible
>140808 15:16:51 [Note] WSREP: view(view_id(NON_PRIM,04754ae8-1f0f-11e4-a064-76fa7b1d6330,1) memb {
>	04754ae8-1f0f-11e4-a064-76fa7b1d6330,0
>} joined {
>} left {
>} partitioned {
>})
>140808 15:16:52 [Warning] WSREP: last inactive check more than PT1.5S ago (PT3.50249S), skipping check
>140808 15:17:21 [Note] WSREP: view((empty))
>140808 15:17:21 [ERROR] WSREP: failed to open gcomm backend connection: 110: failed to reach primary view: 110 (Connection timed out)
>	 at gcomm/src/pc.cpp:connect():141
>140808 15:17:21 [ERROR] WSREP: gcs/src/gcs_core.c:gcs_core_open():202: Failed to open backend connection: -110 (Connection timed out)
>140808 15:17:21 [ERROR] WSREP: gcs/src/gcs.c:gcs_open():1291: Failed to open channel 'galera_cluster' at 'gcomm://192.168.0.9,192.168.0.10,192.168.0.11': -110 (Connection timed out)
>140808 15:17:21 [ERROR] WSREP: gcs connect failed: Connection timed out
>140808 15:17:21 [ERROR] WSREP: wsrep::connect() failed: 7
>140808 15:17:21 [ERROR] Aborting
>
>140808 15:17:21 [Note] WSREP: Service disconnected.
>140808 15:17:22 [Note] WSREP: Some threads may fail to exit.
>140808 15:17:22 [Note] /usr/libexec/mysqld: Shutdown complete
>
>140808 15:17:22 mysqld_safe mysqld from pid file /var/run/mariadb/mariadb.pid ended
>140808 15:46:16 mysqld_safe Starting mysqld daemon with databases from /var/lib/mysql
>140808 15:46:16 mysqld_safe WSREP: Running position recovery with --log_error='/var/lib/mysql/wsrep_recovery.AkyPaI' --pid-file='/var/lib/mysql/maca25400702876.example.com-recover.pid'
>140808 15:46:16 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 15:46:16 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 15:46:16 [Warning] Could not increase number of max_open_files to more than 1024 (request: 1835)
>/usr/libexec/mysqld: Query cache is disabled (resize or similar command in progress); repeat this command later
>140808 15:46:18 mysqld_safe WSREP: Recovered position 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>140808 15:46:18 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 15:46:18 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 15:46:18 [Note] WSREP: wsrep_start_position var submitted: '162e206f-1f0c-11e4-a55f-87aae18c99f1:20'
>140808 15:46:18 [Warning] Could not increase number of max_open_files to more than 1024 (request: 1835)
>/usr/libexec/mysqld: Query cache is disabled (resize or similar command in progress); repeat this command later
>140808 15:46:18 [Note] WSREP: Read nil XID from storage engines, skipping position init
>140808 15:46:18 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib64/galera/libgalera_smm.so'
>140808 15:46:18 [Note] WSREP: wsrep_load(): Galera 3.5(rXXXX) by Codership Oy <info@codership.com> loaded successfully.
>140808 15:46:18 [Note] WSREP: CRC-32C: using "slicing-by-8" algorithm.
>140808 15:46:18 [Note] WSREP: Found saved state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:-1
>140808 15:46:18 [Note] WSREP: Passing config to GCS: base_host = 10.8.29.214; base_port = 4567; cert.log_conflicts = no; debug = no; evs.inactive_check_period = PT0.5S; evs.inactive_timeout = PT15S; evs.join_retrans_period = PT1S; evs.max_install_timeouts = 1; 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.size = 128M; 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; pc.checksum = false; pc.ignore_quorum = false; pc.ignore_sb = false; pc.npvo = false; pc.version = 0; pc.wait_prim = true; pc.wait_prim_timeout = P30S; pc.weight = 1; protonet
>140808 15:46:18 [Note] WSREP: Service thread queue flushed.
>140808 15:46:18 [Note] WSREP: Assign initial position for certification: 20, protocol version: -1
>140808 15:46:18 [Note] WSREP: wsrep_sst_grab()
>140808 15:46:18 [Note] WSREP: Start replication
>140808 15:46:18 [Note] WSREP: Setting initial position to 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>140808 15:46:18 [Note] WSREP: protonet asio version 0
>140808 15:46:18 [Note] WSREP: Using CRC-32C (optimized) for message checksums.
>140808 15:46:18 [Note] WSREP: backend: asio
>140808 15:46:18 [Note] WSREP: GMCast version 0
>140808 15:46:18 [Note] WSREP: (23791517-1f13-11e4-b54a-abdb77f71828, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
>140808 15:46:18 [Note] WSREP: (23791517-1f13-11e4-b54a-abdb77f71828, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
>140808 15:46:18 [Note] WSREP: EVS version 0
>140808 15:46:18 [Note] WSREP: PC version 0
>140808 15:46:18 [Note] WSREP: gcomm: connecting to group 'galera_cluster', peer '192.168.0.9:,192.168.0.10:,192.168.0.11:'
>140808 15:46:18 [Warning] WSREP: (23791517-1f13-11e4-b54a-abdb77f71828, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' points to own listening address, blacklisting
>140808 15:46:21 [Warning] WSREP: no nodes coming from prim view, prim not possible
>140808 15:46:21 [Note] WSREP: view(view_id(NON_PRIM,23791517-1f13-11e4-b54a-abdb77f71828,1) memb {
>	23791517-1f13-11e4-b54a-abdb77f71828,0
>} joined {
>} left {
>} partitioned {
>})
>140808 15:46:22 [Warning] WSREP: last inactive check more than PT1.5S ago (PT3.50286S), skipping check
>140808 15:46:51 [Note] WSREP: view((empty))
>140808 15:46:51 [ERROR] WSREP: failed to open gcomm backend connection: 110: failed to reach primary view: 110 (Connection timed out)
>	 at gcomm/src/pc.cpp:connect():141
>140808 15:46:51 [ERROR] WSREP: gcs/src/gcs_core.c:gcs_core_open():202: Failed to open backend connection: -110 (Connection timed out)
>140808 15:46:51 [ERROR] WSREP: gcs/src/gcs.c:gcs_open():1291: Failed to open channel 'galera_cluster' at 'gcomm://192.168.0.9,192.168.0.10,192.168.0.11': -110 (Connection timed out)
>140808 15:46:51 [ERROR] WSREP: gcs connect failed: Connection timed out
>140808 15:46:51 [ERROR] WSREP: wsrep::connect() failed: 7
>140808 15:46:51 [ERROR] Aborting
>
>140808 15:46:51 [Note] WSREP: Service disconnected.
>140808 15:46:52 [Note] WSREP: Some threads may fail to exit.
>140808 15:46:52 [Note] /usr/libexec/mysqld: Shutdown complete
>
>140808 15:46:52 mysqld_safe mysqld from pid file /var/run/mariadb/mariadb.pid ended
>140808 16:16:09 mysqld_safe Starting mysqld daemon with databases from /var/lib/mysql
>140808 16:16:09 mysqld_safe WSREP: Running position recovery with --log_error='/var/lib/mysql/wsrep_recovery.ecaaMq' --pid-file='/var/lib/mysql/maca25400702876.example.com-recover.pid'
>140808 16:16:09 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 16:16:09 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 16:16:09 [Warning] Could not increase number of max_open_files to more than 1024 (request: 1835)
>/usr/libexec/mysqld: Query cache is disabled (resize or similar command in progress); repeat this command later
>140808 16:16:11 mysqld_safe WSREP: Recovered position 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>140808 16:16:11 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 16:16:11 [Warning] option 'open_files_limit': unsigned value 18446744073709551615 adjusted to 4294967295
>140808 16:16:11 [Note] WSREP: wsrep_start_position var submitted: '162e206f-1f0c-11e4-a55f-87aae18c99f1:20'
>140808 16:16:11 [Warning] Could not increase number of max_open_files to more than 1024 (request: 1835)
>/usr/libexec/mysqld: Query cache is disabled (resize or similar command in progress); repeat this command later
>140808 16:16:11 [Note] WSREP: Read nil XID from storage engines, skipping position init
>140808 16:16:11 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib64/galera/libgalera_smm.so'
>140808 16:16:11 [Note] WSREP: wsrep_load(): Galera 3.5(rXXXX) by Codership Oy <info@codership.com> loaded successfully.
>140808 16:16:11 [Note] WSREP: CRC-32C: using "slicing-by-8" algorithm.
>140808 16:16:11 [Note] WSREP: Found saved state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:-1
>140808 16:16:11 [Note] WSREP: Passing config to GCS: base_host = 10.8.29.214; base_port = 4567; cert.log_conflicts = no; debug = no; evs.inactive_check_period = PT0.5S; evs.inactive_timeout = PT15S; evs.join_retrans_period = PT1S; evs.max_install_timeouts = 1; 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.size = 128M; 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; pc.checksum = false; pc.ignore_quorum = false; pc.ignore_sb = false; pc.npvo = false; pc.version = 0; pc.wait_prim = true; pc.wait_prim_timeout = P30S; pc.weight = 1; protonet
>140808 16:16:11 [Note] WSREP: Service thread queue flushed.
>140808 16:16:11 [Note] WSREP: Assign initial position for certification: 20, protocol version: -1
>140808 16:16:11 [Note] WSREP: wsrep_sst_grab()
>140808 16:16:11 [Note] WSREP: Start replication
>140808 16:16:11 [Note] WSREP: Setting initial position to 162e206f-1f0c-11e4-a55f-87aae18c99f1:20
>140808 16:16:11 [Note] WSREP: protonet asio version 0
>140808 16:16:11 [Note] WSREP: Using CRC-32C (optimized) for message checksums.
>140808 16:16:11 [Note] WSREP: backend: asio
>140808 16:16:11 [Note] WSREP: GMCast version 0
>140808 16:16:11 [Note] WSREP: (501d41db-1f17-11e4-b4aa-f378ef11c981, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
>140808 16:16:11 [Note] WSREP: (501d41db-1f17-11e4-b4aa-f378ef11c981, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
>140808 16:16:11 [Note] WSREP: EVS version 0
>140808 16:16:11 [Note] WSREP: PC version 0
>140808 16:16:11 [Note] WSREP: gcomm: connecting to group 'galera_cluster', peer '192.168.0.9:,192.168.0.10:,192.168.0.11:'
>140808 16:16:11 [Warning] WSREP: (501d41db-1f17-11e4-b4aa-f378ef11c981, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' points to own listening address, blacklisting
>140808 16:16:11 [Note] WSREP: (501d41db-1f17-11e4-b4aa-f378ef11c981, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 501d41db-1f17-11e4-b4aa-f378ef11c981 is blacklisted, skipping
>140808 16:16:11 [Note] WSREP: (501d41db-1f17-11e4-b4aa-f378ef11c981, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 501d41db-1f17-11e4-b4aa-f378ef11c981 is blacklisted, skipping
>140808 16:16:11 [Note] WSREP: (501d41db-1f17-11e4-b4aa-f378ef11c981, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 501d41db-1f17-11e4-b4aa-f378ef11c981 is blacklisted, skipping
>140808 16:16:11 [Note] WSREP: (501d41db-1f17-11e4-b4aa-f378ef11c981, 'tcp://0.0.0.0:4567') address 'tcp://192.168.0.10:4567' pointing to uuid 501d41db-1f17-11e4-b4aa-f378ef11c981 is blacklisted, skipping
>140808 16:16:12 [Note] WSREP: declaring 202d574d-1f16-11e4-a622-0aae7c3c4d06 stable
>140808 16:16:12 [Note] WSREP: declaring 204d48c0-1f16-11e4-804a-f676e17d65e3 stable
>140808 16:16:12 [Note] WSREP: Node 202d574d-1f16-11e4-a622-0aae7c3c4d06 state prim
>140808 16:16:12 [Note] WSREP: view(view_id(PRIM,202d574d-1f16-11e4-a622-0aae7c3c4d06,3) memb {
>	202d574d-1f16-11e4-a622-0aae7c3c4d06,0
>	204d48c0-1f16-11e4-804a-f676e17d65e3,0
>	501d41db-1f17-11e4-b4aa-f378ef11c981,0
>} joined {
>} left {
>} partitioned {
>})
>140808 16:16:12 [Note] WSREP: gcomm: connected
>140808 16:16:12 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
>140808 16:16:12 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
>140808 16:16:12 [Note] WSREP: Opened channel 'galera_cluster'
>140808 16:16:12 [Note] WSREP: Waiting for SST to complete.
>140808 16:16:12 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 2, memb_num = 3
>140808 16:16:12 [Note] WSREP: STATE EXCHANGE: Waiting for state UUID.
>140808 16:16:12 [Note] WSREP: STATE EXCHANGE: sent state msg: 51254e62-1f17-11e4-93d4-33395a76ce8b
>140808 16:16:12 [Note] WSREP: STATE EXCHANGE: got state msg: 51254e62-1f17-11e4-93d4-33395a76ce8b from 0 (maca25400702875.example.com)
>140808 16:16:12 [Note] WSREP: STATE EXCHANGE: got state msg: 51254e62-1f17-11e4-93d4-33395a76ce8b from 1 (maca25400702877.example.com)
>140808 16:16:12 [Note] WSREP: STATE EXCHANGE: got state msg: 51254e62-1f17-11e4-93d4-33395a76ce8b from 2 (maca25400702876.example.com)
>140808 16:16:12 [Note] WSREP: Quorum results:
>	version    = 3,
>	component  = PRIMARY,
>	conf_id    = 2,
>	members    = 3/3 (joined/total),
>	act_id     = 20,
>	last_appl. = -1,
>	protocols  = 0/5/2 (gcs/repl/appl),
>	group UUID = 162e206f-1f0c-11e4-a55f-87aae18c99f1
>140808 16:16:12 [Note] WSREP: Flow-control interval: [28, 28]
>140808 16:16:12 [Note] WSREP: Restored state OPEN -> JOINED (20)
>140808 16:16:12 [Note] WSREP: New cluster view: global state: 162e206f-1f0c-11e4-a55f-87aae18c99f1:20, view# 3: Primary, number of nodes: 3, my index: 2, protocol version 2
>140808 16:16:12 [Note] WSREP: SST complete, seqno: 20
>140808 16:16:12 [Note] WSREP: Member 2.0 (maca25400702876.example.com) synced with group.
>140808 16:16:12 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 20)
>140808 16:16:12 InnoDB: The InnoDB memory heap is disabled
>140808 16:16:12 InnoDB: Mutexes and rw_locks use GCC atomic builtins
>140808 16:16:12 InnoDB: Compressed tables use zlib 1.2.7
>140808 16:16:12 InnoDB: Using Linux native AIO
>140808 16:16:12 InnoDB: Initializing buffer pool, size = 128.0M
>140808 16:16:12 InnoDB: Completed initialization of buffer pool
>140808 16:16:12 InnoDB: highest supported file format is Barracuda.
>140808 16:16:12  InnoDB: Waiting for the background threads to start
>140808 16:16:13 Percona XtraDB (http://www.percona.com) 5.5.37-MariaDB-34.0 started; log sequence number 1598617
>140808 16:16:13 [Note] Plugin 'FEEDBACK' is disabled.
>140808 16:16:13 [Note] Server socket created on IP: '10.8.29.214'.
>140808 16:16:13 [Note] Event Scheduler: Loaded 0 events
>140808 16:16:13 [Note] /usr/libexec/mysqld: ready for connections.
>Version: '5.5.37-MariaDB-wsrep'  socket: '/var/lib/mysql/mysql.sock'  port: 3306  MariaDB Server, wsrep_25.10.r3980
>140808 16:16:13 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>140808 16:16:13 [Note] WSREP: REPL Protocols: 5 (3, 1)
>140808 16:16:13 [Note] WSREP: Service thread queue flushed.
>140808 16:16:13 [Note] WSREP: Assign initial position for certification: 20, protocol version: 3
>140808 16:16:13 [Note] WSREP: Service thread queue flushed.
>140808 16:16:13 [Note] WSREP: Synchronized with group, ready for connections
>140808 16:16:13 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.

Actions: View

Attachments on bug 1128285: 925288 | 925289 | 925290 | 925292