"Unexpected number of remote volumes marked as deleted" error

[jerrac]

Well, I finally had time to get back to this issue.

I went ahead and upgraded to v2.0.2.15-2.0.2.15_experimental_2018-01-03 downloaded from GitHub.

I moved the old database and ran the repair operation from the command line. It completed successfully, except for these messages partway through:

Operation Get with file duplicati-20170611T183256Z.dlist.zip.aes attempt 1 of 5 failed with message: File length is invalid => File length is invalid
  Downloading file (40.42 MB) ...
Operation Get with file duplicati-20170611T183256Z.dlist.zip.aes attempt 2 of 5 failed with message: File length is invalid => File length is invalid
  Downloading file (40.42 MB) ...
Operation Get with file duplicati-20170611T183256Z.dlist.zip.aes attempt 3 of 5 failed with message: File length is invalid => File length is invalid
  Downloading file (40.42 MB) ...
Operation Get with file duplicati-20170611T183256Z.dlist.zip.aes attempt 4 of 5 failed with message: File length is invalid => File length is invalid
  Downloading file (40.42 MB) ...
Operation Get with file duplicati-20170611T183256Z.dlist.zip.aes attempt 5 of 5 failed with message: File length is invalid => File length is invalid
  Downloading file (41.32 MB) ...
Failed to process file: duplicati-20170611T183256Z.dlist.zip.aes => File length is invalid

It ended with this:

Processing required 1 blocklist volumes
  Downloading file (49.99 MB) ...
Recreate completed, verifying the database consistency
Recreate completed, and consistency checks completed, marking database as complete

Then I ran a backup, and received the same error as before.

Here is the error message again. Just in case there’s something different I didn’t spot.

Fatal error => Unexpected number of remote volumes marked as deleted. Found 0 filesets, but 1 volumes

System.Exception: Unexpected number of remote volumes marked as deleted. Found 0 filesets, but 1 volumes
  at Duplicati.Library.Main.Database.LocalDeleteDatabase+<DropFilesetsFromTable>d__5.MoveNext () [0x00252] in <ab07a85a74244406aaefc2202f7e530f>:0 
  at System.Collections.Generic.LargeArrayBuilder`1[T].AddRange (System.Collections.Generic.IEnumerable`1[T] items) [0x0005e] in <521f3fe476f34ea88748e97b3b984d05>:0 
  at System.Collections.Generic.EnumerableHelpers.ToArray[T] (System.Collections.Generic.IEnumerable`1[T] source) [0x00033] in <521f3fe476f34ea88748e97b3b984d05>:0 
  at System.Linq.Enumerable.ToArray[TSource] (System.Collections.Generic.IEnumerable`1[T] source) [0x00018] in <521f3fe476f34ea88748e97b3b984d05>:0 
  at Duplicati.Library.Main.Operation.DeleteHandler.DoRun (Duplicati.Library.Main.Database.LocalDeleteDatabase db, System.Data.IDbTransaction& transaction, System.Boolean hasVerifiedBacked, System.Boolean forceCompact, Duplicati.Library.Main.BackendManager sharedManager) [0x00169] in <ab07a85a74244406aaefc2202f7e530f>:0 
  at Duplicati.Library.Main.Operation.BackupHandler.CompactIfRequired (Duplicati.Library.Main.BackendManager backend, System.Int64 lastVolumeSize) [0x000a5] in <ab07a85a74244406aaefc2202f7e530f>:0 
  at Duplicati.Library.Main.Operation.BackupHandler.Run (System.String[] sources, Duplicati.Library.Utility.IFilter filter) [0x008a5] in <ab07a85a74244406aaefc2202f7e530f>:0 
  at Duplicati.Library.Main.Controller+<>c__DisplayClass17_0.<Backup>b__0 (Duplicati.Library.Main.BackupResults result) [0x00036] in <ab07a85a74244406aaefc2202f7e530f>:0 
  at Duplicati.Library.Main.Controller.RunAction[T] (T result, System.String[]& paths, Duplicati.Library.Utility.IFilter& filter, System.Action`1[T] method) [0x0014b] in <ab07a85a74244406aaefc2202f7e530f>:0 
  at Duplicati.Library.Main.Controller.Backup (System.String[] inputsources, Duplicati.Library.Utility.IFilter filter) [0x00068] in <ab07a85a74244406aaefc2202f7e530f>:0 
  at Duplicati.CommandLine.Commands.Backup (System.IO.TextWriter outwriter, System.Action`1[T] setup, System.Collections.Generic.List`1[T] args, System.Collections.Generic.Dictionary`2[TKey,TValue] options, Duplicati.Library.Utility.IFilter filter) [0x000ee] in <4d8cdd60210946ec8cc8a22c1148fc2f>:0 
  at (wrapper delegate-invoke) System.Func`6[System.IO.TextWriter,System.Action`1[Duplicati.Library.Main.Controller],System.Collections.Generic.List`1[System.String],System.Collections.Generic.Dictionary`2[System.String,System.String],Duplicati.Library.Utility.IFilter,System.Int32]:invoke_TResult_T1_T2_T3_T4_T5 (System.IO.TextWriter,System.Action`1<Duplicati.Library.Main.Controller>,System.Collections.Generic.List`1<string>,System.Collections.Generic.Dictionary`2<string, string>,Duplicati.Library.Utility.IFilter)
  at Duplicati.CommandLine.Program.RunCommandLine (System.IO.TextWriter outwriter, System.IO.TextWriter errwriter, System.Action`1[T] setup, System.String[] args) [0x003fb] in <4d8cdd60210946ec8cc8a22c1148fc2f>:0 

If you need the rest of the output for some reason, I have saved it.

@JonMikelV

This is odd because code wise this should only happen if Duplicati is interrupted exactly during this block of code. Do you recall a power outage or system crash that might have happened just before you started getting this?

It’s been months since this started happening, so I don’t remember. I actually have the exact same data being backed up to Google Drive in another job. So it hasn’t been on the top of my priority list. (The data is in a work account, so I want a local backup. Plus, I have yet to figure out why my internet connection starts losing packets whenever I try to backup to Google drive here at home. It works fine from work…)