Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Unable to backup after termination of a running backup #910

Closed
rehanone opened this issue Oct 15, 2023 · 9 comments
Closed

Unable to backup after termination of a running backup #910

rehanone opened this issue Oct 15, 2023 · 9 comments
Labels
S-triage Status: Waiting for a maintainer to triage this issue/PR

Comments

@rehanone
Copy link

During a running backup I mistakenly assumed that a wrong target path was being backed up and decided to kill the backup by using Ctrl-C. Now I am unable to backup that path as the program goes in a loop printing failure messages like this.

[WARN] Error error sending request for url (http://127.0.0.1:39709/data/77d81d383832a29f284c42d27283a97c1466725757fb116392d331d6c59afc9b): operation timed out at 1.702818509s, retrying
[00:02:03] backing up...                  ████████████████████████████████████████  90.96 MiB/90.96 MiB  0B/s         (ETA 0s)                                                                     [DEBUG] (3) reqwest::connect: starting new connection: http://127.0.0.1:39709/
[00:02:12] backing up...                  ████████████████████████████████████████  90.96 MiB/90.96 MiB  0B/s         (ETA 0s)                                                                     [INFO] rclone output: 2023/10/15 19:41:29 ERROR : data/77/77d81d383832a29f284c42d27283a97c1466725757fb116392d331d6c59afc9b: Post request put error: RequestCanceled: request context canceled

[INFO] rclone output: caused by: context canceled

I have already tried check and prune commands and still get the same error. It looks like something to do with rclone but I have no idea what it could be or if it is an issue with rustic. There is no cache for rclone in path /root/.cache as well.
@github-actions github-actions bot added the S-triage Status: Waiting for a maintainer to triage this issue/PR label Oct 15, 2023
@aawsome
Copy link
Member

aawsome commented Oct 16, 2023 •
edited
Loading

Thanks for reporting! Can you give the complete ouput so it becomes clear at which state this happens? (Using a higher log level could also help)
Can you also check if there is a leftover rclone process?

@rehanone
Copy link
Author

rehanone commented Oct 16, 2023 •
edited by simonsan
Loading

@aawsome, Thanks for response! I have checked for leftover rclone and rustic processes and restarted the VM as well but it does not help.

Here is the full log:

06:34:46 [DEBUG] (1) rustic::backend::rclone: starting rclone with args ["serve", "restic", "scaleway-rustic:docker-data", "--addr", "localhost:0"]
06:34:46 [DEBUG] (1) rustic::backend::rclone: using REST backend with url scaleway-rustic:docker-data.
06:34:46 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:49] (ThreadId(1)) park without timeout
06:34:46 [TRACE] (3) reqwest::blocking::client: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/client.rs:1033] (ThreadId(3)) start runtime::block_on
06:34:46 [TRACE] (1) rustic::backend::rest: [src/backend/rest.rs:137] listing tpe: Config
06:34:46 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:34:46 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:42] (ThreadId(1)) park timeout 29.99999902s
06:34:46 [DEBUG] (3) reqwest::connect: starting new connection: http://127.0.0.1:45679/
06:34:46 [TRACE] (3) mio::poll: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/mio-0.8.8/src/poll.rs:531] registering event source with poller: token=Token(0), interests=READABLE | WRITABLE
06:34:46 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:46 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:355] signal found waiting giver, notifying
06:34:46 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:200] poll_want: taker wants!
06:34:46 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:46 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:46 [TRACE] (1) rustic::backend::rest: [src/backend/rest.rs:137] listing tpe: Key
06:34:46 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:34:46 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:42] (ThreadId(1)) park timeout 29.99999917s
06:34:46 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:46 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:46 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:34:46 [TRACE] (1) rustic::backend::rest: [src/backend/rest.rs:185] reading tpe: Key, id: 4314c2c0
06:34:46 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:34:46 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:42] (ThreadId(1)) park timeout 29.99999916s
06:34:47 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:47 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:47 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:34:47 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:47 [INFO] repository rclone:scaleway-rustic:docker-data: password is correct.
06:34:47 [TRACE] (1) rustic::backend::rest: [src/backend/rest.rs:185] reading tpe: Config, id: 00000000
06:34:47 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:34:47 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:42] (ThreadId(1)) park timeout 29.99999851s
06:34:47 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:47 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:47 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:34:47 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:47 [INFO] using cache at /root/.cache/rustic/3dd7aecacb817a4c8d84699143e8fc0f30ec33bc34b84abd13a8508c66024a39
06:34:47 [INFO] using all backup sources from config file.
06:34:47 [TRACE] (1) rustic::backend::rest: [src/backend/rest.rs:137] listing tpe: Index
06:34:47 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:34:47 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:42] (ThreadId(1)) park timeout 29.99999906s
06:34:48 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:48 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:48 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:34:48 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Index, id: 27524ba2
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Index, id: 4f65b158
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Index, id: d26965c1
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Index, id: 2b254cd9
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [INFO] merging source="/docker-data" section from config file
06:34:48 [INFO] starting to backup "/docker-data"...
06:34:48 [TRACE] (1) rustic::backend::rest: [src/backend/rest.rs:137] listing tpe: Snapshot
06:34:48 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:34:48 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:42] (ThreadId(1)) park timeout 29.99999882s
06:34:48 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:48 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:48 [TRACE] (1) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:34:48 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: 10e692cd
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: 8f67eaba
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: 189e3f0c
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: 922820a3
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: 2d298609
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: a0be4645
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: 32981016
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: c8e6834a
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: 485ae7bb
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: d9c8a2a2
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: f2b84ec1
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: 5778e34b
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: 6d2297e6
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: fbf91f69
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: 8ed86e0f
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:199] cache reading tpe: Snapshot, id: ff0780b7
06:34:48 [TRACE] (5) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [TRACE] (6) rustic::backend::cache: [src/backend/cache.rs:201] cache hit!
06:34:48 [INFO] using no parent
06:34:48 [TRACE] (1) users::base: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/users-0.11.0/src/base.rs:332] Running getpwuid_r for user #2100
06:34:48 [TRACE] (1) users::base: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/users-0.11.0/src/base.rs:447] Running getgruid_r for group #2100
06:34:48 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data"
06:34:48 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf"
06:34:48 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/config"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/config/absdatabase.sqlite"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/config/oldDb.zip"
06:34:48 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/config"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/config" 1.1 kiB
06:34:48 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata"
06:34:48 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/authors"
06:34:48 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/authors"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/authors" 13 B
06:34:48 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/backups"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-17T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-18T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-19T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-20T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-21T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-22T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-23T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-24T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-25T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-26T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-27T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-28T0130.audiobookshelf"
06:34:48 [TRACE] (28) users::base: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/users-0.11.0/src/base.rs:332] Running getpwuid_r for user #0
06:34:48 [TRACE] (28) users::base: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/users-0.11.0/src/base.rs:258] Loading user with uid 0
06:34:48 [TRACE] (28) users::base: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/users-0.11.0/src/base.rs:447] Running getgruid_r for group #0
06:34:48 [TRACE] (28) users::base: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/users-0.11.0/src/base.rs:273] Loading group with gid 0
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-29T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-09-30T0130.audiobookshelf"
06:34:48 [TRACE] (12) rustic::backend::rest: [src/backend/rest.rs:243] writing tpe: Pack, id: 3e40801f
06:34:48 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:34:48 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:42] (ThreadId(12)) park timeout 29.99999212s
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-01T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-02T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-03T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-04T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-05T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-06T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-07T0130.audiobookshelf"
06:34:48 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-08T0130.audiobookshelf"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-09T0130.audiobookshelf"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-10T0130.audiobookshelf"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-11T0130.audiobookshelf"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-12T0130.audiobookshelf"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-13T0130.audiobookshelf"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-14T0130.audiobookshelf"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-15T0130.audiobookshelf"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/backups/2023-10-16T0130.audiobookshelf"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/backups"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/backups" 12.9 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/cache"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/cache/covers"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/01b48fb8-0f39-4723-a17c-67489c5b4555_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/0392b59b-006b-4a68-9d74-3639e0ef1d3f_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/072587ab-45c5-4d38-8501-acde6d67df21_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/09901e67-d664-4ca4-a12a-52f0b42337f6_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/0be8152a-4034-4b29-b645-0d2b86db3fa5_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/132202a9-8095-492e-a8dd-3c85942529a3_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/20153a2a-d541-444a-b84b-61f99e822509_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/2057ef90-65bd-4f4f-9e2b-c2dcae2b814e_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/23eee77e-6ba4-4fb4-85f1-2f287676849d_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/2a97bcde-a808-48a6-9f02-f177ce49a98c_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/2c8cb88f-a784-4c3d-b986-cf08d120e487_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/34630ce5-df0b-4fa4-a4da-82dfac207dc6_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/38ea6158-9cb7-4362-a226-098a2c7e5e12_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/45003a46-40f9-45a7-92aa-bfc6a5d5759b_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/492e5d53-b2c7-4465-8dbf-437f5178596f_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/58c15e9a-9cae-4a25-8a53-fad32287d921_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/5aa816a6-3346-4862-97b3-cad59d47304b_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/62a459a3-f196-450b-bc6d-6f7d5ab59761_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/6fbd6b87-86f7-4961-9397-d2e7d8c28b77_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/7006a751-593b-4f8a-9707-258048cb2ef5_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/88fbbca2-42ab-4149-9128-6cbb9a6a16ba_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/923831e5-8ae2-41c4-954f-a1a36c67c8ae_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/9770a0a7-20ef-446a-b227-3955ca378a37_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/9839be54-bef6-4ea3-8625-92e2c67760f2_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/a0dcaacb-b04a-4ed7-a86b-7aa3d9e65862_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/a3606d48-ec4c-46e7-ab54-e46fed511d46_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/a42dcac0-6134-4690-8697-e03e478c1279_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/a53d0018-4e50-4f13-b0ec-a933096d8b29_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/b9dd5a49-c1f7-431e-b8e6-69a757243103_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/d55fea02-29cb-42e8-b286-a5f4dc43e043_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/d9c601c8-c6c1-462e-96b9-cf343398128a_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/e8bd6801-39c3-450f-b3d4-e7945ef24aa8_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/fe2aea6a-14e7-44e3-ac0c-b37a61d9da05_400.webp"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/cache/covers/ff71193a-5e1a-4c45-a2d4-46f1af2d5f15_400.webp"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/cache/covers"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/cache/covers" 12.6 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/cache/images"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/cache/images"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/cache/images" 13 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/cache/items"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/cache/items"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/cache/items" 13 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/cache"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/cache" 1013 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/downloads"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/downloads"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/downloads" 13 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/01b48fb8-0f39-4723-a17c-67489c5b4555"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/01b48fb8-0f39-4723-a17c-67489c5b4555/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/01b48fb8-0f39-4723-a17c-67489c5b4555"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/01b48fb8-0f39-4723-a17c-67489c5b4555" 355 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/0392b59b-006b-4a68-9d74-3639e0ef1d3f"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/0392b59b-006b-4a68-9d74-3639e0ef1d3f/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/0392b59b-006b-4a68-9d74-3639e0ef1d3f/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/0392b59b-006b-4a68-9d74-3639e0ef1d3f"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/0392b59b-006b-4a68-9d74-3639e0ef1d3f" 695 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/072587ab-45c5-4d38-8501-acde6d67df21"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/072587ab-45c5-4d38-8501-acde6d67df21/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/072587ab-45c5-4d38-8501-acde6d67df21/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/072587ab-45c5-4d38-8501-acde6d67df21"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/072587ab-45c5-4d38-8501-acde6d67df21" 695 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/09901e67-d664-4ca4-a12a-52f0b42337f6"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/09901e67-d664-4ca4-a12a-52f0b42337f6/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/09901e67-d664-4ca4-a12a-52f0b42337f6"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/09901e67-d664-4ca4-a12a-52f0b42337f6" 355 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/0be8152a-4034-4b29-b645-0d2b86db3fa5"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/0be8152a-4034-4b29-b645-0d2b86db3fa5/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/0be8152a-4034-4b29-b645-0d2b86db3fa5"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/0be8152a-4034-4b29-b645-0d2b86db3fa5" 355 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/132202a9-8095-492e-a8dd-3c85942529a3"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/132202a9-8095-492e-a8dd-3c85942529a3/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/132202a9-8095-492e-a8dd-3c85942529a3/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/132202a9-8095-492e-a8dd-3c85942529a3"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/132202a9-8095-492e-a8dd-3c85942529a3" 696 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/20153a2a-d541-444a-b84b-61f99e822509"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/20153a2a-d541-444a-b84b-61f99e822509/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/20153a2a-d541-444a-b84b-61f99e822509/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/20153a2a-d541-444a-b84b-61f99e822509"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/20153a2a-d541-444a-b84b-61f99e822509" 695 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/2057ef90-65bd-4f4f-9e2b-c2dcae2b814e"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/2057ef90-65bd-4f4f-9e2b-c2dcae2b814e/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/2057ef90-65bd-4f4f-9e2b-c2dcae2b814e/cover.png"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/2057ef90-65bd-4f4f-9e2b-c2dcae2b814e/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/2057ef90-65bd-4f4f-9e2b-c2dcae2b814e"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/2057ef90-65bd-4f4f-9e2b-c2dcae2b814e" 1.0 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/23eee77e-6ba4-4fb4-85f1-2f287676849d"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/23eee77e-6ba4-4fb4-85f1-2f287676849d/cover.png"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/23eee77e-6ba4-4fb4-85f1-2f287676849d/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/23eee77e-6ba4-4fb4-85f1-2f287676849d"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/23eee77e-6ba4-4fb4-85f1-2f287676849d" 696 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/2a97bcde-a808-48a6-9f02-f177ce49a98c"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/2a97bcde-a808-48a6-9f02-f177ce49a98c/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/2a97bcde-a808-48a6-9f02-f177ce49a98c/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/2a97bcde-a808-48a6-9f02-f177ce49a98c"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/2a97bcde-a808-48a6-9f02-f177ce49a98c" 695 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/2c8cb88f-a784-4c3d-b986-cf08d120e487"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/2c8cb88f-a784-4c3d-b986-cf08d120e487/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/2c8cb88f-a784-4c3d-b986-cf08d120e487/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/2c8cb88f-a784-4c3d-b986-cf08d120e487"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/2c8cb88f-a784-4c3d-b986-cf08d120e487" 696 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/34630ce5-df0b-4fa4-a4da-82dfac207dc6"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/34630ce5-df0b-4fa4-a4da-82dfac207dc6/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/34630ce5-df0b-4fa4-a4da-82dfac207dc6/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/34630ce5-df0b-4fa4-a4da-82dfac207dc6"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/34630ce5-df0b-4fa4-a4da-82dfac207dc6" 696 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/38ea6158-9cb7-4362-a226-098a2c7e5e12"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/38ea6158-9cb7-4362-a226-098a2c7e5e12/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/38ea6158-9cb7-4362-a226-098a2c7e5e12/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/38ea6158-9cb7-4362-a226-098a2c7e5e12"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/38ea6158-9cb7-4362-a226-098a2c7e5e12" 696 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/45003a46-40f9-45a7-92aa-bfc6a5d5759b"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/45003a46-40f9-45a7-92aa-bfc6a5d5759b/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/45003a46-40f9-45a7-92aa-bfc6a5d5759b/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/45003a46-40f9-45a7-92aa-bfc6a5d5759b"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/45003a46-40f9-45a7-92aa-bfc6a5d5759b" 696 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/492e5d53-b2c7-4465-8dbf-437f5178596f"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/492e5d53-b2c7-4465-8dbf-437f5178596f/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/492e5d53-b2c7-4465-8dbf-437f5178596f/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/492e5d53-b2c7-4465-8dbf-437f5178596f"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/492e5d53-b2c7-4465-8dbf-437f5178596f" 696 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/58c15e9a-9cae-4a25-8a53-fad32287d921"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/58c15e9a-9cae-4a25-8a53-fad32287d921/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/58c15e9a-9cae-4a25-8a53-fad32287d921"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/58c15e9a-9cae-4a25-8a53-fad32287d921" 355 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/5aa816a6-3346-4862-97b3-cad59d47304b"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/5aa816a6-3346-4862-97b3-cad59d47304b/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/5aa816a6-3346-4862-97b3-cad59d47304b/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/5aa816a6-3346-4862-97b3-cad59d47304b"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/5aa816a6-3346-4862-97b3-cad59d47304b" 697 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/62a459a3-f196-450b-bc6d-6f7d5ab59761"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/62a459a3-f196-450b-bc6d-6f7d5ab59761/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/62a459a3-f196-450b-bc6d-6f7d5ab59761"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/62a459a3-f196-450b-bc6d-6f7d5ab59761" 355 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/6fbd6b87-86f7-4961-9397-d2e7d8c28b77"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/6fbd6b87-86f7-4961-9397-d2e7d8c28b77/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/6fbd6b87-86f7-4961-9397-d2e7d8c28b77/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/6fbd6b87-86f7-4961-9397-d2e7d8c28b77"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/6fbd6b87-86f7-4961-9397-d2e7d8c28b77" 696 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/7006a751-593b-4f8a-9707-258048cb2ef5"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/7006a751-593b-4f8a-9707-258048cb2ef5/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/7006a751-593b-4f8a-9707-258048cb2ef5"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/7006a751-593b-4f8a-9707-258048cb2ef5" 354 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/88fbbca2-42ab-4149-9128-6cbb9a6a16ba"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/88fbbca2-42ab-4149-9128-6cbb9a6a16ba/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/88fbbca2-42ab-4149-9128-6cbb9a6a16ba"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/88fbbca2-42ab-4149-9128-6cbb9a6a16ba" 354 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/923831e5-8ae2-41c4-954f-a1a36c67c8ae"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/923831e5-8ae2-41c4-954f-a1a36c67c8ae/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/923831e5-8ae2-41c4-954f-a1a36c67c8ae/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/923831e5-8ae2-41c4-954f-a1a36c67c8ae"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/923831e5-8ae2-41c4-954f-a1a36c67c8ae" 695 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/9770a0a7-20ef-446a-b227-3955ca378a37"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/9770a0a7-20ef-446a-b227-3955ca378a37/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/9770a0a7-20ef-446a-b227-3955ca378a37/cover.png"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/9770a0a7-20ef-446a-b227-3955ca378a37/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/9770a0a7-20ef-446a-b227-3955ca378a37"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/9770a0a7-20ef-446a-b227-3955ca378a37" 1.0 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/9839be54-bef6-4ea3-8625-92e2c67760f2"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/9839be54-bef6-4ea3-8625-92e2c67760f2/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/9839be54-bef6-4ea3-8625-92e2c67760f2/cover.png"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/9839be54-bef6-4ea3-8625-92e2c67760f2/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/9839be54-bef6-4ea3-8625-92e2c67760f2"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/9839be54-bef6-4ea3-8625-92e2c67760f2" 1.0 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/a0dcaacb-b04a-4ed7-a86b-7aa3d9e65862"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/a0dcaacb-b04a-4ed7-a86b-7aa3d9e65862/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/a0dcaacb-b04a-4ed7-a86b-7aa3d9e65862/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/a0dcaacb-b04a-4ed7-a86b-7aa3d9e65862"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/a0dcaacb-b04a-4ed7-a86b-7aa3d9e65862" 696 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/a3606d48-ec4c-46e7-ab54-e46fed511d46"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/a3606d48-ec4c-46e7-ab54-e46fed511d46/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/a3606d48-ec4c-46e7-ab54-e46fed511d46/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/a3606d48-ec4c-46e7-ab54-e46fed511d46"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/a3606d48-ec4c-46e7-ab54-e46fed511d46" 694 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/a42dcac0-6134-4690-8697-e03e478c1279"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/a42dcac0-6134-4690-8697-e03e478c1279/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/a42dcac0-6134-4690-8697-e03e478c1279/cover.png"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/a42dcac0-6134-4690-8697-e03e478c1279/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/a42dcac0-6134-4690-8697-e03e478c1279"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/a42dcac0-6134-4690-8697-e03e478c1279" 1.0 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/a53d0018-4e50-4f13-b0ec-a933096d8b29"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/a53d0018-4e50-4f13-b0ec-a933096d8b29/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/a53d0018-4e50-4f13-b0ec-a933096d8b29/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/a53d0018-4e50-4f13-b0ec-a933096d8b29"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/a53d0018-4e50-4f13-b0ec-a933096d8b29" 696 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/b9dd5a49-c1f7-431e-b8e6-69a757243103"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/b9dd5a49-c1f7-431e-b8e6-69a757243103/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/b9dd5a49-c1f7-431e-b8e6-69a757243103/cover.png"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/b9dd5a49-c1f7-431e-b8e6-69a757243103/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/b9dd5a49-c1f7-431e-b8e6-69a757243103"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/b9dd5a49-c1f7-431e-b8e6-69a757243103" 1.0 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/d55fea02-29cb-42e8-b286-a5f4dc43e043"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/d55fea02-29cb-42e8-b286-a5f4dc43e043/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/d55fea02-29cb-42e8-b286-a5f4dc43e043/cover.png"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/d55fea02-29cb-42e8-b286-a5f4dc43e043/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/d55fea02-29cb-42e8-b286-a5f4dc43e043"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/d55fea02-29cb-42e8-b286-a5f4dc43e043" 1.0 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/d9c601c8-c6c1-462e-96b9-cf343398128a"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/d9c601c8-c6c1-462e-96b9-cf343398128a/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/d9c601c8-c6c1-462e-96b9-cf343398128a/cover.png"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/d9c601c8-c6c1-462e-96b9-cf343398128a/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/d9c601c8-c6c1-462e-96b9-cf343398128a"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/d9c601c8-c6c1-462e-96b9-cf343398128a" 1.0 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/e8bd6801-39c3-450f-b3d4-e7945ef24aa8"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/e8bd6801-39c3-450f-b3d4-e7945ef24aa8/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/e8bd6801-39c3-450f-b3d4-e7945ef24aa8/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/e8bd6801-39c3-450f-b3d4-e7945ef24aa8"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/e8bd6801-39c3-450f-b3d4-e7945ef24aa8" 696 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/fe2aea6a-14e7-44e3-ac0c-b37a61d9da05"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/fe2aea6a-14e7-44e3-ac0c-b37a61d9da05/cover.jpg"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/fe2aea6a-14e7-44e3-ac0c-b37a61d9da05"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/fe2aea6a-14e7-44e3-ac0c-b37a61d9da05" 353 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/items/ff71193a-5e1a-4c45-a2d4-46f1af2d5f15"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/ff71193a-5e1a-4c45-a2d4-46f1af2d5f15/cover.jpg"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/items/ff71193a-5e1a-4c45-a2d4-46f1af2d5f15/metadata.abs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items/ff71193a-5e1a-4c45-a2d4-46f1af2d5f15"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items/ff71193a-5e1a-4c45-a2d4-46f1af2d5f15" 697 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/items"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/items" 12.1 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/logs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/logs/daily"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/daily/2023-10-10.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/daily/2023-10-11.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/daily/2023-10-12.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/daily/2023-10-13.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/daily/2023-10-14.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/daily/2023-10-15.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/daily/2023-10-16.txt"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/logs/daily"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/logs/daily" 2.5 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/logs/scans"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2022-10-12_lscan_18ukjnxzw9dswtl1yv.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2022-10-12_lscan_uj25sjpnhgqg0z0z2y.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2022-10-15_lscan_cvovonzj5czskqisni.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2022-10-15_lscan_ytqwy5r8et3b8pmfua.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2023-08-02_0fc1eefe-99c6-41f7-9bee-38be6e66e210.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2023-08-02_cc4b1586-4a5a-4f29-b8e4-89a35c50cf8e.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2023-09-05_310cbf2e-db5b-4dae-be2a-1858092486e9.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2023-09-05_5578c0d8-fea6-43b2-b79b-4c58e6391dfe.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2023-09-05_a8f8f94c-ff29-4e81-8d4e-6385b290af03.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2023-09-05_d0900126-0815-4408-bfcc-3cb88486cff4.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2023-09-05_d27f19b0-6a40-46d1-b4fd-0ddbdcef7109.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2023-09-27_21a7be22-f59f-402e-a116-52aed3412de3.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2023-09-27_76158d27-2ff2-47cf-b036-5e99cffec148.txt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/audiobookshelf/metadata/logs/scans/2023-09-28_dc25a015-6da9-47a6-a5d2-9824c1377ea4.txt"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/logs/scans"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/logs/scans" 5.3 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/logs"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/logs" 678 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/audiobookshelf/metadata/streams"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata/streams"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata/streams" 13 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf/metadata"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf/metadata" 2.3 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/audiobookshelf"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/audiobookshelf" 682 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/autoheal"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/autoheal"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/autoheal" 13 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy/config"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy/config/caddy"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/caddy/config/caddy/autosave.json"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy/config/caddy"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy/config/caddy" 378 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy/config"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy/config" 368 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy/data"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy/data/caddy"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy/data/caddy/certificates"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy/data/caddy/certificates/local"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy/data/caddy/certificates/local/audiobooks-private.deluge.top"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/caddy/data/caddy/certificates/local/audiobooks-private.deluge.top/audiobooks-private.deluge.top.crt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/caddy/data/caddy/certificates/local/audiobooks-private.deluge.top/audiobooks-private.deluge.top.json"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/caddy/data/caddy/certificates/local/audiobooks-private.deluge.top/audiobooks-private.deluge.top.key"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy/data/caddy/certificates/local/audiobooks-private.deluge.top"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy/data/caddy/certificates/local/audiobooks-private.deluge.top" 1.1 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy/data/caddy/certificates/local"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy/data/caddy/certificates/local" 392 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy/data/caddy/certificates"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy/data/caddy/certificates" 368 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy/data/caddy/locks"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy/data/caddy/locks"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy/data/caddy/locks" 13 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy/data/caddy/pki"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy/data/caddy/pki/authorities"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy/data/caddy/pki/authorities/local"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/caddy/data/caddy/pki/authorities/local/intermediate.crt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/caddy/data/caddy/pki/authorities/local/intermediate.key"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/caddy/data/caddy/pki/authorities/local/root.crt"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/caddy/data/caddy/pki/authorities/local/root.key"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy/data/caddy/pki/authorities/local"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy/data/caddy/pki/authorities/local" 1.4 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy/data/caddy/pki/authorities"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy/data/caddy/pki/authorities" 368 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy/data/caddy/pki"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy/data/caddy/pki" 374 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy/data/caddy"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy/data/caddy" 1.1 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy/data"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy/data" 368 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/caddy/etc"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       file: "/docker-data/caddy/etc/Caddyfile"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy/etc"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy/etc" 374 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/caddy"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/caddy" 1.1 kiB
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:52] entering "/docker-data/s3fs"
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data/s3fs"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data/s3fs" 13 B
06:34:49 [TRACE] (1) rustic::archiver::tree_archiver: [src/archiver/tree_archiver.rs:64] finishing "/docker-data"
06:34:49 [DEBUG] (1) rustic::archiver::tree_archiver: new       tree: "/docker-data" 1.4 kiB
06:35:18 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:38] wait timeout exceeded
06:35:18 [TRACE] (3) mio::poll: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/mio-0.8.8/src/poll.rs:662] deregistering event source from poller
06:35:18 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:330] signal: Closed
06:35:18 [WARN] Error error sending request for url (http://127.0.0.1:45679/data/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57): operation timed out at 282.488378ms, retrying
06:35:19 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:35:19 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:42] (ThreadId(12)) park timeout 29.9999985s
06:35:19 [DEBUG] (3) reqwest::connect: starting new connection: http://127.0.0.1:45679/
06:35:19 [TRACE] (3) mio::poll: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/mio-0.8.8/src/poll.rs:531] registering event source with poller: token=Token(16777216), interests=READABLE | WRITABLE
06:35:19 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:35:19 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:355] signal found waiting giver, notifying
06:35:19 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:200] poll_want: taker wants!
06:35:32 [INFO] rclone output: 2023/10/16 06:35:32 ERROR : data/3e/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57: Post request put error: RequestCanceled: request context canceled

