PDA

View Full Version : copy-plugin exited with error 512 at the end of copying



andreas.kurz@linbit.com
January 21st, 2009, 12:34 AM
Hello!

I am running a snapshot based remote backup of two MySQL servers but on one server the copy process terminates with error 512 at the very end of copying all the data ... I already found some other threads with quite similar problems but not exactly the same as here.

I already read about problems when the uid and gid is not the same on the backup and the remote server but why is the backup of one server successful? ... and I see all the data being copied for the second server

The output of a failed run ... I terminated the run manually after the failed copy from the snapshot:

mysql-zrm-scheduler --now --backup-set ema2db --backup-level 0

schedule:INFO: ZRM for MySQL Community Edition - version 2.1
Logging to /var/log/mysql-zrm/mysql-zrm-scheduler.log
backup:INFO: ZRM for MySQL Community Edition - version 2.1
ema2db:backup:INFO: START OF BACKUP
ema2db:backup:INFO: PHASE START: Initialization
ema2db:backup:INFO: Mail address: root@localhost is ok
ema2db:backup:INFO: ZRM Temporary configuration file = /etc/mysql-zrm/ema2db/tmp02SHG.conf
ema2db:backup:INFO: {
ema2db:backup:INFO: verbose=1
ema2db:backup:INFO: retention-policy=17D
ema2db:backup:INFO: tmpdir=/tmp
ema2db:backup:INFO: destination=/var/lib/mysql-zrm
ema2db:backup:INFO: socket-remote-port=25300
ema2db:backup:INFO: password=******
ema2db:backup:INFO: backup-mode=raw
ema2db:backup:INFO: snapshot-plugin=/usr/share/mysql-zrm/plugins/drbd-snapshot.pl
ema2db:backup:INFO: backup-type=regular
ema2db:backup:INFO: compress-plugin=/usr/local/bin/pigz
ema2db:backup:INFO: user=zrmbackup
ema2db:backup:INFO: copy-plugin=/usr/share/mysql-zrm/plugins/pigz-socket-copy.pl
ema2db:backup:INFO: backup-level=0
ema2db:backup:INFO: quiet=0
ema2db:backup:INFO: mailto=root@localhost
ema2db:backup:INFO: host=ema2db
ema2db:backup:INFO: snapshot-size=35g
ema2db:backup:INFO: compress=/usr/local/bin/pigz
ema2db:backup:INFO: mysql-binlog-path=/mnt/ha0/binlogs
ema2db:backup:INFO: }
ema2db:backup:INFO: Getting mysql variables
ema2db:backup:INFO: mysqladmin --user="zrmbackup" --password="*****" --host="ema2db" variables
ema2db:backup:INFO: datadir is /var/lib/mysql/
ema2db:backup:INFO: mysql_version is 5.0.51a-9-log
ema2db:backup:INFO: InnoDB data file are /var/lib/mysql/ibdata1
ema2db:backup:INFO: InnoDB log dir is /var/lib/mysql
ema2db:backup:INFO: backup set being used is ema2db
ema2db:backup:INFO: backup-set=ema2db
ema2db:backup:INFO: backup-date=20090120181438
ema2db:backup:INFO: mysql-server-os=Linux/Unix
ema2db:backup:INFO: backup-type=regular
ema2db:backup:INFO: host=ema2db
ema2db:backup:INFO: backup-date-epoch=1232471678
ema2db:backup:INFO: retention-policy=17D
ema2db:backup:INFO: mysql-zrm-version=ZRM for MySQL Community Edition - version 2.1
ema2db:backup:INFO: mysql-version=5.0.51a-9-log
ema2db:backup:INFO: backup-directory=/var/lib/mysql-zrm/ema2db/20090120181438
ema2db:backup:INFO: backup-level=0
ema2db:backup:INFO: backup-mode=raw
ema2db:backup:INFO: PHASE END: Initialization
ema2db:backup:INFO: PHASE START: Running pre backup plugin
ema2db:backup:INFO: Executing pre-backup-plugin
ema2db:backup:INFO: PHASE END: Running pre backup plugin
ema2db:backup:INFO: PHASE START: Flushing logs
ema2db:backup:INFO: Flushing the logs
ema2db:backup:INFO: mysqladmin --user="zrmbackup" --password="*****" --host="ema2db" flush-logs
ema2db:backup:INFO: Getting master logname using command mysql --user="zrmbackup" --password="*****" --host="ema2db" -e "show master status"
ema2db:backup:INFO: PHASE END: Flushing logs
ema2db:backup:INFO: Getting list of Databases
ema2db:backup:INFO: mysql --user="zrmbackup" --password="*****" --host="ema2db" -e "show databases;"
ema2db:backup:INFO: PHASE START: Creating snapshot based backup
ema2db:backup:INFO: innodb on lvm = 0
ema2db:backup:INFO: getting device details using command /usr/share/mysql-zrm/plugins/drbd-snapshot.pl --action get-vm-device-details --directory /var/lib/mysql --sname zrm7WCmxPXbA0 --host ema2db 2>/tmp/CPQpMKsgAp
ema2db:backup:INFO: getting device details using command /usr/share/mysql-zrm/plugins/drbd-snapshot.pl --action get-vm-device-details --directory /var/lib/mysql --sname zrm7bJT17Dj2G --host ema2db 2>/tmp/CPQpMKsgAp
ema2db:backup:INFO: getting device details using command /usr/share/mysql-zrm/plugins/drbd-snapshot.pl --action get-vm-device-details --directory "/var/lib/mysql//emarsys" --sname zrmx0JfnjIlFN --host ema2db 2>/tmp/CPQpMKsgAp
ema2db:backup:INFO: getting device details using command /usr/share/mysql-zrm/plugins/drbd-snapshot.pl --action get-vm-device-details --directory "/var/lib/mysql//mysql" --sname zrmUeMRIiiC1Q --host ema2db 2>/tmp/CPQpMKsgAp
ema2db:backup:INFO: Locking tables and creating snapshot
ema2db:backup:INFO: mysql --user="zrmbackup" --password="*****" --host="ema2db" -e "flush tables with read lock; flush logs; show master status;system (/usr/share/mysql-zrm/plugins/drbd-snapshot.pl --action create-snapshot --dev /dev/vg00-ema2db2/drbd0 --size 35g --sname zrm7WCmxPXbA0 --directory /var/lib/mysql-zrm/ema2db/20090120181438/ZRM_MOUNTS/zrm7WCmxPXbA0 --host ema2db >/tmp/zrm7WCmxPXbA0.log 2>&1 ); unlock tables;"
ema2db:backup:INFO: File Position Binlog_Do_DB Binlog_Ignore_DB
mysql-bin.000743 98
ema2db:backup:INFO: Output of command: 'Locking tables and creating snapshot' is {
Logical volume "zrm7WCmxPXbA0" created
}
ema2db:backup:INFO: Mounting snapshot
ema2db:backup:INFO: /usr/share/mysql-zrm/plugins/drbd-snapshot.pl --action mount --dev /dev/vg00-ema2db2/zrm7WCmxPXbA0 --directory /var/lib/mysql-zrm/ema2db/20090120181438/ZRM_MOUNTS/zrm7WCmxPXbA0 --fstype xfs --host ema2db

