The support forum

Retry on USB source momentary disconnects?

matt-wilkie :

Sep 13, 2019

I'm trying to do a one time backup (mirror) from an external USB3 mounted hard drive to an internal SATA drive. The connection to the USB drive keeps dropping during the copy. It's restored very quickly, without any action on my part, but by that time Bvckup2 has aborted. It's not a Bv2 specific problem. I experience the same problem with the same devices when using FreeFileSync.

Is there way to get Bv2 to wait a few moments and then try again, without restarting the whole job? It takes about 6 minutes to do the Preparing stage and only 1 or 2 minutes on copying before it aborts again.

I've read about the retry on network drops and timeouts, https://bvckup2.com/wip/23042018, can that be pressed into service here somehow?

2019.09.12 21:08:24.380 (UTC-8) 3 3             Details
2019.09.12 21:08:24.380 (UTC-8) 3 4                 Source: 90.02 MB, created 2015.03.27 17:23:50.054, modified 2015.03.27 17:22:41.000, archive
2019.09.12 21:08:24.380 (UTC-8) 3 5                     Raw: 94396696 / 130719758300546024 / 130719757610000000 / 00000020 / b77e0263879be7de / [com.dropbox.attributes, 213]
2019.09.12 21:08:24.380 (UTC-8) 3 4                 Backup: 90.02 MB, created 2019.09.12 21:00:30.899, modified 2019.09.12 21:00:30.899, (no attributes)
2019.09.12 21:08:24.380 (UTC-8) 3 5                     Raw: 94396696 / 16975111 / 132128208308990754 / 00000000
2019.09.12 21:08:24.421 (UTC-8) 3 3             Partially processed file
2019.09.12 21:08:24.421 (UTC-8) 3 4                 Source: 94396696, 2015.03.27 17:23:50.054, 2015.03.27 17:22:41.000, 39845888, 0x01
2019.09.12 21:08:24.421 (UTC-8) 3 4                 Backup: 94396696, 2019.09.12 21:00:30.899, 2019.09.12 21:00:30.899, 39845888 / 608, 0x08000000, 0
2019.09.12 21:08:24.421 (UTC-8) 3 5                     Write log: 0-607
2019.09.12 21:08:24.421 (UTC-8) 2 3             Resuming copying at 39845888...
2019.09.12 21:08:24.421 (UTC-8) 3 4                 Stop mask from the last time: read
2019.09.12 21:08:50.443 (UTC-8) 0 3             ReadFileAsync() failed with 433
2019.09.12 21:08:50.443 (UTC-8) 3 4                 Context: 39845888 2097152
2019.09.12 21:08:50.545 (UTC-8) 3 3             Details
2019.09.12 21:08:50.545 (UTC-8) 3 4                 Source: 137.52 MB, created 2015.03.27 17:13:20.863, modified 2015.03.27 17:11:55.000, archive
2019.09.12 21:08:50.545 (UTC-8) 3 5                     Raw: 144199329 / 130719752008637307 / 130719751150000000 / 00000020 / b77e0263879be7de / [com.dropbox.attributes, 210]
2019.09.12 21:08:50.545 (UTC-8) 3 4                 Backup: 137.52 MB, created 2015.03.27 17:13:20.863, modified 2015.03.27 17:11:55.000, archive
2019.09.12 21:08:50.545 (UTC-8) 3 5                     Raw: 144199329 / 130719752008637307 / 130719751150000000 / 00000020 / 349ad4d7cec3ec7e / [com.dropbox.attributes, 210]
2019.09.12 21:08:50.545 (UTC-8) 3 3             Updating: last-modified timestamp, owner, group, DACL
2019.09.12 21:08:50.545 (UTC-8) 0 4                 Error: path not found
2019.09.12 21:08:50.545 (UTC-8) 3 5                     CreateFile() failed with 3
2019.09.12 21:08:50.545 (UTC-8) 3 6                         Context: \\?\E:\Dropbox_volumes\Matt\Aikido\Videos\Sensei Toshiro Suga, Uke Jaff Ragi, Didier Cagnet (1988).mp4 00020080 00000003 00000003 02000000
2019.09.12 21:08:50.549 (UTC-8) 0 2         Backup aborted
2019.09.12 21:08:51.820 (UTC-8) 2 1     Completed in 6 min 46 sec with 3 errors
2019.09.12 21:08:51.820 (UTC-8) 3 2         Read 67.31 KB, wrote 67.31 KB
2019.09.12 21:08:51.916 (UTC-8) 2 0 Source local drive is no longer present
2019.09.12 21:08:59.388 (UTC-8) 2 0 Source local drive is present