06:35:32 [INFO] rclone output: caused by: context canceled

06:35:32 [INFO] rclone output: 2023/10/16 06:35:32 ERROR : data/3e/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57: Post request rcat error: RequestCanceled: request context canceled

06:35:32 [INFO] rclone output: caused by: context canceled

06:35:49 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:38] wait timeout exceeded
06:35:49 [WARN] Error error sending request for url (http://127.0.0.1:45679/data/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57): operation timed out at 763.992828ms, retrying
06:35:49 [TRACE] (3) mio::poll: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/mio-0.8.8/src/poll.rs:662] deregistering event source from poller
06:35:49 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:330] signal: Closed
06:35:49 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:35:49 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:42] (ThreadId(12)) park timeout 29.99999855s
06:35:49 [DEBUG] (3) reqwest::connect: starting new connection: http://127.0.0.1:45679/
06:35:49 [TRACE] (3) mio::poll: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/mio-0.8.8/src/poll.rs:531] registering event source with poller: token=Token(33554432), interests=READABLE | WRITABLE
06:35:49 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:35:49 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:355] signal found waiting giver, notifying
06:35:49 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:200] poll_want: taker wants!
06:35:58 [INFO] rclone output: 2023/10/16 06:35:58 ERROR : data/3e/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57: Post request put error: RequestCanceled: request context canceled