ema2db:backup:INFO: Start copying data from remote.
close of pipe failed
ema2db:backup:ERROR: Could not copy file /var/lib/mysql-zrm/ema2db/20090120181438/ZRM_LINKS/.
ema2db:backup:ERROR: copy-plugin exited with error 512
ema2db:backup:ERROR: Unable to copy from links
ema2db:backup:INFO: Unmounting
ema2db:backup:INFO: /usr/share/mysql-zrm/plugins/drbd-snapshot.pl --action umount --directory /var/lib/mysql-zrm/ema2db/20090120181438/ZRM_MOUNTS/zrm7WCmxPXbA0 --host ema2db
ema2db:backup:INFO: /usr/share/mysql-zrm/plugins/drbd-snapshot.pl --action remove-snapshot --host ema2db --dev "/dev/vg00-ema2db2/zrm7WCmxPXbA0" > /tmp/CPQpMKsgAp 2>&1
ema2db:backup:INFO: PHASE END: Creating snapshot based backup
ema2db:backup:INFO: PHASE START: Find table type
ema2db:backup:INFO: Command used for getting engine type mysql --user="zrmbackup" --password="*****" --host="ema2db" -e "show table status from \`emarsys\`"
ema2db:backup:ERROR: Process Aborted
ema2db:backup:INFO: PHASE START: Cleanup
ema2db:backup:INFO: backup-status=Backup failed
Terminated
[mysql@eubkp:/etc/mysql-zrm/emadb]$ ema2db:backup:INFO: Backup failed
ema2db:backup:INFO: mailing file /tmp/P6zTL2wVY0
ema2db:backup:INFO: mail command is cat "/tmp/P6zTL2wVY0"|mail -s "[ZRM for MySQL Report] ERROR during backup of backup-set ema2db" root@localhost
ema2db:backup:INFO: PHASE END: Cleanup
ema2db:backup:INFO: END OF BACKUP

Any hints?

Thanks & Kind Regards
Andreas Kurz

paddy
January 21st, 2009, 04:35 PM
ema2db:backup:INFO: copy-plugin=/usr/share/mysql-zrm/plugins/pigz-socket-copy.pl
ema2db:backup:INFO:



It appears you are using a custom plugin. Can you check if the plugin is returning an error?

Paddy