matt-wilkie :

Sep 13, 2019

I have it working now! My last sentence provided the clue: access the external drive with \\localhost\e$\path and edit the engine.ini file as per https://bvckup2.com/support/forum/topic/857

Here's my added INI settings (they weren't present at all before):

errors.exec.retry.count                            20
errors.exec.retry.pause                            650 ms
errors.exec.retry.inclusive                        0
errors.exec.retry.error                            3
errors.exec.retry.error                            433


So far I haven't seen any failures in the log that needed more than 2 retries to be successful (https://i.imgur.com/hzdAIrh.png). Of the 14 disconnect events in the last 17 minutes 9 succeeded on 1st retry, 4 and 2nd, and only 1 needed a 3rd. All were eventually successful.

matt-wilkie :

Sep 13, 2019

*Correction*: it's not necessary to use a localhost network path. I cloned my backup jobs and then got mixed up about which was which. All that is needed is the correct error codes to retry on.

Alex Pankratov :

Sep 13, 2019



That's a clever workaround with using network path! Very clever.

However the 'errors.exec.retry.error' override is the right way to do it. Cheers for reading the documentation and figuring it out on your own. I am not-so-mildly impressed :)

Alex Pankratov :

Oct 07, 2019



Matt, can I ask what is the exact drive model?

Another case surfaced with this exact profile, and I strongly suspect that it's the exact drive model. This is because the error itself is undocumented (meaning that it's likely to be vendor-specific) and because of the timing, which may imply a buggy driver/firmware update going out recently.

PS. Oh, and in this new case the drive is actually (a) self-ejecting and (b) in 4 minutes. Do you remember the timing on yours?

jeremy :

Oct 16, 2019

hey matt and alex,

i am the other matching profile, but not finding any success with the retry on errors method...

INI settings (also were not present before i added manually)
errors.exec.retry.count 20
errors.exec.retry.pause 1 min
errors.exec.retry.inclusive 1

- source and destination drives are both: Seagate 4000GB model: ST40000DM000 (connected by USB3 and the only drives docked inside of the 4-bay enclosure)

- drive bay is: Mediasonic PROBOX 4 Bay 3.5" SATA - USB 3.0 + eSATA (HF7-SU3S3)

- repeated error message:  FindFirstFileEx() failed with 433

log:
Using 3 threads, depth first, basic info, large fetch
Excluded: $RECYCLE.BIN
Excluded: _PHOTOS 2008 - 2019 [F]
Excluded: System Volume Information
Completed in 2 min 6 sec
46864 folders, 192653 files, 2.04 TB
Scanning destination ...
Setup
Using 3 threads, depth first, basic info, large fetch
Excluded: $RECYCLE.BIN
Excluded: System Volume Information
FindFirstFileEx() failed with 433
Context: G:\_PHOTOS 2008 - 2019\photos of 2016\Dumke 40th Anniversary\1-Assets\NG\
Will retry in 1 min, attempt 1 out of 5...

New topic

Create
Made by IO Bureau in Switzerland
Support

Updates
Blog / RSS
Follow Twitter
Reddit
Miscellanea Press kit
Testimonials
Company Imprint

Legal Terms
Privacy