06:35:58 [INFO] rclone output: caused by: context canceled

06:35:58 [INFO] rclone output: 2023/10/16 06:35:58 ERROR : data/3e/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57: Post request rcat error: RequestCanceled: request context canceled

06:35:58 [INFO] rclone output: caused by: context canceled

06:36:19 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:38] wait timeout exceeded
06:36:19 [WARN] Error error sending request for url (http://127.0.0.1:45679/data/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57): operation timed out at 1.558043948s, retrying
06:36:19 [TRACE] (3) mio::poll: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/mio-0.8.8/src/poll.rs:662] deregistering event source from poller
06:36:19 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:330] signal: Closed
06:36:21 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:36:21 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:42] (ThreadId(12)) park timeout 29.99999838s
06:36:21 [DEBUG] (3) reqwest::connect: starting new connection: http://127.0.0.1:45679/
06:36:21 [TRACE] (3) mio::poll: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/mio-0.8.8/src/poll.rs:531] registering event source with poller: token=Token(50331648), interests=READABLE | WRITABLE
06:36:21 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:36:21 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:355] signal found waiting giver, notifying
06:36:21 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:200] poll_want: taker wants!
06:36:29 [INFO] rclone output: 2023/10/16 06:36:29 ERROR : data/3e/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57: Post request put error: RequestCanceled: request context canceled

