Warning-Duplicati.Library.Main.BackendManager-FolderCreateError

Support
1

Am I missing something here? This error just appeared out of nowhere. Backups before it completed fine and backups after it completed fine with zero changes on the client or the Wasabi backend.

I feel like I’m missing more of the log. I’m interpreting this as a hiccup connecting to Wasabi from the client then Duplicati retried and all was good? Also where did it try to create the folder at?

Here’s the log:

{
“DeletedFiles”: 0,
“DeletedFolders”: 0,
“ModifiedFiles”: 3,
“ExaminedFiles”: 6,
“OpenedFiles”: 3,
“AddedFiles”: 0,
“SizeOfModifiedFiles”: 652718080,
“SizeOfAddedFiles”: 0,
“SizeOfExaminedFiles”: 652718786,
“SizeOfOpenedFiles”: 652718080,
“NotProcessedFiles”: 0,
“AddedFolders”: 0,
“TooLargeFiles”: 0,
“FilesWithError”: 0,
“ModifiedFolders”: 0,
“ModifiedSymlinks”: 0,
“AddedSymlinks”: 0,
“DeletedSymlinks”: 0,
“PartialBackup”: false,
“Dryrun”: false,
“MainOperation”: “Backup”,
“CompactResults”: null,
“VacuumResults”: null,
“DeleteResults”: null,
“RepairResults”: null,
“TestResults”: {
“MainOperation”: “Test”,
“VerificationsActualLength”: 3,
“Verifications”: [
{
“Key”: “duplicati-20230103T070000Z.dlist.zip.aes”,
“Value”: []
},
{
“Key”: “duplicati-i41974a8a5493413abb0f8a5efd3e7b1d.dindex.zip.aes”,
“Value”: []
},
{
“Key”: “duplicati-b4645d6c899a843fb94c2546a18382119.dblock.zip.aes”,
“Value”: []
}
],
“ParsedResult”: “Success”,
“Version”: “2.0.6.3 (2.0.6.3_beta_2021-06-17)”,
“EndTime”: “2023-01-03T07:01:29.8793503Z”,
“BeginTime”: “2023-01-03T07:01:26.8524855Z”,
“Duration”: “00:00:03.0268648”,
“MessagesActualLength”: 0,
“WarningsActualLength”: 0,
“ErrorsActualLength”: 0,
“Messages”: null,
“Warnings”: null,
“Errors”: null,
“BackendStatistics”: {
“RemoteCalls”: 21,
“BytesUploaded”: 352261011,
“BytesDownloaded”: 52506071,
“FilesUploaded”: 15,
“FilesDownloaded”: 3,
“FilesDeleted”: 0,
“FoldersCreated”: 0,
“RetryAttempts”: 1,
“UnknownFileSize”: 0,
“UnknownFileCount”: 1,
“KnownFileCount”: 315,
“KnownFileSize”: 6514607551,
“LastBackupDate”: “2023-01-03T02:00:00-05:00”,
“BackupListCount”: 29,
“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-03T07:00:00.013736Z”,
“Duration”: “00:00:00”,
“MessagesActualLength”: 0,
“WarningsActualLength”: 0,
“ErrorsActualLength”: 0,
“Messages”: null,
“Warnings”: null,
“Errors”: null
}
},
“ParsedResult”: “Warning”,
“Version”: “2.0.6.3 (2.0.6.3_beta_2021-06-17)”,
“EndTime”: “2023-01-03T07:01:29.8874433Z”,
“BeginTime”: “2023-01-03T07:00:00.013736Z”,
“Duration”: “00:01:29.8737073”,
“MessagesActualLength”: 43,
“WarningsActualLength”: 1,
“ErrorsActualLength”: 0,
“Messages”: [
“2023-01-03 02:00:00 -05 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started”,
“2023-01-03 02:00:02 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: ()”,
“2023-01-03 02:00:13 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Retrying: ()”,
“2023-01-03 02:00:43 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: ()”,
“2023-01-03 02:00:43 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed: (301 bytes)”,
“2023-01-03 02:00:51 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-bd992782cd5fc489b81548364310567e6.dblock.zip.aes (49.94 MB)”,
“2023-01-03 02:00:52 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-beae039faf97c47f881cd0f8dd9ce1986.dblock.zip.aes (49.92 MB)”,
“2023-01-03 02:00:52 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-bb0a76f0af0794c7589a8e842c049f3b5.dblock.zip.aes (49.95 MB)”,
“2023-01-03 02:01:04 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-beae039faf97c47f881cd0f8dd9ce1986.dblock.zip.aes (49.92 MB)”,
“2023-01-03 02:01:04 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-i9e3b10462a24439bbf41796ab65e8d97.dindex.zip.aes (27.45 KB)”,
“2023-01-03 02:01:05 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-i9e3b10462a24439bbf41796ab65e8d97.dindex.zip.aes (27.45 KB)”,
“2023-01-03 02:01:05 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-bb0a76f0af0794c7589a8e842c049f3b5.dblock.zip.aes (49.95 MB)”,
“2023-01-03 02:01:05 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-i393e16f9baf547f4a7c3cfeca3d8832a.dindex.zip.aes (27.51 KB)”,
“2023-01-03 02:01:05 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-i393e16f9baf547f4a7c3cfeca3d8832a.dindex.zip.aes (27.51 KB)”,
“2023-01-03 02:01:05 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-bd992782cd5fc489b81548364310567e6.dblock.zip.aes (49.94 MB)”,
“2023-01-03 02:01:05 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b556baab652124386ae7d1cf01c72d540.dblock.zip.aes (49.95 MB)”,
“2023-01-03 02:01:05 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-i0261a4139fcb456c999c241ca2f7c521.dindex.zip.aes (36.08 KB)”,
“2023-01-03 02:01:05 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-i0261a4139fcb456c999c241ca2f7c521.dindex.zip.aes (36.08 KB)”,
“2023-01-03 02:01:05 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b1d7af4fcb04446a8a8126c0ffee4ed9f.dblock.zip.aes (49.95 MB)”,
“2023-01-03 02:01:05 -05 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-bba57915af9f24894909b0c7c6d23a7f5.dblock.zip.aes (49.92 MB)”
],
“Warnings”: [
“2023-01-03 02:00:32 -05 - [Warning-Duplicati.Library.Main.BackendManager-FolderCreateError]: Failed to create folder: The requested folder does not exist”
],
“Errors”: [],
“BackendStatistics”: {
“RemoteCalls”: 21,
“BytesUploaded”: 352261011,
“BytesDownloaded”: 52506071,
“FilesUploaded”: 15,
“FilesDownloaded”: 3,
“FilesDeleted”: 0,
“FoldersCreated”: 0,
“RetryAttempts”: 1,
“UnknownFileSize”: 0,
“UnknownFileCount”: 1,
“KnownFileCount”: 315,
“KnownFileSize”: 6514607551,
“LastBackupDate”: “2023-01-03T02:00:00-05:00”,
“BackupListCount”: 29,
“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-03T07:00:00.013736Z”,
“Duration”: “00:00:00”,
“MessagesActualLength”: 0,
“WarningsActualLength”: 0,
“ErrorsActualLength”: 0,
“Messages”: null,
“Warnings”: null,
“Errors”: null
}
}

