2 Backup warnings - what is the problem?

Support
1

Can anyone please tell me why there are 2 warnings from the log below? The backup result was a “Success”.

I had a custom retention rule of “2M:0s,6M:2D,1Y:1W” and changing that to 6 months (as a test) seems to have got rid of the warnings. Is the syntax wrong? I want to retain all version for 2 months; after that up to 6 months old, twice daily; and after a year 1 a week. Hmm - what about between 6 and 12 months - I don’t think I understand this correctly!

Thanks.

-------- Log --------

DeletedFiles: 0

DeletedFolders: 0

ModifiedFiles: 3

ExaminedFiles: 13002

OpenedFiles: 3

AddedFiles: 0

SizeOfModifiedFiles: 9768240

SizeOfAddedFiles: 0

SizeOfExaminedFiles: 8870480270

SizeOfOpenedFiles: 9768240

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

MainOperation: Compact

ParsedResult: Success

Version: 2.0.3.10 (2.0.3.10_canary_2018-08-30)

EndTime: 31/08/2018 13:20:49 (1535718049)

BeginTime: 31/08/2018 13:20:49 (1535718049)

Duration: 00:00:00.9403111

Messages: [

    2018-08-31 13:19:59 +01 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started,

    2018-08-31 13:20:01 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started:  (),

    2018-08-31 13:20:07 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed:  (297 bytes),

    2018-08-31 13:20:36 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b33dcd395c04f4205b13d32498aa42915.dblock.zip.aes (363.56 KB),

    2018-08-31 13:20:45 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-b33dcd395c04f4205b13d32498aa42915.dblock.zip.aes (363.56 KB),

…

]

Warnings: []

Errors: []

BackendStatistics:

    RemoteCalls: 8

    BytesUploaded: 1711511

    BytesDownloaded: 53807447

    FilesUploaded: 3

    FilesDownloaded: 3

    FilesDeleted: 0

    FoldersCreated: 0

    RetryAttempts: 0

    UnknownFileSize: 0

    UnknownFileCount: 0

    KnownFileCount: 300

    KnownFileSize: 6607826364

    LastBackupDate: 31/08/2018 13:19:59 (1535717999)

    BackupListCount: 20

    TotalQuotaSpace: 0

    FreeQuotaSpace: 0

    AssignedQuotaSpace: -1

    ReportedQuotaError: False

    ReportedQuotaWarning: False

    ParsedResult: Success

    Version: 2.0.3.10 (2.0.3.10_canary_2018-08-30)

    Messages: [

        2018-08-31 13:19:59 +01 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started,

        2018-08-31 13:20:01 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started:  (),

        2018-08-31 13:20:07 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed:  (297 bytes),

        2018-08-31 13:20:36 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b33dcd395c04f4205b13d32498aa42915.dblock.zip.aes (363.56 KB),

        2018-08-31 13:20:45 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-b33dcd395c04f4205b13d32498aa42915.dblock.zip.aes (363.56 KB),

…

    ]

    Warnings: []

    Errors: []

DeleteResults:

DeletedSets: []

Dryrun: False

MainOperation: Delete

ParsedResult: Success

Version: 2.0.3.10 (2.0.3.10_canary_2018-08-30)

EndTime: 31/08/2018 13:20:49 (1535718049)

BeginTime: 31/08/2018 13:20:48 (1535718048)

Duration: 00:00:01.4260033

Messages: [

    2018-08-31 13:19:59 +01 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started,

    2018-08-31 13:20:01 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started:  (),

    2018-08-31 13:20:07 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed:  (297 bytes),

    2018-08-31 13:20:36 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b33dcd395c04f4205b13d32498aa42915.dblock.zip.aes (363.56 KB),

    2018-08-31 13:20:45 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-b33dcd395c04f4205b13d32498aa42915.dblock.zip.aes (363.56 KB),

…

]

Warnings: []

Errors: []

RepairResults: null

TestResults:

MainOperation: Test

Verifications: [

    Key: duplicati-20180831T121959Z.dlist.zip.aes

    Value: [],

    Key: duplicati-i1478111cb05c4edaae9f79813809361c.dindex.zip.aes

    Value: [],

    Key: duplicati-b192b0c93a8204457bd2b5e892b96f11c.dblock.zip.aes

    Value: []

]

