Verifying files stage is very slow (Hours processing dlist files)

One of my backups seems to have an issue.

The backup runs along and things seem to be reasonable in time with every stage of the backup. Until it hits “verifying files”. This, I believe, is the stage where it samples a certain amount of files on the remote to check what they contain is what is expected.

Something seems very wrong. Here is the log. I’ve abridged The parts which seem to be running at normal speed Just to give you an idea of the times involved.


KEY
######        = ABRIDGED
### TEXT ###  = COMMENTS

### BACKUP START ###

2026-01-09 14:01:44 +00 - [Information-Duplicati.Library.Main.Controller-StartingOperation]: The operation Backup has started
2026-01-09 14:01:44 +00 - [Verbose-Duplicati.Library.SQLiteHelper.SQLiteLoader-CustomSQLiteOption]: Setting custom SQLite option 'cache_size=-669696'.
2026-01-09 14:16:58 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started:  ()
2026-01-09 14:17:02 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed:  (48.25 KiB)
2026-01-09 14:17:02 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: QuotaInfo - Started:  ()
2026-01-09 14:17:31 +00 - [Verbose-Duplicati.Library.Main.Operation.Backup.FileEnumerationProcess-IncludingPath]: Including path as no filters matched: X:\snapraid.content
2026-01-09 14:17:31 +00 - [Verbose-Duplicati.Library.Main.Operation.Backup.FileEnumerationProcess-ExcludingPathFromAttributes]: Excluding path due to attribute filter: X:\$RECYCLE.BIN

######

2026-01-09 14:25:24 +00 - [Verbose-Duplicati.Library.Main.Operation.Backup.FilePreFilterProcess.FileEntry-SkipCheckNoMetadataChange]: Skipped checking file, because no metadata was updated W:\PoolPart.ecbd5f51-9237-44aa-9cbc-b53fa65d09fe\Anonomus (E).xxh3
2026-01-09 14:25:24 +00 - [Verbose-Duplicati.Library.Main.Operation.Backup.FilePreFilterProcess.FileEntry-SkipCheckNoMetadataChange]: Skipped checking file, because no metadata was updated W:\snapraid.content

### START OF DBLOCK <PUT> ### 

2026-01-09 14:25:49 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-babcba20d1f3f4c1a81e3c5f7ce3cfecd.dblock.zip.aes (49.02 MiB)
2026-01-09 14:25:49 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-babcba20d1f3f4c1a81e3c5f7ce3cfecd.dblock.zip.aes (49.02 MiB)

######

2026-01-09 14:26:43 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-b68178442f9534fd789d99ddf244f729f.dblock.zip.aes (49.01 MiB)
2026-01-09 14:26:43 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-bca71a63f99834bbb96562e6739fd087e.dblock.zip.aes (49.08 MiB)

### START OF DINDEX <PUT> ###

2026-01-09 14:26:43 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-i6230cdce32804007885d4ca871acf585.dindex.zip.aes (2.54 KiB)
2026-01-09 14:26:43 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-i6230cdce32804007885d4ca871acf585.dindex.zip.aes (2.54 KiB)

######

2026-01-09 14:27:02 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-i0dca73ceaf0e405d8ced58e6d8ed1e32.dindex.zip.aes (1.43 KiB)
2026-01-09 14:27:02 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-i0dca73ceaf0e405d8ced58e6d8ed1e32.dindex.zip.aes (1.43 KiB)

### START OF DLIST <PUT> ### 

2026-01-09 14:27:59 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Started: duplicati-20260109T140144Z.dlist.zip.aes (116.44 MiB)
2026-01-09 14:27:59 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Put - Completed: duplicati-20260109T140144Z.dlist.zip.aes (116.44 MiB)

### START OF VERIFYING FILES ###

2026-01-09 14:27:59 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started:  ()
2026-01-09 14:27:59 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Completed:  (48.34 KiB)
2026-01-09 14:28:00 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: QuotaInfo - Started:  ()

### START OF DLIST <GET> ###

###
TAKE NOTE OF THIS SECTION... I've included all entries to show you the time it's taking on each dlist file and how long the entire process is taking.
###