06:36:29 [INFO] rclone output: caused by: context canceled

06:36:29 [INFO] rclone output: 2023/10/16 06:36:29 ERROR : data/3e/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57: Post request rcat error: RequestCanceled: request context canceled

06:36:29 [INFO] rclone output: caused by: context canceled

06:36:51 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:38] wait timeout exceeded
06:36:51 [WARN] Error error sending request for url (http://127.0.0.1:45679/data/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57): operation timed out at 1.687717613s, retrying
06:36:51 [TRACE] (3) mio::poll: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/mio-0.8.8/src/poll.rs:662] deregistering event source from poller
06:36:51 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:330] signal: Closed
06:36:53 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:16] wait at most 30s
06:36:53 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:42] (ThreadId(12)) park timeout 29.99999861s
06:36:53 [DEBUG] (3) reqwest::connect: starting new connection: http://127.0.0.1:45679/
06:36:53 [TRACE] (3) mio::poll: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/mio-0.8.8/src/poll.rs:531] registering event source with poller: token=Token(67108864), interests=READABLE | WRITABLE
06:36:53 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:341] signal: Want
06:36:53 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:355] signal found waiting giver, notifying
06:36:53 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:200] poll_want: taker wants!
06:37:02 [INFO] rclone output: 2023/10/16 06:37:02 ERROR : data/3e/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57: Post request put error: RequestCanceled: request context canceled