ParsedResult: Success

Version: 2.0.3.10 (2.0.3.10_canary_2018-08-30)

EndTime: 31/08/2018 13:21:24 (1535718084)

BeginTime: 31/08/2018 13:20:55 (1535718055)

Duration: 00:00:28.8070786

Messages: [

    2018-08-31 13:19:59 +01 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started,

    2018-08-31 13:20:01 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started:  (),

    2018-08-31 13:20:07 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed:  (297 bytes),

    2018-08-31 13:20:36 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b33dcd395c04f4205b13d32498aa42915.dblock.zip.aes (363.56 KB),

    2018-08-31 13:20:45 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-b33dcd395c04f4205b13d32498aa42915.dblock.zip.aes (363.56 KB),

…

]

Warnings: []

Errors: []

ParsedResult: Success

Version: 2.0.3.10 (2.0.3.10_canary_2018-08-30)

EndTime: 31/08/2018 13:21:24 (1535718084)

BeginTime: 31/08/2018 13:19:59 (1535717999)

Duration: 00:01:25.2163572

Messages: [

2018-08-31 13:19:59 +01 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started,

2018-08-31 13:20:01 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started:  (),

2018-08-31 13:20:07 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed:  (297 bytes),

2018-08-31 13:20:36 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b33dcd395c04f4205b13d32498aa42915.dblock.zip.aes (363.56 KB),

2018-08-31 13:20:45 +01 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-b33dcd395c04f4205b13d32498aa42915.dblock.zip.aes (363.56 KB),

…

]

Warnings:

Errors:

2

Same here, it traditionally loves to warn me and traditionally I start searching and now I don’t find anything. I use latest Canary, it reported an error, which I did not find.
This was reported as an error and I cannot tell if it did backup…:

