Trying to create a cluster, the second and third nodes won’t join if I use xtrabackup-v2. If I use rsync it works fine.
On the donor, after the tables are streamed, there is an error about not being able to find a bin log, and then it all shuts down.
-innobackupex-backup: [00] error: cannot open file /mysql_datadir//mariadb-bin.000363
Here are the donor logs:
...
Mar 15 09:26:32 avc2-wus1-db08 -innobackupex-backup: 160315 09:26:32 [01] Streaming ./mysql/help_relation.frm to <STDOUT>
Mar 15 09:26:32 avc2-wus1-db08 -innobackupex-backup: 160315 09:26:32 [01] ...done
Mar 15 09:26:32 avc2-wus1-db08 -innobackupex-backup: 160315 09:26:32 [01] Streaming ./mysql/time_zone_transition.frm to <STDOUT>
Mar 15 09:26:32 avc2-wus1-db08 -innobackupex-backup: 160315 09:26:32 [01] ...done
Mar 15 09:26:32 avc2-wus1-db08 -innobackupex-backup: 160315 09:26:32 [01] Streaming ./mysql/time_zone.frm to <STDOUT>
Mar 15 09:26:32 avc2-wus1-db08 -innobackupex-backup: 160315 09:26:32 [01] ...done
Mar 15 09:26:32 avc2-wus1-db08 -innobackupex-backup: 160315 09:26:32 [01] Streaming ./plugin/db.opt to <STDOUT>
Mar 15 09:26:32 avc2-wus1-db08 -innobackupex-backup: 160315 09:26:32 [01] ...done
Mar 15 09:26:32 avc2-wus1-db08 -innobackupex-backup: 160315 09:26:32 Finished backing up non-InnoDB tables and files
Mar 15 09:26:32 avc2-wus1-db08 -innobackupex-backup: 160315 09:26:32 [00] Streaming xtrabackup_galera_info
Mar 15 09:26:32 avc2-wus1-db08 -innobackupex-backup: 160315 09:26:32 [00] ...done
Mar 15 09:26:33 avc2-wus1-db08 -innobackupex-backup: InnoDB: Operating system error number 2 in a file operation.
Mar 15 09:26:33 avc2-wus1-db08 -innobackupex-backup: InnoDB: The error means the system cannot find the path specified.
Mar 15 09:26:33 avc2-wus1-db08[B] -innobackupex-backup: [00] error: cannot open file /mysql_datadir//mariadb-bin.000363[/B]
Mar 15 09:26:33 avc2-wus1-db08 -innobackupex-backup: InnoDB: Operating system error number 9 in a file operation.
Mar 15 09:26:33 avc2-wus1-db08 -innobackupex-backup: InnoDB: Error number 9 means 'Bad file descriptor'
Mar 15 09:26:33 avc2-wus1-db08 -innobackupex-backup: InnoDB: Some operating system error numbers are described at http://dev.mysql.com/doc/refman/5.7/en/operating-system-error-codes.html
Mar 15 09:26:33 avc2-wus1-db08 -innobackupex-backup: InnoDB: File (unknown): 'close' returned OS error 109. Cannot continue operation
Mar 15 09:26:33 avc2-wus1-db08 -innobackupex-backup: InnoDB: Cannot continue operation.
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Warning] Aborted connection 45 to db: 'unconnected' user: 'root' host: 'localhost' (Unknown error)
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: resuming provider at 11
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: Provider resumed.
Mar 15 09:26:33 avc2-wus1-db08 -wsrep-sst-donor: innobackupex finished with error: 3. Check /mysql_datadir//innobackup.backup.log
Mar 15 09:26:33 avc2-wus1-db08 -wsrep-sst-donor: Cleanup after exit with status:22
Mar 15 09:26:33 avc2-wus1-db08 -wsrep-sst-donor: Cleaning up temporary directories
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [ERROR] WSREP: Failed to read from: wsrep_sst_xtrabackup-v2 --role 'donor' --address '10.150.28.26:4444/xtrabackup_sst//1' --socket '/var/run/mysqld/mysqld.sock' --datadir '/mysql_datadir/' --defaults-file '/etc/mysql/my.cnf' --defaults-group-suffix '' --binlog '/var/log/mysql/mariadb-bin' --gtid '37178575-308f-11e5-a8b2-6af2fcef5c43:1397289'
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [ERROR] WSREP: Process completed with error: wsrep_sst_xtrabackup-v2 --role 'donor' --address '10.150.28.26:4444/xtrabackup_sst//1' --socket '/var/run/mysqld/mysqld.sock' --datadir '/mysql_datadir/' --defaults-file '/etc/mysql/my.cnf' --defaults-group-suffix '' --binlog '/var/log/mysql/mariadb-bin' --gtid '37178575-308f-11e5-a8b2-6af2fcef5c43:1397289': 22 (Invalid argument)
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [ERROR] WSREP: Command did not run: wsrep_sst_xtrabackup-v2 --role 'donor' --address '10.150.28.26:4444/xtrabackup_sst//1' --socket '/var/run/mysqld/mysqld.sock' --datadir '/mysql_datadir/' --defaults-file '/etc/mysql/my.cnf' --defaults-group-suffix '' --binlog '/var/log/mysql/mariadb-bin' --gtid '37178575-308f-11e5-a8b2-6af2fcef5c43:1397289'
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Warning] WSREP: 0.0 (avc2-wus1-db08): State transfer to 1.0 (avc2-wus1-db09) failed: -22 (Invalid argument)
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: Shifting DONOR/DESYNCED -> JOINED (TO: 1397290)
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: declaring a88f0db7 at tcp://10.150.28.24:4567 stable
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: forgetting 9f75855a (tcp://10.150.28.26:4567)
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: Member 0.0 (avc2-wus1-db08) synced with group.
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 1397290)
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: Synchronized with group, ready for connections
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: Node 51b6359d state prim
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: view(view_id(PRIM,51b6359d,26) memb {
Mar 15 09:26:33 avc2-wus1-db08 mysqld: #01151b6359d,0
Mar 15 09:26:33 avc2-wus1-db08 mysqld: #011a88f0db7,0
Mar 15 09:26:33 avc2-wus1-db08 mysqld: } joined {
Mar 15 09:26:33 avc2-wus1-db08 mysqld: } left {
Mar 15 09:26:33 avc2-wus1-db08 mysqld: } partitioned {
Mar 15 09:26:33 avc2-wus1-db08 mysqld: #0119f75855a,0
Mar 15 09:26:33 avc2-wus1-db08 mysqld: })
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: save pc into disk
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: forgetting 9f75855a (tcp://10.150.28.26:4567)
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 2
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: STATE_EXCHANGE: sent state UUID: ae2b229f-eaca-11e5-b86f-8e27339ebc6b
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: STATE EXCHANGE: sent state msg: ae2b229f-eaca-11e5-b86f-8e27339ebc6b
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: STATE EXCHANGE: got state msg: ae2b229f-eaca-11e5-b86f-8e27339ebc6b from 0 (avc2-wus1-db08)
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: STATE EXCHANGE: got state msg: ae2b229f-eaca-11e5-b86f-8e27339ebc6b from 1 (avc2-wus1-db07)
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: Quorum results:
Mar 15 09:26:33 avc2-wus1-db08 mysqld: #011version = 3,
Mar 15 09:26:33 avc2-wus1-db08 mysqld: #011component = PRIMARY,
Mar 15 09:26:33 avc2-wus1-db08 mysqld: #011conf_id = 23,
Mar 15 09:26:33 avc2-wus1-db08 mysqld: #011members = 2/2 (joined/total),
Mar 15 09:26:33 avc2-wus1-db08 mysqld: #011act_id = 1397290,
Mar 15 09:26:33 avc2-wus1-db08 mysqld: #011last_appl. = 0,
Mar 15 09:26:33 avc2-wus1-db08 mysqld: #011protocols = 0/7/3 (gcs/repl/appl),
Mar 15 09:26:33 avc2-wus1-db08 mysqld: #011group UUID = 37178575-308f-11e5-a8b2-6af2fcef5c43
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: Flow-control interval: [23, 23]
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: New cluster view: global state: 37178575-308f-11e5-a8b2-6af2fcef5c43:1397290, view# 24: Primary, number of nodes: 2, my index: 0, protocol version 3
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: REPL Protocols: 7 (3, 2)
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: Service thread queue flushed.
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: Assign initial position for certification: 1397290, protocol version: 3
Mar 15 09:26:33 avc2-wus1-db08 mysqld: 160315 9:26:33 [Note] WSREP: Service thread queue flushed.
Mar 15 09:26:38 avc2-wus1-db08 mysqld: 160315 9:26:38 [Note] WSREP: cleaning up 9f75855a (tcp://10.150.28.26:4567)
The bin logs are actually located in /var/log/mysql/
How do I get xtrabackup to look there instead?