I have Duplicati backing up to B2 Cloud Storage and in the past have needed to restore without issue. Today I had an emergency and needed to restore only to get the error -
2019-04-09 14:34:11 +02 - [Error-Duplicati.Library.Main.Operation.RestoreHandler-PatchingFailed]: Failed to patch with remote file: “duplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes”, message: Failed to decrypt data (invalid passphrase?): Invalid password or corrupted data
Connection test is fine. Verify Files is fine, even Delete and Repair and another restore was the same.
This got me worried so I went to my 2 other servers running duplicati and tried restoring a test file from them and to my horror I got the same result. It looks like I currently dont have a single working backup.
2 servers are running 2.0.4.15_canary_2019-02-06 and one is 2.0.4.16_canary_2019-03-28 - same result on all 3.
As i said, in the past (maybe 2 months ago) I restored without issue.
Any pointers? I need to have a backup of these servers that I can rely on.
Full log from latest restore attempt of an arbitary file:-
{
"RestoredFiles": 0,
"SizeOfRestoredFiles": 0,
"RestoredFolders": 0,
"RestoredSymlinks": 0,
"PatchedFiles": 0,
"DeletedFiles": 0,
"DeletedFolders": 0,
"DeletedSymlinks": 0,
"MainOperation": "Restore",
"RecreateDatabaseResults": null,
"ParsedResult": "Error",
"Version": "2.0.4.16 (2.0.4.16_canary_2019-03-28)",
"EndTime": "2019-04-09T13:16:34.155921Z",
"BeginTime": "2019-04-09T13:15:00.324607Z",
"Duration": "00:01:33.8313140",
"MessagesActualLength": 16,
"WarningsActualLength": 0,
"ErrorsActualLength": 2,
"Messages": [
"2019-04-09 15:15:00 +02 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Restore has started",
"2019-04-09 15:15:00 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: ()",
"2019-04-09 15:15:02 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed: (4 bytes)",
"2019-04-09 15:15:02 +02 - [Information-Duplicati.Library.Main.Database.LocalRestoreDatabase-SearchingBackup]: Searching backup 0 (4/9/2019 12:30:25 PM) ...",
"2019-04-09 15:15:02 +02 - [Information-Duplicati.Library.Main.Operation.RestoreHandler-RemoteFileCount]: 1 remote files are required to restore",
"2019-04-09 15:15:02 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes (99.92 MB)",
"2019-04-09 15:15:11 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Retrying: duplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes (99.92 MB)",
"2019-04-09 15:15:21 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes (99.92 MB)",
"2019-04-09 15:15:32 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Retrying: duplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes (99.92 MB)",
"2019-04-09 15:15:42 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes (99.92 MB)",
"2019-04-09 15:15:52 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Retrying: duplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes (99.92 MB)",
"2019-04-09 15:16:02 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes (99.92 MB)",
"2019-04-09 15:16:13 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Retrying: duplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes (99.92 MB)",
"2019-04-09 15:16:23 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes (99.92 MB)",
"2019-04-09 15:16:34 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Failed: duplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes (99.92 MB)",
"2019-04-09 15:16:34 +02 - [Information-Duplicati.Library.Main.Operation.RestoreHandler-RestoreFailures]: Failed to restore 1 files, additionally the following files failed to download, which may be the cause:\nduplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes"
],
"Warnings": [],
"Errors": [
"2019-04-09 15:16:34 +02 - [Error-Duplicati.Library.Main.Operation.RestoreHandler-PatchingFailed]: Failed to patch with remote file: \"duplicati-b4f95c396a5e443738ebc57d761a95047.dblock.zip.aes\", message: Failed to decrypt data (invalid passphrase?): Invalid password or corrupted data",
"2019-04-09 15:16:34 +02 - [Error-Duplicati.Library.Main.Operation.RestoreHandler-RestoreFileFailed]: Could not find file \"/home/runcloud/webapps/vovi/license.txt\"."
],
"BackendStatistics": {
"RemoteCalls": 6,
"BytesUploaded": 0,
"BytesDownloaded": 0,
"FilesUploaded": 0,
"FilesDownloaded": 0,
"FilesDeleted": 0,
"FoldersCreated": 0,
"RetryAttempts": 4,
"UnknownFileSize": 0,
"UnknownFileCount": 0,
"KnownFileCount": 4,
"KnownFileSize": 125254020,
"LastBackupDate": "2019-04-09T14:30:25+02:00",
"BackupListCount": 1,
"TotalQuotaSpace": 0,
"FreeQuotaSpace": 0,
"AssignedQuotaSpace": -1,
"ReportedQuotaError": false,
"ReportedQuotaWarning": false,
"MainOperation": "Restore",
"ParsedResult": "Success",
"Version": "2.0.4.16 (2.0.4.16_canary_2019-03-28)",
"EndTime": "0001-01-01T00:00:00",
"BeginTime": "2019-04-09T13:15:00.324615Z",
"Duration": "00:00:00",
"MessagesActualLength": 0,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": null,
"Warnings": null,
"Errors": null
}
}