Details
-
Bug
-
Status: Closed (View Workflow)
-
Major
-
Resolution: Fixed
-
5.5.28a-galera
-
None
-
Debian Squeeze on KVM.
Description
Using the two bash scripts I made, the first for installing the service on each server, the second for connecting the cluster on the second server, I have the following error on the second server:
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] /usr/sbin/mysqld: Normal shutdown
Feb 11 10:41:27 mariadb2 mysqld:
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: Stop replication
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: Closing send monitor...
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: Closed send monitor.
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: gcomm: terminating thread
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: gcomm: joining thread
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: gcomm: closing backend
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: view((empty))
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: Received self-leave message.
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: gcomm: closed
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: Flow-control interval: [0, 0]
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: Received SELF-LEAVE. Closing connection.
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: Shifting SYNCED -> CLOSED (TO: 160)
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: RECV thread exiting 0: Success
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: New cluster view: global state: 64dc5b89-742e-11e2-0800-9315c248faac:160, view# -1: non-Primary, number of nodes: 0, my index: -1, protocol version 2
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: applier thread exiting (code:0)
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: recv_thread() joined.
Feb 11 10:41:27 mariadb2 mysqld: 130211 10:41:27 [Note] WSREP: Closing slave action queue.
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] WSREP: rollbacker thread exiting
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] Event Scheduler: Purging the queue. 0 events
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] WSREP: dtor state: CLOSED
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] WSREP: mon: entered 160 oooe fraction 0 oool fraction 0
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] WSREP: mon: entered 160 oooe fraction 0 oool fraction 0
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] WSREP: mon: entered 163 oooe fraction 0 oool fraction 0
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] WSREP: cert index usage at exit 44
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] WSREP: cert trx map usage at exit 160
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] WSREP: deps set usage at exit 0
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] WSREP: avg deps dist 1
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] WSREP: wsdb trx map usage 0 conn query map usage 0
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] WSREP: Shifting CLOSED -> DESTROYED (TO: 160)
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 [Note] WSREP: Flushing memory map to disk...
Feb 11 10:41:29 mariadb2 mysqld: 130211 10:41:29 InnoDB: Starting shutdown...
Feb 11 10:41:30 mariadb2 mysqld: 130211 10:41:30 InnoDB: Shutdown completed; log sequence number 1598303
Feb 11 10:41:30 mariadb2 mysqld: 130211 10:41:30 [Note] /usr/sbin/mysqld: Shutdown complete
Feb 11 10:41:30 mariadb2 mysqld:
Feb 11 10:41:30 mariadb2 mysqld_safe: mysqld from pid file /var/run/mysqld/mysqld.pid ended
Feb 11 10:41:32 mariadb2 mysqld_safe: Starting mysqld daemon with databases from /var/lib/mysql
Feb 11 10:41:32 mariadb2 mysqld_safe: WSREP: Running position recovery with --log_error=/tmp/tmp.83XkqghiNr
Feb 11 10:41:34 mariadb2 mysqld_safe: WSREP: Recovered position 64dc5b89-742e-11e2-0800-9315c248faac:0
Feb 11 10:41:34 mariadb2 mysqld: 130211 10:41:34 [Warning] option 'table_cache': unsigned value 2097152 adjusted to 524288
Feb 11 10:41:34 mariadb2 mysqld: 130211 10:41:34 [Note] WSREP: wsrep_start_position var submitted: '64dc5b89-742e-11e2-0800-9315c248faac:0'
Feb 11 10:41:34 mariadb2 mysqld: 130211 10:41:34 [Note] WSREP: Read nil XID from storage engines, skipping position init
Feb 11 10:41:34 mariadb2 mysqld: 130211 10:41:34 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib/galera/libgalera_smm.so'
Feb 11 10:41:34 mariadb2 mysqld: 130211 10:41:34 [Note] WSREP: wsrep_load(): Galera 23.2.2(r137) by Codership Oy <info@codership.com> loaded succesfully.
Feb 11 10:41:34 mariadb2 mysqld: 130211 10:41:34 [ERROR] WSREP: Failed to read output of: '/sbin/ifconfig | grep -E '^[[:space:]]+inet addr:' | grep -m1 -v 'inet addr:127' | sed 's/:/ /' | awk '
Feb 11 10:41:34 mariadb2 mysqld: 130211 10:41:34 [Warning] WSREP: Failed to guess base node address. Set it explicitly via wsrep_node_address.
Feb 11 10:41:34 mariadb2 mysqld: 130211 10:41:34 [Warning] WSREP: Guessing address for incoming client connections failed. Try setting wsrep_node_incoming_address explicitly.
Feb 11 10:41:34 mariadb2 mysqld: 130211 10:41:34 [Note] WSREP: Found saved state: 64dc5b89-742e-11e2-0800-9315c248faac:160
Feb 11 10:41:34 mariadb2 mysqld: 130211 10:41:34 [Note] WSREP: Reusing existing '/var/lib/mysql//galera.cache'.
Feb 11 10:41:34 mariadb2 mysqld: 130211 10:41:34 [Note] WSREP: Passing config to GCS: base_port = 4567; cert.log_conflicts = no; 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; 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; replicator.causal_read_timeout = PT30S; replicator.commit_order = 3
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: Assign initial position for certification: 160, protocol version: -1
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: wsrep_sst_grab()
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: Start replication
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: Setting initial position to 64dc5b89-742e-11e2-0800-9315c248faac:160
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: protonet asio version 0
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: backend: asio
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: GMCast version 0
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: (3972dc6f-742f-11e2-0800-02e5048bee79, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: (3972dc6f-742f-11e2-0800-02e5048bee79, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: EVS version 0
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: PC version 0
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: gcomm: connecting to group 'my_wsrep_cluster', peer '192.168.122.137:'
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: declaring c71af152-742e-11e2-0800-b2d6fce1fcbe stable
Feb 11 10:41:35 mariadb2 mysqld: 130211 10:41:35 [Note] WSREP: view(view_id(PRIM,3972dc6f-742f-11e2-0800-02e5048bee79,2) memb { Feb 11 10:41:35 mariadb2 mysqld: #0113972dc6f-742f-11e2-0800-02e5048bee79, Feb 11 10:41:35 mariadb2 mysqld: #011c71af152-742e-11e2-0800-b2d6fce1fcbe, Feb 11 10:41:35 mariadb2 mysqld: } joined { Feb 11 10:41:35 mariadb2 mysqld: } left { Feb 11 10:41:35 mariadb2 mysqld: } partitioned { Feb 11 10:41:35 mariadb2 mysqld: })
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: gcomm: connected
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: Opened channel 'my_wsrep_cluster'
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: Waiting for SST to complete.
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 2
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 3a0d6651-742f-11e2-0800-786cdd42b5c4
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: STATE EXCHANGE: sent state msg: 3a0d6651-742f-11e2-0800-786cdd42b5c4
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: STATE EXCHANGE: got state msg: 3a0d6651-742f-11e2-0800-786cdd42b5c4 from 1 (mariadb1)
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: STATE EXCHANGE: got state msg: 3a0d6651-742f-11e2-0800-786cdd42b5c4 from 0 (mariadb2)
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: Quorum results:
Feb 11 10:41:36 mariadb2 mysqld: #011version = 2,
Feb 11 10:41:36 mariadb2 mysqld: #011component = PRIMARY,
Feb 11 10:41:36 mariadb2 mysqld: #011conf_id = 1,
Feb 11 10:41:36 mariadb2 mysqld: #011members = 1/2 (joined/total),
Feb 11 10:41:36 mariadb2 mysqld: #011act_id = 160,
Feb 11 10:41:36 mariadb2 mysqld: #011last_appl. = -1,
Feb 11 10:41:36 mariadb2 mysqld: #011protocols = 0/4/2 (gcs/repl/appl),
Feb 11 10:41:36 mariadb2 mysqld: #011group UUID = c71c6b4f-742e-11e2-0800-c1770497f8e0
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: Flow-control interval: [23, 23]
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: Shifting OPEN -> PRIMARY (TO: 160)
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: State transfer required:
Feb 11 10:41:36 mariadb2 mysqld: #011Group state: c71c6b4f-742e-11e2-0800-c1770497f8e0:160
Feb 11 10:41:36 mariadb2 mysqld: #011Local state: 64dc5b89-742e-11e2-0800-9315c248faac:160
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Note] WSREP: New cluster view: global state: c71c6b4f-742e-11e2-0800-c1770497f8e0:160, view# 2: Primary, number of nodes: 2, my index: 0, protocol version 2
Feb 11 10:41:36 mariadb2 mysqld: 130211 10:41:36 [Warning] WSREP: Gap in state sequence. Need state transfer.
Feb 11 10:41:38 mariadb2 mysqld: 130211 10:41:38 [ERROR] WSREP: Failed to read output of: '/sbin/ifconfig | grep -E '^[[:space:]]+inet addr:' | grep -m1 -v 'inet addr:127' | sed 's/:/ /' | awk '{ print $3 }
''
Feb 11 10:41:38 mariadb2 mysqld: 130211 10:41:38 [ERROR] WSREP: Could not prepare state transfer request: failed to guess address to accept state transfer at. wsrep_sst_receive_address must be set manually.
Feb 11 10:41:38 mariadb2 mysqld: 130211 10:41:38 [ERROR] Aborting
Feb 11 10:41:38 mariadb2 mysqld:
Feb 11 10:41:40 mariadb2 mysqld: 130211 10:41:40 [Note] WSREP: Closing send monitor...
Feb 11 10:41:40 mariadb2 mysqld: 130211 10:41:40 [Note] WSREP: Closed send monitor.
Feb 11 10:41:40 mariadb2 mysqld: 130211 10:41:40 [Note] WSREP: gcomm: terminating thread
Feb 11 10:41:40 mariadb2 mysqld: 130211 10:41:40 [Note] WSREP: gcomm: joining thread
Feb 11 10:41:40 mariadb2 mysqld: 130211 10:41:40 [Note] WSREP: gcomm: closing backend
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: view(view_id(NON_PRIM,3972dc6f-742f-11e2-0800-02e5048bee79,2) memb
joined
{ Feb 11 10:41:41 mariadb2 mysqld: }left
{ Feb 11 10:41:41 mariadb2 mysqld: }partitioned
{ Feb 11 10:41:41 mariadb2 mysqld: #011c71af152-742e-11e2-0800-b2d6fce1fcbe, Feb 11 10:41:41 mariadb2 mysqld: })
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: view((empty))
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: gcomm: closed
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: Flow-control interval: [16, 16]
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: Received NON-PRIMARY.
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: Shifting PRIMARY -> OPEN (TO: 160)
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: Received self-leave message.
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: Flow-control interval: [0, 0]
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: Received SELF-LEAVE. Closing connection.
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: Shifting OPEN -> CLOSED (TO: 160)
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: RECV thread exiting 0: Success
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: recv_thread() joined.
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: Closing slave action queue.
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: Service disconnected.
Feb 11 10:41:41 mariadb2 mysqld: 130211 10:41:41 [Note] WSREP: rollbacker thread exiting
Feb 11 10:41:42 mariadb2 mysqld: 130211 10:41:42 [Note] WSREP: Some threads may fail to exit.
Feb 11 10:41:42 mariadb2 mysqld: 130211 10:41:42 [Note] /usr/sbin/mysqld: Shutdown complete
Feb 11 10:41:42 mariadb2 mysqld:
Feb 11 10:41:47 mariadb2 mysqld: Error in my_thread_global_end(): 2 threads didn't exit
Feb 11 10:41:47 mariadb2 mysqld_safe: mysqld from pid file /var/run/mysqld/mysqld.pid ended
Feb 11 10:42:02 mariadb2 /etc/init.d/mysql[5109]: 0 processes alive and '/usr/bin/mysqladmin --defaults-file=/etc/mysql/debian.cnf ping' resulted in
Feb 11 10:42:02 mariadb2 /etc/init.d/mysql[5109]: #007/usr/bin/mysqladmin: connect to server at 'localhost' failed
Feb 11 10:42:02 mariadb2 /etc/init.d/mysql[5109]: error: 'Can't connect to local MySQL server through socket '/var/run/mysqld/mysqld.sock' (111)'
Feb 11 10:42:02 mariadb2 /etc/init.d/mysql[5109]: Check that mysqld is running and that the socket: '/var/run/mysqld/mysqld.sock' exists!
Feb 11 10:42:02 mariadb2 /etc/init.d/mysql[5109]: