Duplicati is on v2, but it’s no better. Forbidden
, though, is a standard 403 all the way back to HTTP 1.0:
Hypertext Transfer Protocol – HTTP/1.0
403 Forbidden
The server understood the request, but is refusing to fulfill it.
Possibly this is expressed differently in Canary. I think it’s been fiddled with sometimes. The 5 is number-of-retries, but there’s also the first “try” which is not a retry. In your big log, you can see all the failures, but one of the four (can be configured) parallel uploads got there first. Here I label the uploads A, B, C, and D:
A 2020-07-20 21:48:20 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b4bc325b682cf4f3199737dbc95d54d8c.dblock.zip.aes (49.92 MB)
B 2020-07-20 21:48:23 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b2a57907c7e4b4b289cbf6909a884501b.dblock.zip.aes (49.93 MB)
C 2020-07-20 21:48:24 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b83af10d636ae4d5288667f6b6510dc6a.dblock.zip.aes (49.92 MB)
D 2020-07-20 21:48:24 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b011bee3e67964735a9fee983e4df411f.dblock.zip.aes (49.93 MB)
A 2020-07-20 22:00:48 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-b4bc325b682cf4f3199737dbc95d54d8c.dblock.zip.aes attempt 1 of 5 failed with message: The remote server returned an error: (403) Forbidden.
A 2020-07-20 22:00:48 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-b4bc325b682cf4f3199737dbc95d54d8c.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:00:48 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-b83af10d636ae4d5288667f6b6510dc6a.dblock.zip.aes attempt 1 of 5 failed with message: The remote server returned an error: (403) Forbidden.
C 2020-07-20 22:00:48 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-b83af10d636ae4d5288667f6b6510dc6a.dblock.zip.aes (49.92 MB)
D 2020-07-20 22:00:49 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-b011bee3e67964735a9fee983e4df411f.dblock.zip.aes attempt 1 of 5 failed with message: The remote server returned an error: (403) Forbidden.
D 2020-07-20 22:00:49 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-b011bee3e67964735a9fee983e4df411f.dblock.zip.aes (49.93 MB)
A 2020-07-20 22:00:58 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b4bc325b682cf4f3199737dbc95d54d8c.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:00:58 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bd226bff02684451fb1c00d9c31cece18.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:00:58 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-b4bc325b682cf4f3199737dbc95d54d8c.dblock.zip.aes" to "duplicati-bd226bff02684451fb1c00d9c31cece18.dblock.zip.aes"
A 2020-07-20 22:00:58 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-bd226bff02684451fb1c00d9c31cece18.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:00:58 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b83af10d636ae4d5288667f6b6510dc6a.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:00:58 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b7fba8ae76f704b0bbf1c3c5dbc8ac08c.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:00:58 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-b83af10d636ae4d5288667f6b6510dc6a.dblock.zip.aes" to "duplicati-b7fba8ae76f704b0bbf1c3c5dbc8ac08c.dblock.zip.aes"
C 2020-07-20 22:00:58 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b7fba8ae76f704b0bbf1c3c5dbc8ac08c.dblock.zip.aes (49.92 MB)
D 2020-07-20 22:00:59 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b011bee3e67964735a9fee983e4df411f.dblock.zip.aes (49.93 MB)
D 2020-07-20 22:00:59 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bf475a34392d34917abb34cdb94e45c72.dblock.zip.aes (49.93 MB)
D 2020-07-20 22:00:59 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-b011bee3e67964735a9fee983e4df411f.dblock.zip.aes" to "duplicati-bf475a34392d34917abb34cdb94e45c72.dblock.zip.aes"
D 2020-07-20 22:00:59 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-bf475a34392d34917abb34cdb94e45c72.dblock.zip.aes (49.93 MB)
B 2020-07-20 22:01:07 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-b2a57907c7e4b4b289cbf6909a884501b.dblock.zip.aes attempt 1 of 5 failed with message: The remote server returned an error: (403) Forbidden.
B 2020-07-20 22:01:07 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-b2a57907c7e4b4b289cbf6909a884501b.dblock.zip.aes (49.93 MB)
C 2020-07-20 22:01:08 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-b7fba8ae76f704b0bbf1c3c5dbc8ac08c.dblock.zip.aes attempt 2 of 5 failed with message: The remote server returned an error: (403) Forbidden.
D 2020-07-20 22:01:08 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-bf475a34392d34917abb34cdb94e45c72.dblock.zip.aes attempt 2 of 5 failed with message: The remote server returned an error: (403) Forbidden.
C 2020-07-20 22:01:08 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-b7fba8ae76f704b0bbf1c3c5dbc8ac08c.dblock.zip.aes (49.92 MB)
D 2020-07-20 22:01:08 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-bf475a34392d34917abb34cdb94e45c72.dblock.zip.aes (49.93 MB)
A 2020-07-20 22:01:09 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-bd226bff02684451fb1c00d9c31cece18.dblock.zip.aes attempt 2 of 5 failed with message: The remote server returned an error: (403) Forbidden.
A 2020-07-20 22:01:09 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-bd226bff02684451fb1c00d9c31cece18.dblock.zip.aes (49.92 MB)
B 2020-07-20 22:01:17 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b2a57907c7e4b4b289cbf6909a884501b.dblock.zip.aes (49.93 MB)
B 2020-07-20 22:01:17 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bbb951a0093714154b98f2afde8579700.dblock.zip.aes (49.93 MB)
B 2020-07-20 22:01:17 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-b2a57907c7e4b4b289cbf6909a884501b.dblock.zip.aes" to "duplicati-bbb951a0093714154b98f2afde8579700.dblock.zip.aes"
B 2020-07-20 22:01:17 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-bbb951a0093714154b98f2afde8579700.dblock.zip.aes (49.93 MB)
C 2020-07-20 22:01:18 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b7fba8ae76f704b0bbf1c3c5dbc8ac08c.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:01:18 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-ba01630bf0e664ed49e0e1b028cc974d7.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:01:18 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-b7fba8ae76f704b0bbf1c3c5dbc8ac08c.dblock.zip.aes" to "duplicati-ba01630bf0e664ed49e0e1b028cc974d7.dblock.zip.aes"
C 2020-07-20 22:01:18 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-ba01630bf0e664ed49e0e1b028cc974d7.dblock.zip.aes (49.92 MB)
D 2020-07-20 22:01:18 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bf475a34392d34917abb34cdb94e45c72.dblock.zip.aes (49.93 MB)
D 2020-07-20 22:01:18 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-ba2f57a33913f4ef482b437d2f248fc9d.dblock.zip.aes (49.93 MB)
D 2020-07-20 22:01:18 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-bf475a34392d34917abb34cdb94e45c72.dblock.zip.aes" to "duplicati-ba2f57a33913f4ef482b437d2f248fc9d.dblock.zip.aes"
D 2020-07-20 22:01:18 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-ba2f57a33913f4ef482b437d2f248fc9d.dblock.zip.aes (49.93 MB)
A 2020-07-20 22:01:19 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bd226bff02684451fb1c00d9c31cece18.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:01:19 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bb428fcdb086e413cbef9c261d018c24a.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:01:19 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-bd226bff02684451fb1c00d9c31cece18.dblock.zip.aes" to "duplicati-bb428fcdb086e413cbef9c261d018c24a.dblock.zip.aes"
A 2020-07-20 22:01:19 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-bb428fcdb086e413cbef9c261d018c24a.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:01:29 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-ba01630bf0e664ed49e0e1b028cc974d7.dblock.zip.aes attempt 3 of 5 failed with message: The remote server returned an error: (403) Forbidden.
C 2020-07-20 22:01:29 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-ba01630bf0e664ed49e0e1b028cc974d7.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:01:29 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-bb428fcdb086e413cbef9c261d018c24a.dblock.zip.aes attempt 3 of 5 failed with message: The remote server returned an error: (403) Forbidden.
A 2020-07-20 22:01:29 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-bb428fcdb086e413cbef9c261d018c24a.dblock.zip.aes (49.92 MB)
D 2020-07-20 22:01:29 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-ba2f57a33913f4ef482b437d2f248fc9d.dblock.zip.aes attempt 3 of 5 failed with message: The remote server returned an error: (403) Forbidden.
D 2020-07-20 22:01:29 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-ba2f57a33913f4ef482b437d2f248fc9d.dblock.zip.aes (49.93 MB)
C 2020-07-20 22:01:39 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-ba01630bf0e664ed49e0e1b028cc974d7.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:01:39 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bfbf68b9123e846b8a61571a21913aafd.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:01:39 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-ba01630bf0e664ed49e0e1b028cc974d7.dblock.zip.aes" to "duplicati-bfbf68b9123e846b8a61571a21913aafd.dblock.zip.aes"
C 2020-07-20 22:01:39 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-bfbf68b9123e846b8a61571a21913aafd.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:01:39 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bb428fcdb086e413cbef9c261d018c24a.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:01:39 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bee1494ca00964aa98c0e56899f747e17.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:01:39 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-bb428fcdb086e413cbef9c261d018c24a.dblock.zip.aes" to "duplicati-bee1494ca00964aa98c0e56899f747e17.dblock.zip.aes"
A 2020-07-20 22:01:39 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-bee1494ca00964aa98c0e56899f747e17.dblock.zip.aes (49.92 MB)
D 2020-07-20 22:01:39 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-ba2f57a33913f4ef482b437d2f248fc9d.dblock.zip.aes (49.93 MB)
D 2020-07-20 22:01:39 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b4f9f213727a8462e8f99dcce672124ac.dblock.zip.aes (49.93 MB)
D 2020-07-20 22:01:39 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-ba2f57a33913f4ef482b437d2f248fc9d.dblock.zip.aes" to "duplicati-b4f9f213727a8462e8f99dcce672124ac.dblock.zip.aes"
D 2020-07-20 22:01:39 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b4f9f213727a8462e8f99dcce672124ac.dblock.zip.aes (49.93 MB)
A 2020-07-20 22:01:49 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-bee1494ca00964aa98c0e56899f747e17.dblock.zip.aes attempt 4 of 5 failed with message: The remote server returned an error: (403) Forbidden.
A 2020-07-20 22:01:49 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-bee1494ca00964aa98c0e56899f747e17.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:01:59 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bee1494ca00964aa98c0e56899f747e17.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:01:59 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b1c15e5c9b5de49d7a87c7dbceb7f26c3.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:01:59 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-bee1494ca00964aa98c0e56899f747e17.dblock.zip.aes" to "duplicati-b1c15e5c9b5de49d7a87c7dbceb7f26c3.dblock.zip.aes"
A 2020-07-20 22:01:59 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b1c15e5c9b5de49d7a87c7dbceb7f26c3.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:02:07 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-bfbf68b9123e846b8a61571a21913aafd.dblock.zip.aes attempt 4 of 5 failed with message: The remote server returned an error: (403) Forbidden.
C 2020-07-20 22:02:07 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-bfbf68b9123e846b8a61571a21913aafd.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:02:07 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-b1c15e5c9b5de49d7a87c7dbceb7f26c3.dblock.zip.aes attempt 5 of 5 failed with message: The remote server returned an error: (403) Forbidden.
A 2020-07-20 22:02:07 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-b1c15e5c9b5de49d7a87c7dbceb7f26c3.dblock.zip.aes (49.92 MB)
D 2020-07-20 22:02:08 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-b4f9f213727a8462e8f99dcce672124ac.dblock.zip.aes attempt 4 of 5 failed with message: The remote server returned an error: (403) Forbidden.
D 2020-07-20 22:02:08 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-b4f9f213727a8462e8f99dcce672124ac.dblock.zip.aes (49.93 MB)
B 2020-07-20 22:02:08 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-bbb951a0093714154b98f2afde8579700.dblock.zip.aes attempt 2 of 5 failed with message: The remote server returned an error: (403) Forbidden.
B 2020-07-20 22:02:08 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-bbb951a0093714154b98f2afde8579700.dblock.zip.aes (49.93 MB)
C 2020-07-20 22:02:17 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bfbf68b9123e846b8a61571a21913aafd.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:02:17 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b91c3c9c7009c47aba8e066d231ac06ba.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:02:17 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-bfbf68b9123e846b8a61571a21913aafd.dblock.zip.aes" to "duplicati-b91c3c9c7009c47aba8e066d231ac06ba.dblock.zip.aes"
C 2020-07-20 22:02:17 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b91c3c9c7009c47aba8e066d231ac06ba.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:02:17 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b1c15e5c9b5de49d7a87c7dbceb7f26c3.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:02:17 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b06c9a241d7d748adafaaebb8c5918b4a.dblock.zip.aes (49.92 MB)
A 2020-07-20 22:02:17 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-b1c15e5c9b5de49d7a87c7dbceb7f26c3.dblock.zip.aes" to "duplicati-b06c9a241d7d748adafaaebb8c5918b4a.dblock.zip.aes"
A 2020-07-20 22:02:17 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b06c9a241d7d748adafaaebb8c5918b4a.dblock.zip.aes (49.92 MB)
D 2020-07-20 22:02:18 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b4f9f213727a8462e8f99dcce672124ac.dblock.zip.aes (49.93 MB)
D 2020-07-20 22:02:18 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-b10ab147b67744876a1e7fa66c46a66aa.dblock.zip.aes (49.93 MB)
D 2020-07-20 22:02:18 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-b4f9f213727a8462e8f99dcce672124ac.dblock.zip.aes" to "duplicati-b10ab147b67744876a1e7fa66c46a66aa.dblock.zip.aes"
D 2020-07-20 22:02:18 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-b10ab147b67744876a1e7fa66c46a66aa.dblock.zip.aes (49.93 MB)
B 2020-07-20 22:02:18 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bbb951a0093714154b98f2afde8579700.dblock.zip.aes (49.93 MB)
B 2020-07-20 22:02:18 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Rename: duplicati-bc19ecb78b6de4954b824504ef8a5e0b3.dblock.zip.aes (49.93 MB)
B 2020-07-20 22:02:18 -04 - [Information-Duplicati.Library.Main.Operation.Backup.BackendUploader-RenameRemoteTargetFile]: Renaming "duplicati-bbb951a0093714154b98f2afde8579700.dblock.zip.aes" to "duplicati-bc19ecb78b6de4954b824504ef8a5e0b3.dblock.zip.aes"
B 2020-07-20 22:02:18 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-bc19ecb78b6de4954b824504ef8a5e0b3.dblock.zip.aes (49.93 MB)
A 2020-07-20 22:02:27 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-b06c9a241d7d748adafaaebb8c5918b4a.dblock.zip.aes attempt 6 of 5 failed with message: The remote server returned an error: (403) Forbidden.
A 2020-07-20 22:02:27 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Failed: duplicati-b06c9a241d7d748adafaaebb8c5918b4a.dblock.zip.aes (49.92 MB)
C 2020-07-20 22:02:27 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-b91c3c9c7009c47aba8e066d231ac06ba.dblock.zip.aes attempt 5 of 5 failed with message: The remote server returned an error: (403) Forbidden.
C 2020-07-20 22:02:27 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-b91c3c9c7009c47aba8e066d231ac06ba.dblock.zip.aes (49.92 MB)
B 2020-07-20 22:02:27 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-bc19ecb78b6de4954b824504ef8a5e0b3.dblock.zip.aes attempt 3 of 5 failed with message: The remote server returned an error: (403) Forbidden.
B 2020-07-20 22:02:27 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-bc19ecb78b6de4954b824504ef8a5e0b3.dblock.zip.aes (49.93 MB)
D 2020-07-20 22:02:28 -04 - [Retry-Duplicati.Library.Main.Operation.Backup.BackendUploader-RetryPut]: Operation Put with file duplicati-b10ab147b67744876a1e7fa66c46a66aa.dblock.zip.aes attempt 5 of 5 failed with message: The remote server returned an error: (403) Forbidden.
D 2020-07-20 22:02:28 -04 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Retrying: duplicati-b10ab147b67744876a1e7fa66c46a66aa.dblock.zip.aes (49.93 MB)
2020-07-20 22:02:38 -04 - [Error-Duplicati.Library.Main.Operation.BackupHandler-FatalError]: Fatal error
System.IO.FileNotFoundException: Could not find file "/tmp/dup-aee9b1e1-0218-45d7-9146-edf43bf9e238"
File name: '/tmp/dup-aee9b1e1-0218-45d7-9146-edf43bf9e238'
at System.IO.FileStream..ctor (System.String path, System.IO.FileMode mode, System.IO.FileAccess access, System.IO.FileShare share, System.Int32 bufferSize, System.Boolean anonymous, System.IO.FileOptions options) [0x0019e] in <a17fa1457c5d44f2885ac746c1764ea5>:0
at System.IO.FileStream..ctor (System.String path, System.IO.FileMode mode, System.IO.FileAccess access, System.IO.FileShare share) [0x00000] in <a17fa1457c5d44f2885ac746c1764ea5>:0
at (wrapper remoting-invoke-with-check) System.IO.FileStream..ctor(string,System.IO.FileMode,System.IO.FileAccess,System.IO.FileShare)
at Duplicati.Library.Main.Volumes.VolumeReaderBase.LoadCompressor (System.String compressor, System.String file, Duplicati.Library.Main.Options options, System.IO.Stream& stream) [0x00000] in <8f1de655bd1240739a78684d845cecc8>:0
at Duplicati.Library.Main.Volumes.VolumeReaderBase..ctor (System.String compressor, System.String file, Duplicati.Library.Main.Options options) [0x00007] in <8f1de655bd1240739a78684d845cecc8>:0
at Duplicati.Library.Main.Volumes.BlockVolumeReader..ctor (System.String compressor, System.String file, Duplicati.Library.Main.Options options) [0x00010] in <8f1de655bd1240739a78684d845cecc8>:0
at Duplicati.Library.Main.Operation.Backup.SpillCollectorProcess+<>c__DisplayClass0_0.<Run>b__0 (<>f__AnonymousType11`2[<Input>j__TPar,<Output>j__TPar] self) [0x0023c] in <8f1de655bd1240739a78684d845cecc8>:0
at CoCoL.AutomationExtensions.RunTask[T] (T channels, System.Func`2[T,TResult] method, System.Boolean catchRetiredExceptions) [0x000d5] in <9a758ff4db6c48d6b3d4d0e5c2adf6d1>:0
at Duplicati.Library.Main.Operation.BackupHandler.RunMainOperation (System.Collections.Generic.IEnumerable`1[T] sources, Duplicati.Library.Snapshots.ISnapshotService snapshot, Duplicati.Library.Snapshots.UsnJournalService journalService, Duplicati.Library.Main.Operation.Backup.BackupDatabase database, Duplicati.Library.Main.Operation.Backup.BackupStatsCollector stats, Duplicati.Library.Main.Options options, Duplicati.Library.Utility.IFilter sourcefilter, Duplicati.Library.Utility.IFilter filter, Duplicati.Library.Main.BackupResults result, Duplicati.Library.Main.Operation.Common.ITaskReader taskreader, System.Int64 filesetid, System.Int64 lastfilesetid, System.Threading.CancellationToken token) [0x0035f] in <8f1de655bd1240739a78684d845cecc8>:0
at Duplicati.Library.Main.Operation.BackupHandler.RunAsync (System.String[] sources, Duplicati.Library.Utility.IFilter filter, System.Threading.CancellationToken token) [0x00a12] in <8f1de655bd1240739a78684d845cecc8>:0
I made the above summary yesterday to confirm what I thought it was doing. You can see that after the “6 of 5” there are three that weren’t at 6 yet, and beneath those others (but not the 6) there’s a “Retrying” line.
I’m kind of curious if the 10 second delay before “Could not find file” is related to the default 10 second time between “Retrying” declaration and actually trying to do the upload (see prior examples). Maybe something cleaned up files when it was clear that one uploader exhausted its retries, then a different uploader tripped.
--asynchronous-concurrent-upload-limit (Integer): The number of concurrent
uploads allowed
When performing asynchronous uploads, the maximum number of concurrent
uploads allowed. Set to zero to disable the limit.
* default value: 4
could be an experiment to see if it somehow helps either your “Could not find file” (by avoiding the tripping over a deleted file), or by changing upload characteristics if you suspect that’s somehow causing the 403.
Per-transfer. You have 4 going on at once, all started at about the same time (see top of my analysis), but over time one got ahead of the others. You can see an earlier spot where the Google time-until-403 varied.
I’m not seeing that. After the 6 of 5, there is nothing else “Started”. Don’t be confused by “Retrying” intents.
Sounds like a paid plan. If you’re paying, do you have support to ask Google why they give 403 Forbidden?
EDIT:
If you wish to try that, 2.0.5.1 can throttle upload but mistakenly throttles download too. It’s fixed in Canary.