Hello,
I have router “AC1750 Wireless Dual Band Gigabit Router” that contain basic (without TLS encryption) ftp server and allow to share connected USB drive in term of remote storage.
I’m trying evaluate duplicati in this scenario but it fail in strange manner that i cannot address by myself.
Here is log output:
DeletedFiles: 0
DeletedFolders: 0
ModifiedFiles: 0
ExaminedFiles: 1
OpenedFiles: 1
AddedFiles: 1
SizeOfModifiedFiles: 0
SizeOfAddedFiles: 5420298
SizeOfExaminedFiles: 5420298
SizeOfOpenedFiles: 5420298
NotProcessedFiles: 0
AddedFolders: 1
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: Warning
Version: 2.0.4.5 (2.0.4.5_beta_2018-11-28)
EndTime: 7/8/2019 12:03:16 PM (1562580196)
BeginTime: 7/8/2019 12:03:16 PM (1562580196)
Duration: 00:00:00.0255610
Messages: [
2019-07-08 12:02:35 +02 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started,
2019-07-08 12:02:35 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: (),
2019-07-08 12:02:35 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed: (),
2019-07-08 12:02:36 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b7121a4faa7bf4df6b3fc8a120b5e70d5.dblock.zip.aes (5.09 MB),
2019-07-08 12:02:36 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-b7121a4faa7bf4df6b3fc8a120b5e70d5.dblock.zip.aes (5.09 MB),
…
]
Warnings: [
2019-07-08 12:02:36 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-b7121a4faa7bf4df6b3fc8a120b5e70d5.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
2019-07-08 12:02:46 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-ba0d596640a62481898fdc48d982f3f3f.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
2019-07-08 12:02:56 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-b9972880aea02409aa341467e70c26012.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
2019-07-08 12:03:06 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-b060d407d65dd497fad3fc7c141b7d775.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
2019-07-08 12:03:16 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-b24631e42c5324090be09eba309976a41.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
…
]
Errors:
BackendStatistics:
RemoteCalls: 8
BytesUploaded: 0
BytesDownloaded: 0
FilesUploaded: 0
FilesDownloaded: 0
FilesDeleted: 0
FoldersCreated: 0
RetryAttempts: 6
UnknownFileSize: 0
UnknownFileCount: 0
KnownFileCount: 0
KnownFileSize: 0
LastBackupDate: 1/1/0001 1:00:00 AM (-62135596800)
BackupListCount: 0
TotalQuotaSpace: 0
FreeQuotaSpace: 0
AssignedQuotaSpace: -1
ReportedQuotaError: False
ReportedQuotaWarning: False
ParsedResult: Warning
Version: 2.0.4.5 (2.0.4.5_beta_2018-11-28)
Messages: [
2019-07-08 12:02:35 +02 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started,
2019-07-08 12:02:35 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: (),
2019-07-08 12:02:35 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed: (),
2019-07-08 12:02:36 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b7121a4faa7bf4df6b3fc8a120b5e70d5.dblock.zip.aes (5.09 MB),
2019-07-08 12:02:36 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-b7121a4faa7bf4df6b3fc8a120b5e70d5.dblock.zip.aes (5.09 MB),
…
]
Warnings: [
2019-07-08 12:02:36 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-b7121a4faa7bf4df6b3fc8a120b5e70d5.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
2019-07-08 12:02:46 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-ba0d596640a62481898fdc48d982f3f3f.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
2019-07-08 12:02:56 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-b9972880aea02409aa341467e70c26012.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
2019-07-08 12:03:06 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-b060d407d65dd497fad3fc7c141b7d775.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
2019-07-08 12:03:16 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-b24631e42c5324090be09eba309976a41.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
…
]
Errors:
DeleteResults: null
RepairResults: null
TestResults: null
ParsedResult: Warning
Version: 2.0.4.5 (2.0.4.5_beta_2018-11-28)
EndTime: 7/8/2019 12:03:16 PM (1562580196)
BeginTime: 7/8/2019 12:02:35 PM (1562580155)
Duration: 00:00:41.2895000
Messages: [
2019-07-08 12:02:35 +02 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started,
2019-07-08 12:02:35 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: (),
2019-07-08 12:02:35 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed: (),
2019-07-08 12:02:36 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b7121a4faa7bf4df6b3fc8a120b5e70d5.dblock.zip.aes (5.09 MB),
2019-07-08 12:02:36 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-b7121a4faa7bf4df6b3fc8a120b5e70d5.dblock.zip.aes (5.09 MB),
…
]
Warnings: [
2019-07-08 12:02:36 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-b7121a4faa7bf4df6b3fc8a120b5e70d5.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
2019-07-08 12:02:46 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-ba0d596640a62481898fdc48d982f3f3f.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
2019-07-08 12:02:56 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-b9972880aea02409aa341467e70c26012.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
2019-07-08 12:03:06 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-b060d407d65dd497fad3fc7c141b7d775.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
2019-07-08 12:03:16 +02 - [Warning-Duplicati.Library.Main.Operation.Common.BackendHandler-FolderCreateError]: Failed to create folder: The folder /volume9/backup/duplicati-b24631e42c5324090be09eba309976a41.dblock.zip.aes was not found, message: The remote server returned an error: (550) 550 Permission denied.
.,
…
]
Errors:
From error message i can read there is problem with FTP permissions… but, they are correct.
I validate that using FileZilla there is 777 permission to /volume9/backup directory, from filezilla i can create folders and upload new files into that directory.
I suspect that it might be caused by that FTP server cannot handle filename that long, so i create file “duplicati-b060d407d65dd497fad3fc7c141b7d775.dblock.zip.aes” and copy it using filezilla.
| Status: | Connecting to 192.168.1.1:21… |
|---|---|
| Status: | Connection established, waiting for welcome message… |
| Status: | Insecure server, it does not support FTP over TLS. |
| Status: | Logged in |
| Status: | Starting upload of /home/camil/Downloads/duplicati-b060d407d65dd497fad3fc7c141b7d775.dblock.zip.aes |
| Status: | File transfer successful, transferred 7,2 MB in 1 second |
| Status: | Retrieving directory listing of “/volume9/backup”… |
| Status: | Directory listing of “/volume9/backup” successful |
and as You can see, same filename that fail in duplicati backend pass without any warning.
Could someone provide idea what might be wrong?
Regards