DeletedFiles: 0 DeletedFolders: 0 ModifiedFiles: 0 ExaminedFiles: 2263 OpenedFiles: 0 AddedFiles: 0 SizeOfModifiedFiles: 0 SizeOfAddedFiles: 0 SizeOfExaminedFiles: 14805845485 SizeOfOpenedFiles: 0 NotProcessedFiles: 0 AddedFolders: 0 TooLargeFiles: 0 FilesWithError: 0 ModifiedFolders: 0 ModifiedSymlinks: 0 AddedSymlinks: 0 DeletedSymlinks: 0 PartialBackup: False Dryrun: False MainOperation: Backup CompactResults: null DeleteResults: DeletedSets: [] Dryrun: False MainOperation: Delete CompactResults: null ParsedResult: Success Version: 2.0.3.10 (2.0.3.10_canary_2018-08-30) EndTime: 31.08.2018 17:45:26 (1535730326) BeginTime: 31.08.2018 17:45:25 (1535730325) Duration: 00:00:00.7410424 Messages: [ 2018-08-31 17:45:10 +02 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started, 2018-08-31 17:45:13 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: (), 2018-08-31 17:45:23 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed: (131 bytes), 2018-08-31 17:45:25 +02 - [Information-Duplicati.Library.Main.Operation.DeleteHandler:RetentionPolicy-StartCheck]: Start checking if backups can be removed, 2018-08-31 17:45:25 +02 - [Information-Duplicati.Library.Main.Operation.DeleteHandler:RetentionPolicy-FramesAndIntervals]: Time frames and intervals pairs: 15.00:00:00 / 5.00:00:00, 59.00:00:00 / 14.00:00:00, 18262.00:00:00 / 730.00:00:00, ... ] Warnings: [] Errors: [] BackendStatistics: RemoteCalls: 5 BytesUploaded: 0 BytesDownloaded: 262547463 FilesUploaded: 0 FilesDownloaded: 3 FilesDeleted: 0 FoldersCreated: 0 RetryAttempts: 0 UnknownFileSize: 0 UnknownFileCount: 0 KnownFileCount: 131 KnownFileSize: 12357873671 LastBackupDate: 08.08.2018 18:21:14 (1533745274) BackupListCount: 3 TotalQuotaSpace: 169738235904 FreeQuotaSpace: 28730122240 AssignedQuotaSpace: -1 ReportedQuotaError: False ReportedQuotaWarning: False ParsedResult: Success Version: 2.0.3.10 (2.0.3.10_canary_2018-08-30) Messages: [ 2018-08-31 17:45:10 +02 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started, 2018-08-31 17:45:13 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: (), 2018-08-31 17:45:23 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed: (131 bytes), 2018-08-31 17:45:25 +02 - [Information-Duplicati.Library.Main.Operation.DeleteHandler:RetentionPolicy-StartCheck]: Start checking if backups can be removed, 2018-08-31 17:45:25 +02 - [Information-Duplicati.Library.Main.Operation.DeleteHandler:RetentionPolicy-FramesAndIntervals]: Time frames and intervals pairs: 15.00:00:00 / 5.00:00:00, 59.00:00:00 / 14.00:00:00, 18262.00:00:00 / 730.00:00:00, ... ] Warnings: [] Errors: [] RepairResults: null TestResults: MainOperation: Test Verifications: [ Key: duplicati-20180206T122710Z.dlist.zip.aes Value: [], Key: duplicati-ic98a20477b9348eeb749a0702f2479fa.dindex.zip.aes Value: [], Key: duplicati-bb86b9d96f18f4aeea22f2d1b36178f81.dblock.zip.aes Value: [] ] ParsedResult: Success Version: 2.0.3.10 (2.0.3.10_canary_2018-08-30) EndTime: 31.08.2018 17:45:28 (1535730328) BeginTime: 31.08.2018 17:45:26 (1535730326) Duration: 00:00:02.1021203 Messages: [ 2018-08-31 17:45:10 +02 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started, 2018-08-31 17:45:13 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: (), 2018-08-31 17:45:23 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed: (131 bytes), 2018-08-31 17:45:25 +02 - [Information-Duplicati.Library.Main.Operation.DeleteHandler:RetentionPolicy-StartCheck]: Start checking if backups can be removed, 2018-08-31 17:45:25 +02 - [Information-Duplicati.Library.Main.Operation.DeleteHandler:RetentionPolicy-FramesAndIntervals]: Time frames and intervals pairs: 15.00:00:00 / 5.00:00:00, 59.00:00:00 / 14.00:00:00, 18262.00:00:00 / 730.00:00:00, ... ] Warnings: [] Errors: [] ParsedResult: Success Version: 2.0.3.10 (2.0.3.10_canary_2018-08-30) EndTime: 31.08.2018 17:45:28 (1535730328) BeginTime: 31.08.2018 17:45:10 (1535730310) Duration: 00:00:17.3079900 Messages: [ 2018-08-31 17:45:10 +02 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started, 2018-08-31 17:45:13 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: (), 2018-08-31 17:45:23 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed: (131 bytes), 2018-08-31 17:45:25 +02 - [Information-Duplicati.Library.Main.Operation.DeleteHandler:RetentionPolicy-StartCheck]: Start checking if backups can be removed, 2018-08-31 17:45:25 +02 - [Information-Duplicati.Library.Main.Operation.DeleteHandler:RetentionPolicy-FramesAndIntervals]: Time frames and intervals pairs: 15.00:00:00 / 5.00:00:00, 59.00:00:00 / 14.00:00:00, 18262.00:00:00 / 730.00:00:00, ... ] Warnings: [] Errors: []

3

Try duplicati-monitoring.com

It parses the logs and had shown me successfull backups even when Duplicati gives warnings.

It so bothers me to get warnings even though I realise a warning is not an error. Psychological.

4

To clarify, is the issue that a popup appears at the bottom of the web UI screen, yet logs don’t indicate why?

FYI the forum software will allow pasting screen clips (if you’re able to take them), and these can add clarity.

Helpfull message box [feature request] #2887 and Feature request: better reporting give possible changes.

Strange warnings after update to Duplicati 2.0.3.4_canary_2018-04-02 discusses checking various log files because they’re kind of spread around right now… I can’t tell you what you’re missing, but you could check.

5

Yes, for me. I’ll post screenshot in future as well when appropriate.