failed to freezer-agent restore data with --consistency-checksum

Bug #1648668 reported by Shangzhong Zhu
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
OpenStack Backup/Restore and DR (Freezer)
In Progress
Undecided
Shangzhong Zhu

Bug Description

Bug Description:
1. Backup data with --consistency-check
zhusz@ubuntu:~/freezer$ freezer-agent --action backup --path-to-backup /home/zhusz/python-freezerclient/ --backup-name backup-test --storage local --container ~/backup20161209 --consistency-check
+----------------------+------------------------------------------------------------------+
| Property | Value |
+----------------------+------------------------------------------------------------------+
| ssh port | 22 |
| consistency checksum | 7abe0deed85ac578f977e5257dca3bf0373da22af944c4d65e279c571aca78df |
| curr backup level | 0 |
| backup name | backup-test |
| container | /home/zhusz/backup20161209 |
| compression | gzip |
| dry run | |
| hostname | ubuntu |
| storage | local |
| vol snap path | /home/zhusz/python-freezerclient/ |
| os auth version | |
| client os | linux2 |
| time stamp | 1481246470 |
| container segments | |
| ssh username | |
| path to backup | /home/zhusz/python-freezerclient/ |
| ssh key | |
| proxy | |
| always level | |
| max level | |
| backup media | fs |
| ssh host | |
| mode | fs |
| fs real path | /home/zhusz/python-freezerclient/ |
| action | backup |
| client version | 3.0.0 |
| log file | /home/zhusz/.freezer/freezer.log |
+----------------------+------------------------------------------------------------------+
2. Restore data with --consistency-checksum
zhusz@ubuntu:~/freezer$ freezer-agent --action restore --restore-abs-path /home/zhusz/restore20161209-1 --backup-name backup-test --storage local --container ~/backup20161209 --consistency-checksum 7abe0deed85ac578f977e5257dca3bf0373da22af944c4d65e279c571aca78df
Critical Error: Backup Consistency Check failed: backup checksum (7abe0deed85ac578f977e5257dca3bf0373da22af944c4d65e279c571aca78df) and restore checksum (5e9cac558eb54a323adb9860f1855fc3792373cfede54e4b2f42a8f275ca8ca7) did not match.

Logs:
2016-12-09 09:21:09.879 8409 INFO freezer.main [-] Begin freezer agent process with args: ['/usr/local/bin/freezer-agent', '--action', 'backup', '--path-to-backup', '/home/zhusz/python-freezerclient/', '--backup-name', 'backup-test', '--storage', 'local', '--container', '/home/zhusz/backup20161209', '--consistency-check']
2016-12-09 09:21:09.879 8409 INFO freezer.main [-] log file at /home/zhusz/.freezer/freezer.log
2016-12-09 09:21:09.958 8409 INFO freezer.job [-] Validating args for the backup job.
2016-12-09 09:21:09.958 8409 INFO freezer.main [-] Job execution Started at: 2016-12-09 09:21:09
2016-12-09 09:21:09.958 8409 INFO freezer.job [-] Backup job started. backup_name: backup-test, container: /home/zhusz/backup20161209, hostname: ubuntu, mode: fs, Storage: local, compression: gzip
2016-12-09 09:21:09.959 8409 INFO freezer.job [-] Executing sync to flush the file system buffer.
2016-12-09 09:21:10.089 8409 INFO freezer.job [-] Path to backup: /home/zhusz/python-freezerclient/
2016-12-09 09:21:40.082 8409 INFO freezer.job [-] Computed checksum for consistency 7abe0deed85ac578f977e5257dca3bf0373da22af944c4d65e279c571aca78df
2016-12-09 09:21:40.084 8409 INFO freezer.engine.tar.tar [-] Starting Tar engine backup stream
2016-12-09 09:21:40.085 8409 INFO freezer.engine.tar.tar [-] Execution command:
/usr/local/bin/tar --create -z --warning=none --no-check-device --one-file-system --preserve-permissions --same-owner --seek --ignore-failed-read --listed-incremental=/tmp/tmpQYqh48/engine_meta .
2016-12-09 09:21:47.578 8409 INFO freezer.engine.tar.tar [-] Tar engine stream completed
2016-12-09 09:21:47.622 8409 INFO freezer.main [-] Job execution Finished, at: 2016-12-09 09:21:47
2016-12-09 09:21:47.622 8409 INFO freezer.main [-] Job time Elapsed: 0:00:37.663777
2016-12-09 09:21:47.623 8409 INFO freezer.main [-] Backup metadata received: {"ssh_port": 22, "consistency_checksum": "7abe0deed85ac578f977e5257dca3bf0373da22af944c4d65e279c571aca78df", "curr_backup_level": 0, "backup_name": "backup-test", "container": "/home/zhusz/backup20161209", "compression": "gzip", "dry_run": "", "hostname": "ubuntu", "storage": "local", "vol_snap_path": "/home/zhusz/python-freezerclient/", "os_auth_version": "", "client_os": "linux2", "time_stamp": 1481246470, "container_segments": "", "ssh_username": "", "path_to_backup": "/home/zhusz/python-freezerclient/", "ssh_key": "", "proxy": "", "always_level": "", "max_level": "", "backup_media": "fs", "ssh_host": "", "mode": "fs", "fs_real_path": "/home/zhusz/python-freezerclient/", "action": "backup", "client_version": "3.0.0", "log_file": "/home/zhusz/.freezer/freezer.log"}
2016-12-09 09:21:47.623 8409 INFO freezer.main [-] End freezer agent process successfully
2016-12-09 09:24:36.623 8492 INFO freezer.main [-] Begin freezer agent process with args: ['/usr/local/bin/freezer-agent', '--action', 'restore', '--restore-abs-path', '/home/zhusz/restore20161209-1', '--backup-name', 'backup-test', '--storage', 'local', '--container', '/home/zhusz/backup20161209', '--consistency-checksum', '7abe0deed85ac578f977e5257dca3bf0373da22af944c4d65e279c571aca78df']