06:37:02 [INFO] rclone output: caused by: context canceled

06:37:02 [INFO] rclone output: 2023/10/16 06:37:02 ERROR : data/3e/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57: Post request rcat error: RequestCanceled: request context canceled

06:37:02 [INFO] rclone output: caused by: context canceled

06:37:23 [TRACE] (12) reqwest::blocking::wait: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/reqwest-0.11.18/src/blocking/wait.rs:38] wait timeout exceeded
06:37:23 [WARN] Error error sending request for url (http://127.0.0.1:45679/data/3e40801fddf67af33eea6123c4756cf6656a280ae83358a12a74929f9e9cff57): operation timed out at 1.431723163s, retrying
06:37:23 [TRACE] (3) mio::poll: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/mio-0.8.8/src/poll.rs:662] deregistering event source from poller
06:37:23 [TRACE] (3) want: [/home/runner/.cargo/registry/src/index.crates.io-6f17d22bba15001f/want-0.3.0/src/lib.rs:330] signal: Closed

@aawsome
Copy link
Member

aawsome commented Oct 17, 2023

Which version of rustic are you using? This seems like a timeout problem which has been already resolved in the current beta version, but is still present in 0.5.4...

@aawsome
Copy link
Member

aawsome commented Oct 17, 2023

Maybe related: #683, #720

