Hi,
I have been using duplicati for close to a year now.
My storage is on B2 and currently I am consuming 1.51 TB.
My backup runs daily and for the last year I have a maximum of 4 GB download a month. And I never have to retrieve.
Since Jan 14 - I noticed duplicati exceeded the quota of 11 GB a day. Today I monitored it and I noticed that it is stuck on “Deleting unwanted files” and even 14 GB were not enough.
Can you please advice what can I do? B2 charges on download. The behavior is extremely odd to me.
It is worth it to mention that I don’t put that much data at once. Rarely it happens.
For example -
Jan 12
Source Files Examined 123310 (1.51 TB) Opened 16 (23.99 MB) Added 10 (3.51 MB) Modified 6 (20.48 MB) Deleted 1
Jan 13
Source Files Examined 123312 (1.51 TB) Opened 14 (22.87 MB) Added 8 (1.59 MB) Modified 6 (21.28 MB) Deleted 6
Then Jan 14 - it error because it exceed the quota
Jan 15 - first attempt (it did ask me to repair)
{
"MainOperation": "Repair",
"RecreateDatabaseResults": null,
"ParsedResult": "Success",
"Version": "2.0.6.3 (2.0.6.3_beta_2021-06-17)",
"EndTime": "2023-01-15T20:23:08.578005Z",
"BeginTime": "2023-01-15T20:22:08.667371Z",
"Duration": "00:00:59.9106340",
"MessagesActualLength": 11,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": [
"2023-01-15 12:22:08 -08 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Repair has started",
"2023-01-15 12:22:12 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: ()",
"2023-01-15 12:23:04 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed: (67.04 KB)",
"2023-01-15 12:23:07 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-ib7a46085ec8a4765a32c63371531da2a.dindex.zip.aes (541 bytes)",
"2023-01-15 12:23:08 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-ib7a46085ec8a4765a32c63371531da2a.dindex.zip.aes (541 bytes)",
"2023-01-15 12:23:08 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-i991c65d456da4fee990a6cdc4f1aa419.dindex.zip.aes (541 bytes)",
"2023-01-15 12:23:08 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-i991c65d456da4fee990a6cdc4f1aa419.dindex.zip.aes (541 bytes)",
"2023-01-15 12:23:08 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-i2cf41c18ed2c47edbf97485199346a7d.dindex.zip.aes (541 bytes)",
"2023-01-15 12:23:08 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-i2cf41c18ed2c47edbf97485199346a7d.dindex.zip.aes (541 bytes)",
"2023-01-15 12:23:08 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-id1286e5e2e1446f69b4623bbeaea938c.dindex.zip.aes (541 bytes)",
"2023-01-15 12:23:08 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-id1286e5e2e1446f69b4623bbeaea938c.dindex.zip.aes (541 bytes)"
],
"Warnings": [],
"Errors": [],
"BackendStatistics": {
"RemoteCalls": 5,
"BytesUploaded": 2164,
"BytesDownloaded": 0,
"FilesUploaded": 4,
"FilesDownloaded": 0,
"FilesDeleted": 0,
"FoldersCreated": 0,
"RetryAttempts": 0,
"UnknownFileSize": 0,
"UnknownFileCount": 0,
"KnownFileCount": 68652,
"KnownFileSize": 1795695727036,
"LastBackupDate": "2023-01-14T12:00:04-08:00",
"BackupListCount": 14,
"TotalQuotaSpace": 0,
"FreeQuotaSpace": 0,
"AssignedQuotaSpace": -1,
"ReportedQuotaError": false,
"ReportedQuotaWarning": false,
"MainOperation": "Repair",
"ParsedResult": "Success",
"Version": "2.0.6.3 (2.0.6.3_beta_2021-06-17)",
"EndTime": "0001-01-01T00:00:00",
"BeginTime": "2023-01-15T20:22:08.66739Z",
"Duration": "00:00:00",
"MessagesActualLength": 0,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": null,
"Warnings": null,
"Errors": null
}
}
Jan 15 - second attempt (I did manually cancel this one when it approached 14 GB download - after completing the current file)
{
"DeletedFiles": 57,
"DeletedFolders": 0,
"ModifiedFiles": 8,
"ExaminedFiles": 123338,
"OpenedFiles": 79,
"AddedFiles": 71,
"SizeOfModifiedFiles": 9942387,
"SizeOfAddedFiles": 136432020,
"SizeOfExaminedFiles": 1661731240758,
"SizeOfOpenedFiles": 146374407,
"NotProcessedFiles": 0,
"AddedFolders": 0,
"TooLargeFiles": 0,
"FilesWithError": 0,
"ModifiedFolders": 0,
"ModifiedSymlinks": 0,
"AddedSymlinks": 0,
"DeletedSymlinks": 0,
"PartialBackup": false,
"Dryrun": false,
"MainOperation": "Backup",
"CompactResults": {
"DeletedFileCount": 0,
"DownloadedFileCount": 0,
"UploadedFileCount": 0,
"DeletedFileSize": 0,
"DownloadedFileSize": 0,
"UploadedFileSize": 0,
"Dryrun": false,
"VacuumResults": null,
"MainOperation": "Compact",
"ParsedResult": "Success",
"Version": "2.0.6.3 (2.0.6.3_beta_2021-06-17)",
"EndTime": "0001-01-01T00:00:00",
"BeginTime": "2023-01-15T20:41:15.209857Z",
"Duration": "00:00:00",
"MessagesActualLength": 0,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": null,
"Warnings": null,
"Errors": null,
"BackendStatistics": {
"RemoteCalls": 993,
"BytesUploaded": 4120731731,
"BytesDownloaded": 14612072859,
"FilesUploaded": 159,
"FilesDownloaded": 279,
"FilesDeleted": 553,
"FoldersCreated": 0,
"RetryAttempts": 0,
"UnknownFileSize": 0,
"UnknownFileCount": 0,
"KnownFileCount": 68262,
"KnownFileSize": 1785338349950,
"LastBackupDate": "2023-01-15T12:23:50-08:00",
"BackupListCount": 14,
"TotalQuotaSpace": 0,
"FreeQuotaSpace": 0,
"AssignedQuotaSpace": -1,
"ReportedQuotaError": false,
"ReportedQuotaWarning": false,
"MainOperation": "Backup",
"ParsedResult": "Success",
"Version": "2.0.6.3 (2.0.6.3_beta_2021-06-17)",
"EndTime": "0001-01-01T00:00:00",
"BeginTime": "2023-01-15T20:23:50.094811Z",
"Duration": "00:00:00",
"MessagesActualLength": 0,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": null,
"Warnings": null,
"Errors": null
}
},
"VacuumResults": null,
"DeleteResults": {
"DeletedSetsActualLength": 1,
"DeletedSets": [
{
"Item1": 7,
"Item2": "2023-01-08T12:00:04-08:00"
}
],
"Dryrun": false,
"MainOperation": "Delete",
"CompactResults": {
"DeletedFileCount": 0,
"DownloadedFileCount": 0,
"UploadedFileCount": 0,
"DeletedFileSize": 0,
"DownloadedFileSize": 0,
"UploadedFileSize": 0,
"Dryrun": false,
"VacuumResults": null,
"MainOperation": "Compact",
"ParsedResult": "Success",
"Version": "2.0.6.3 (2.0.6.3_beta_2021-06-17)",
"EndTime": "0001-01-01T00:00:00",
"BeginTime": "2023-01-15T20:41:15.209857Z",
"Duration": "00:00:00",
"MessagesActualLength": 0,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": null,
"Warnings": null,
"Errors": null,
"BackendStatistics": {
"RemoteCalls": 993,
"BytesUploaded": 4120731731,
"BytesDownloaded": 14612072859,
"FilesUploaded": 159,
"FilesDownloaded": 279,
"FilesDeleted": 553,
"FoldersCreated": 0,
"RetryAttempts": 0,
"UnknownFileSize": 0,
"UnknownFileCount": 0,
"KnownFileCount": 68262,
"KnownFileSize": 1785338349950,
"LastBackupDate": "2023-01-15T12:23:50-08:00",
"BackupListCount": 14,
"TotalQuotaSpace": 0,
"FreeQuotaSpace": 0,
"AssignedQuotaSpace": -1,
"ReportedQuotaError": false,
"ReportedQuotaWarning": false,
"MainOperation": "Backup",
"ParsedResult": "Success",
"Version": "2.0.6.3 (2.0.6.3_beta_2021-06-17)",
"EndTime": "0001-01-01T00:00:00",
"BeginTime": "2023-01-15T20:23:50.094811Z",
"Duration": "00:00:00",
"MessagesActualLength": 0,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": null,
"Warnings": null,
"Errors": null
}
},
"ParsedResult": "Success",
"Version": "2.0.6.3 (2.0.6.3_beta_2021-06-17)",
"EndTime": "2023-01-15T21:20:32.210895Z",
"BeginTime": "2023-01-15T20:39:56.457404Z",
"Duration": "00:40:35.7534910",
"MessagesActualLength": 0,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": null,
"Warnings": null,
"Errors": null,
"BackendStatistics": {
"RemoteCalls": 993,
"BytesUploaded": 4120731731,
"BytesDownloaded": 14612072859,
"FilesUploaded": 159,
"FilesDownloaded": 279,
"FilesDeleted": 553,
"FoldersCreated": 0,
"RetryAttempts": 0,
"UnknownFileSize": 0,
"UnknownFileCount": 0,
"KnownFileCount": 68262,
"KnownFileSize": 1785338349950,
"LastBackupDate": "2023-01-15T12:23:50-08:00",
"BackupListCount": 14,
"TotalQuotaSpace": 0,
"FreeQuotaSpace": 0,
"AssignedQuotaSpace": -1,
"ReportedQuotaError": false,
"ReportedQuotaWarning": false,
"MainOperation": "Backup",
"ParsedResult": "Success",
"Version": "2.0.6.3 (2.0.6.3_beta_2021-06-17)",
"EndTime": "0001-01-01T00:00:00",
"BeginTime": "2023-01-15T20:23:50.094811Z",
"Duration": "00:00:00",
"MessagesActualLength": 0,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": null,
"Warnings": null,
"Errors": null
}
},
"RepairResults": null,
"TestResults": {
"MainOperation": "Test",
"VerificationsActualLength": 0,
"Verifications": [],
"ParsedResult": "Success",
"Version": "2.0.6.3 (2.0.6.3_beta_2021-06-17)",
"EndTime": "2023-01-15T21:21:23.633617Z",
"BeginTime": "2023-01-15T21:21:22.407419Z",
"Duration": "00:00:01.2261980",
"MessagesActualLength": 0,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": null,
"Warnings": null,
"Errors": null,
"BackendStatistics": {
"RemoteCalls": 993,
"BytesUploaded": 4120731731,
"BytesDownloaded": 14612072859,
"FilesUploaded": 159,
"FilesDownloaded": 279,
"FilesDeleted": 553,
"FoldersCreated": 0,
"RetryAttempts": 0,
"UnknownFileSize": 0,
"UnknownFileCount": 0,
"KnownFileCount": 68262,
"KnownFileSize": 1785338349950,
"LastBackupDate": "2023-01-15T12:23:50-08:00",
"BackupListCount": 14,
"TotalQuotaSpace": 0,
"FreeQuotaSpace": 0,
"AssignedQuotaSpace": -1,
"ReportedQuotaError": false,
"ReportedQuotaWarning": false,
"MainOperation": "Backup",
"ParsedResult": "Success",
"Version": "2.0.6.3 (2.0.6.3_beta_2021-06-17)",
"EndTime": "0001-01-01T00:00:00",
"BeginTime": "2023-01-15T20:23:50.094811Z",
"Duration": "00:00:00",
"MessagesActualLength": 0,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": null,
"Warnings": null,
"Errors": null
}
},
"ParsedResult": "Success",
"Version": "2.0.6.3 (2.0.6.3_beta_2021-06-17)",
"EndTime": "2023-01-15T21:21:23.634128Z",
"BeginTime": "2023-01-15T20:23:50.094805Z",
"Duration": "00:57:33.5393230",
"MessagesActualLength": 1997,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": [
"2023-01-15 12:23:50 -08 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started",
"2023-01-15 12:25:05 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: ()",
"2023-01-15 12:25:52 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed: (67.05 KB)",
"2023-01-15 12:36:50 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b8ccdf5342e6b4796ad3eed433270ad5c.dblock.zip.aes (49.91 MB)",
"2023-01-15 12:36:58 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-beb928e3c734f43e89e25f1ad4a6ee354.dblock.zip.aes (49.93 MB)",
"2023-01-15 12:37:10 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-bfd63a78f93e04350b78ab62bcd335305.dblock.zip.aes (11.03 MB)",
"2023-01-15 12:37:37 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-b8ccdf5342e6b4796ad3eed433270ad5c.dblock.zip.aes (49.91 MB)",
"2023-01-15 12:37:37 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-iade99aff69914c308f74907ea5698625.dindex.zip.aes (52.31 KB)",
"2023-01-15 12:37:37 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-iade99aff69914c308f74907ea5698625.dindex.zip.aes (52.31 KB)",
"2023-01-15 12:37:51 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-beb928e3c734f43e89e25f1ad4a6ee354.dblock.zip.aes (49.93 MB)",
"2023-01-15 12:37:51 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-ie70c4272c2c9403d859b756f5d1de0ee.dindex.zip.aes (70.59 KB)",
"2023-01-15 12:37:51 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-ie70c4272c2c9403d859b756f5d1de0ee.dindex.zip.aes (70.59 KB)",
"2023-01-15 12:38:01 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-bfd63a78f93e04350b78ab62bcd335305.dblock.zip.aes (11.03 MB)",
"2023-01-15 12:38:01 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-i46dc54c9de29446597beff39150d687c.dindex.zip.aes (18.61 KB)",
"2023-01-15 12:38:02 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-i46dc54c9de29446597beff39150d687c.dindex.zip.aes (18.61 KB)",
"2023-01-15 12:38:02 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-20230115T202350Z.dlist.zip.aes (12.57 MB)",
"2023-01-15 12:39:56 -08 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-20230115T202350Z.dlist.zip.aes (12.57 MB)",
"2023-01-15 12:39:56 -08 - [Information-Duplicati.Library.Main.Operation.DeleteHandler:RetentionPolicy-StartCheck]: Start checking if backups can be removed",
"2023-01-15 12:39:56 -08 - [Information-Duplicati.Library.Main.Operation.DeleteHandler:RetentionPolicy-FramesAndIntervals]: Time frames and intervals pairs: 7.00:00:00 / Keep all, 28.00:00:00 / 7.00:00:00, 181.00:00:00 / 31.00:00:00",
"2023-01-15 12:39:56 -08 - [Information-Duplicati.Library.Main.Operation.DeleteHandler:RetentionPolicy-BackupList]: Backups to consider: 1/14/2023 12:00:04 PM, 1/13/2023 12:00:04 PM, 1/12/2023 12:00:04 PM, 1/11/2023 12:00:04 PM, 1/10/2023 12:00:04 PM, 1/9/2023 12:00:04 PM, 1/8/2023 12:00:04 PM, 1/4/2023 12:00:04 PM, 12/28/2022 12:00:04 PM, 12/20/2022 3:00:02 PM, 11/29/2022 12:00:04 PM, 10/24/2022 1:00:04 PM, 9/19/2022 1:00:04 PM, 8/16/2022 1:00:04 PM"
],
"Warnings": [],
"Errors": [],
"BackendStatistics": {
"RemoteCalls": 993,
"BytesUploaded": 4120731731,
"BytesDownloaded": 14612072859,
"FilesUploaded": 159,
"FilesDownloaded": 279,
"FilesDeleted": 553,
"FoldersCreated": 0,
"RetryAttempts": 0,
"UnknownFileSize": 0,
"UnknownFileCount": 0,
"KnownFileCount": 68262,
"KnownFileSize": 1785338349950,
"LastBackupDate": "2023-01-15T12:23:50-08:00",
"BackupListCount": 14,
"TotalQuotaSpace": 0,
"FreeQuotaSpace": 0,
"AssignedQuotaSpace": -1,
"ReportedQuotaError": false,
"ReportedQuotaWarning": false,
"MainOperation": "Backup",
"ParsedResult": "Success",
"Version": "2.0.6.3 (2.0.6.3_beta_2021-06-17)",
"EndTime": "0001-01-01T00:00:00",
"BeginTime": "2023-01-15T20:23:50.094811Z",
"Duration": "00:00:00",
"MessagesActualLength": 0,
"WarningsActualLength": 0,
"ErrorsActualLength": 0,
"Messages": null,
"Warnings": null,
"Errors": null
}
}
Since then - I had to disable automatic backup. During the last (second attempt on Jan 15) - duplicati downloaded 15 GB worth of data.
This is very surprising as it only put about 130 MB.
Source Files Examined 123338 (1.51 TB) Opened 79 (139.59 MB) Added 71 (130.11 MB) Modified 8 (9.48 MB) Deleted 57
The longest retention for my backup is 6 months. In the past the backup had to delete about 200 GB worth of data but it was never associated with such an excessive amount of download.
Thank you in advance!