2016-12-09 09:24:36.623 8492 INFO freezer.main [-] log file at /home/zhusz/.freezer/freezer.log
2016-12-09 09:24:36.627 8492 INFO freezer.job [-] Validating args for the restore job.
2016-12-09 09:24:36.627 8492 INFO freezer.main [-] Job execution Started at: 2016-12-09 09:24:36
2016-12-09 09:24:36.627 8492 INFO freezer.job [-] Executing FS restore...
2016-12-09 09:24:36.627 8492 INFO freezer.engine.engine [-] Creating restore path: /home/zhusz/restore20161209-1
2016-12-09 09:24:36.628 8492 INFO freezer.engine.engine [-] Restore path creation completed
2016-12-09 09:24:36.646 8492 INFO freezer.engine.engine [-] Restoring backup ubuntu_backup-test
2016-12-09 09:24:36.658 8498 INFO freezer.storage.base [-] metadata content download ['{"encryption": false, "compression": "gzip", "engine_name": "tar"}']
2016-12-09 09:24:38.345 8498 INFO freezer.engine.tar.tar [-] Pipe closed as EOF reached. Data transmitted successfully
2016-12-09 09:24:38.359 8492 INFO freezer.engine.engine [-] Restore completed successfully for backup name ubuntu_backup-test
2016-12-09 09:24:38.699 8492 ERROR freezer.main [-] Backup Consistency Check failed: backup checksum (7abe0deed85ac578f977e5257dca3bf0373da22af944c4d65e279c571aca78df) and restore checksum (5e9cac558eb54a323adb9860f1855fc3792373cfede54e4b2f42a8f275ca8ca7) did not match.
2016-12-09 09:24:38.699 8492 ERROR freezer.main Traceback (most recent call last):
2016-12-09 09:24:38.699 8492 ERROR freezer.main File "/usr/local/lib/python2.7/dist-packages/freezer/main.py", line 227, in main
2016-12-09 09:24:38.699 8492 ERROR freezer.main freezer_main(backup_args)
2016-12-09 09:24:38.699 8492 ERROR freezer.main File "/usr/local/lib/python2.7/dist-packages/freezer/main.py", line 111, in freezer_main
2016-12-09 09:24:38.699 8492 ERROR freezer.main return run_job(backup_args, storage)
2016-12-09 09:24:38.699 8492 ERROR freezer.main File "/usr/local/lib/python2.7/dist-packages/freezer/main.py", line 124, in run_job
2016-12-09 09:24:38.699 8492 ERROR freezer.main response = freezer_job.execute()
2016-12-09 09:24:38.699 8492 ERROR freezer.main File "/usr/local/lib/python2.7/dist-packages/freezer/job.py", line 286, in execute
2016-12-09 09:24:38.699 8492 ERROR freezer.main format(backup_checksum, restore_checksum.checksum))
2016-12-09 09:24:38.699 8492 ERROR freezer.main ConsistencyCheckException: Backup Consistency Check failed: backup checksum (7abe0deed85ac578f977e5257dca3bf0373da22af944c4d65e279c571aca78df) and restore checksum (5e9cac558eb54a323adb9860f1855fc3792373cfede54e4b2f42a8f275ca8ca7) did not match.
2016-12-09 09:24:38.699 8492 ERROR freezer.main
2016-12-09 09:24:38.699 8492 CRITICAL freezer.main [-] End freezer agent process unsuccessfully
2016-12-09 09:24:38.700 8492 CRITICAL freezer.main [-] Critical Error: Backup Consistency Check failed: backup checksum (7abe0deed85ac578f977e5257dca3bf0373da22af944c4d65e279c571aca78df) and restore checksum (5e9cac558eb54a323adb9860f1855fc3792373cfede54e4b2f42a8f275ca8ca7) did not match.

Shangzhong Zhu (zhusz)
Changed in freezer:
assignee: nobody → Shangzhong Zhu (zhusz)
status: New → In Progress
To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.