2026-01-09 14:28:00 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20260109T140144Z.dlist.zip.aes (116.44 MiB)
2026-01-09 14:28:00 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20260109T140144Z.dlist.zip.aes (116.44 MiB)
2026-01-09 14:28:00 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250917T120738Z.dlist.zip.aes (112.89 MiB)
2026-01-09 14:28:04 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250917T120738Z.dlist.zip.aes (112.89 MiB)
2026-01-09 14:38:32 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250918T120731Z.dlist.zip.aes (112.89 MiB)
2026-01-09 14:38:36 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250918T120731Z.dlist.zip.aes (112.89 MiB)
2026-01-09 14:46:56 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20251013T122222Z.dlist.zip.aes (112.90 MiB)
2026-01-09 14:47:01 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20251013T122222Z.dlist.zip.aes (112.90 MiB)
2026-01-09 14:55:17 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250508T120802Z.dlist.zip.aes (196.53 MiB)
2026-01-09 14:55:24 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250508T120802Z.dlist.zip.aes (196.53 MiB)
2026-01-09 15:03:29 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250924T120900Z.dlist.zip.aes (112.89 MiB)
2026-01-09 15:03:34 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250924T120900Z.dlist.zip.aes (112.89 MiB)
2026-01-09 15:12:28 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250702T120328Z.dlist.zip.aes (196.55 MiB)
2026-01-09 15:12:33 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250702T120328Z.dlist.zip.aes (196.55 MiB)
2026-01-09 15:20:55 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250708T120351Z.dlist.zip.aes (196.55 MiB)
2026-01-09 15:21:01 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250708T120351Z.dlist.zip.aes (196.55 MiB)
2026-01-09 15:29:44 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250715T120428Z.dlist.zip.aes (196.65 MiB)
2026-01-09 15:29:50 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250715T120428Z.dlist.zip.aes (196.65 MiB)
2026-01-09 15:38:55 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20251107T120813Z.dlist.zip.aes (112.91 MiB)
2026-01-09 15:39:00 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20251107T120813Z.dlist.zip.aes (112.91 MiB)
2026-01-09 15:48:02 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250909T120717Z.dlist.zip.aes (112.88 MiB)
2026-01-09 15:48:06 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250909T120717Z.dlist.zip.aes (112.88 MiB)
2026-01-09 15:56:21 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20251126T122423Z.dlist.zip.aes (112.54 MiB)
2026-01-09 15:56:26 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20251126T122423Z.dlist.zip.aes (112.54 MiB)
2026-01-09 16:05:09 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20251221T041102Z.dlist.zip.aes (112.54 MiB)
2026-01-09 16:05:13 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20251221T041102Z.dlist.zip.aes (112.54 MiB)
2026-01-09 16:13:08 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20251113T130859Z.dlist.zip.aes (112.54 MiB)
2026-01-09 16:13:13 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20251113T130859Z.dlist.zip.aes (112.54 MiB)
2026-01-09 16:21:07 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20251111T121459Z.dlist.zip.aes (187.70 MiB)
2026-01-09 16:21:13 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20251111T121459Z.dlist.zip.aes (187.70 MiB)
2026-01-09 16:29:04 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20251202T140913Z.dlist.zip.aes (112.54 MiB)
2026-01-09 16:29:11 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20251202T140913Z.dlist.zip.aes (112.54 MiB)
2026-01-09 16:36:54 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250617T120303Z.dlist.zip.aes (196.54 MiB)
2026-01-09 16:37:00 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250617T120303Z.dlist.zip.aes (196.54 MiB)
2026-01-09 16:45:05 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250615T120255Z.dlist.zip.aes (196.54 MiB)
2026-01-09 16:45:13 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250615T120255Z.dlist.zip.aes (196.54 MiB)
2026-01-09 16:54:10 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20251226T122314Z.dlist.zip.aes (112.54 MiB)
2026-01-09 16:54:14 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20251226T122314Z.dlist.zip.aes (112.54 MiB)
2026-01-09 17:03:07 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20260101T122249Z.dlist.zip.aes (112.54 MiB)
2026-01-09 17:03:12 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20260101T122249Z.dlist.zip.aes (112.54 MiB)
2026-01-09 17:11:15 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250916T120825Z.dlist.zip.aes (112.89 MiB)
2026-01-09 17:11:19 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250916T120825Z.dlist.zip.aes (112.89 MiB)
2026-01-09 17:19:23 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20251002T120642Z.dlist.zip.aes (112.90 MiB)
2026-01-09 17:19:26 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20251002T120642Z.dlist.zip.aes (112.90 MiB)
2026-01-09 17:27:52 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250720T120412Z.dlist.zip.aes (196.65 MiB)
2026-01-09 17:27:58 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250720T120412Z.dlist.zip.aes (196.65 MiB)
2026-01-09 17:36:02 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250530T120238Z.dlist.zip.aes (196.47 MiB)
2026-01-09 17:36:09 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250530T120238Z.dlist.zip.aes (196.47 MiB)
2026-01-09 17:44:49 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-20250516T120208Z.dlist.zip.aes (196.47 MiB)
2026-01-09 17:44:56 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-20250516T120208Z.dlist.zip.aes (196.47 MiB)

### START OF DINDEX <GET> ### 

2026-01-09 17:54:08 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-i7afa1bceb8504d90b7fb72a1aea26d41.dindex.zip.aes (2.54 KiB)
2026-01-09 17:54:08 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-i7afa1bceb8504d90b7fb72a1aea26d41.dindex.zip.aes (2.54 KiB)

######

2026-01-09 18:03:13 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-i8177abda9ba14f07b37f56f0e5bdfa5a.dindex.zip.aes (2.75 KiB)
2026-01-09 18:03:13 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-i8177abda9ba14f07b37f56f0e5bdfa5a.dindex.zip.aes (2.75 KiB)

### START OF DBLOCK <GET> ###

2026-01-09 18:03:13 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-bc7863287ea7440048c5195d2d4e40b0d.dblock.zip.aes (49.01 MiB)
2026-01-09 18:03:15 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-bc7863287ea7440048c5195d2d4e40b0d.dblock.zip.aes (49.01 MiB)

######

2026-01-09 18:04:05 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Started: duplicati-bd057a789355140f1afc87c00ca1ca98b.dblock.zip.aes (49.07 MiB)
2026-01-09 18:04:07 +00 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: Get - Completed: duplicati-bd057a789355140f1afc87c00ca1ca98b.dblock.zip.aes (49.07 MiB)
2026-01-09 18:04:07 +00 - [Information-Duplicati.Library.Main.Operation.TestHandler-Test results]: Successfully verified 75 remote files
2026-01-09 18:04:08 +00 - [Verbose-Duplicati.Library.SQLiteHelper.SQLiteLoader-CustomSQLiteOption]: Setting custom SQLite option 'cache_size=-669696'.
2026-01-09 18:04:08 +00 - [Verbose-Duplicati.Library.SQLiteHelper.SQLiteLoader-CustomSQLiteOption]: Setting custom SQLite option 'cache_size=-669696'.
2026-01-09 18:04:08 +00 - [Verbose-Duplicati.Library.SQLiteHelper.SQLiteLoader-CustomSQLiteOption]: Setting custom SQLite option 'cache_size=-669696'.
2026-01-09 18:07:32 +00 - [Information-Duplicati.Library.Main.Controller-CompletedOperation]: The operation Backup has completed