2

Hello

Yes, it seems that Duplicati tried to access the folder, failed to access it and retried it with success. If this does not occur again with following backups, you can just ignore it in my opinion.
About the error message, maybe Duplicati not finding its folder has assumed it was a new backup and tried to create it and failed (obviously).
I have not checked the code so this is mere speculation.

3

You’re talking about it not finding the folder on the Wasabi backend?

Yes no warnings or errors from that backup onward.

Is there another spot to look for logs from Duplicati or just from the backup job menu?

4

Yes, a backup software usually don’t try to create folders on the system when actually doing a backup.

you can enable more logs by adding an advanced option (console-log-level for example).

I prefer not accessing huge logs in the web UI, and enable the mail reporting with more logging (send-mail-log-level and send-mail-max-log-lines). Besides, I appreciate that logs are not locked into the Duplicati database, you never know what can happen to a database.

5

Thank you. Yea I’d rather see it in the emails. Where did you find those two commands? I looked for them in the documentation and could not find them.

6

In the UI for advanced options, if you scroll long enough to see the mail reporting options.
You are right that these options are not in the documentation. They were probably added after the bulk of the doc job had been done.

7

Gotcha. Guess I can’t send an email using, “verbose” with 0 lines.

2023-01-14 22:43:38 -05 - [Warning-Duplicati.Library.Modules.Builtin.ReportHelper-ReportSubmitError]: Failed to send message: MailKit.Net.Smtp.SmtpCommandException: Message size exceeds fixed maximum message size. Size: 142610 KB, Max size: 32768 KB

8

Considering I just reworked an FTP server app (yes I know you said Wasabi so read on) last month with Duplicati in use, I’d say this should be more correctly put as a concern.

The retry happened during LIST. That is when Duplicati asks for a list of all the files from the remote side. This is obviously showing there’s some issue possible during that time. That issue can potentially cause various problems down the line. Just because it didn’t here doesn’t mean anything except for here.

It shouldn’t be creating folders there but switching (folder creation is tied into that in different ways). So possibly a path related problem in the Wasabi server code. You don’t know when that might show up and mess up things. You can only hope the train stays on the track or change trains :slight_smile:

BTW, Duplicati has a setting to not check and not test… but its obviously better to check so you shouldn’t avoid LIST. no-backend-verification checked & backup-test-samples 0. Doing that should avoid LIST.

Should add too that the remote will send errors back to Duplicati and from there Duplicati won’t necessarily make it obvious.

9

Yep I agree, it shouldn’t be creating folders on the backend.

Here’s the config I currently run on each job (I believe “–full-result=true” is logging only on the client side?):

–accept-any-ssl-certificate=true
–snapshot-policy=Required

–full-remote-verification=true
–full-result=true

–send-mail-url=XXXXXXXXXX
–send-mail-any-operation=true
–send-mail-subject=%OPERATIONNAME% - %backup-name% - %PARSEDRESULT%
–send-mail-to=XXXXXXXXXX
–send-mail-username=XXXXXXXXXX
–send-mail-password=XXXXXXXXXX
–send-mail-from=XXXXXXXXXX

10

It is probably exceeding the limit for your mail server, so if the backup is too big it can’t be used with mail reporting and a high level of logging.

11

retry level would probably be enough to see some detail on destination failure.

If a pattern can be found, you can also use About → Show log → Live → Retry
You might need to click a failing line to see some explanation.

EDIT:

If it’s hard to reproduce, and you don’t want mail, you can have a log file instead.
log-file=<path> log-file-log-level=retry, or something larger if big file is agreeable.

To run a list like backup does, but without backup, use Verify files GUI link.

As an initial operation, it might even be DNS. Or maybe it just won’t be seen again.
Unless you ask for no-backend-verification, all your files got listed, and looked fine.

If this flag is set, the local database is not compared to the remote filelist on startup. The intended usage for this option is to work correctly in cases where the filelisting is broken or unavailable.

12

Most definitely Pretty sure my mail server is limited to 25mb outbound so when I saw 143MB I said nope.