Can you try if the error still occurs with the latest beta version?

If yes, can you increase the rclone verbosity to see why rclone stops working? Which backend are you actually using? Searching for the rclone error I only found https://forum.rclone.org/t/connection-reset-context-canceled/22941 which indicates similar problems with jottacloud...

@rehanone
Copy link
Author

@aawsome , I do not see the beta version on the releases page on github. I have this same issue happing on another VM now which may indicate that something in this repo is causing it?

@aawsome
Copy link
Member

aawsome commented Oct 17, 2023

The nightly builds are available here: https://github.com/rustic-rs/nightly

Your repository is perfectly fine (if check doesn't complain...), however rustic isn't able to upload a pack file - either rclone isn't able to upload it or rustic terminates the upload before rclone is able to finish. In the second case, this is a rustic bug which should have been fixed in the nightly builds.

@rehanone
Copy link
Author

The nightly version seams to have fixed the issue. :) Is there any release plan?

@aawsome
Copy link
Member

aawsome commented Oct 18, 2023

Actually, 0.6.0 is due since a couple of week - I'm unfortunately only missing the time to finally release it. So, I hope it will be very soon...

@aawsome
Copy link
Member

aawsome commented Oct 23, 2023

Closing this issue as 0.6.0 is just released. Binaries will also be available soon...

@aawsome aawsome closed this as completed Oct 23, 2023
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
S-triage Status: Waiting for a maintainer to triage this issue/PR
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@rehanone @aawsome