Save(<data/6df1702ff4>) returned error, retrying after 552.330144ms: open/sync …

Getting Help
1

Hi,

my latest backup (on Windows) to an external SSD has run as follows:

e:\>restic_0.13.0_windows_amd64.exe backup --cache-dir MY_CACHE_DIR\ -r MY_REPO_DIR\ --tag 1ST_TAG --tag 2ND_TAG --tag 3RD_TAG  DIR_TO_BACKUP\
enter password for repository:
repository 67255874 opened successfully, password is correct
created new cache in MY_CACHE_DIR
using parent snapshot 026a052b
error: Open: open \\?\DIR_TO_BACKUP\System Volume Information: Zugriff verweigert
Save(<data/6df1702ff4>) returned error, retrying after 552.330144ms: open MY_REPO_DIR\data\6d\6df1702ff49a95c810f8f9820ee641ecbd8afddeeb7a216a12c3bcdff0def14a-tmp-3349639758: Ein nicht vorhandenes Gerät wurde angegeben.SOME_FILE_TO_BACKUP
Save(<data/c1c59b5418>) returned error, retrying after 582.280027ms: open MY_REPO_DIR\data\c1\c1c59b54186de8f365b98a26840defe2f917d6b5c641a8691309e20a84123720-tmp-1862571922: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/f209f18896>) returned error, retrying after 720.254544ms: open MY_REPO_DIR\data\f2\f209f188967a722482508122e494a3a83f5bfc292cf7abc3b516db8bc515b7a9-tmp-2820108750: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/5f10519134>) returned error, retrying after 468.857094ms: sync MY_REPO_DIR\data\5f\5f10519134056479d44d6e797aa37cd268cf20b659603c1134bdf1ac278ff340-tmp-2804972403: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/2c6302293c>) returned error, retrying after 462.318748ms: sync MY_REPO_DIR\data\2c\2c6302293c7b4da6705b201f01964cbf3e7ebedf315984bdb461b72a8ec01595-tmp-2182071243: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/d600c09134>) returned error, retrying after 593.411537ms: sync MY_REPO_DIR\data\d6\d600c091348b82fea0f2298cbe26c38376adc6f6cb8efd68eaf1deb63b35e428-tmp-2230320151: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/d6ff1b6dbb>) returned error, retrying after 282.818509ms: sync MY_REPO_DIR\data\d6\d6ff1b6dbb4c004a890a8cff95fd2ea6c81e971cc031d1323a583dea63d66476-tmp-2544796838: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/708cd5fc8f>) returned error, retrying after 328.259627ms: sync MY_REPO_DIR\data\70\708cd5fc8f0ac0c9cae8707cdbefd117456f784feba776e1d7d9e772049ab528-tmp-3968498597: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/d6e1f32427>) returned error, retrying after 298.484759ms: sync MY_REPO_DIR\data\d6\d6e1f32427a4973e3bfd030b39857395db8a8195d7d9ac57826c854411de3342-tmp-2201008789: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/718e424bac>) returned error, retrying after 400.45593ms: sync MY_REPO_DIR\data\71\718e424bacd96b9e2992242591edd4914608e7e8d06524cf9d220117a266cca0-tmp-503120676: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/66b414b8cb>) returned error, retrying after 507.606314ms: sync MY_REPO_DIR\data\66\66b414b8cbc7f10eb4e6c27fad55d24764dfdfff214473c1fa9312207af908f4-tmp-722015488: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/d6ff1b6dbb>) returned error, retrying after 985.229971ms: sync MY_REPO_DIR\data\d6\d6ff1b6dbb4c004a890a8cff95fd2ea6c81e971cc031d1323a583dea63d66476-tmp-2553839897: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/d6e1f32427>) returned error, retrying after 535.697904ms: sync MY_REPO_DIR\data\d6\d6e1f32427a4973e3bfd030b39857395db8a8195d7d9ac57826c854411de3342-tmp-918668207: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/708cd5fc8f>) returned error, retrying after 660.492892ms: sync MY_REPO_DIR\data\70\708cd5fc8f0ac0c9cae8707cdbefd117456f784feba776e1d7d9e772049ab528-tmp-3939076264: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/718e424bac>) returned error, retrying after 613.543631ms: sync MY_REPO_DIR\data\71\718e424bacd96b9e2992242591edd4914608e7e8d06524cf9d220117a266cca0-tmp-4094187436: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/2c6302293c>) returned error, retrying after 726.667384ms: sync MY_REPO_DIR\data\2c\2c6302293c7b4da6705b201f01964cbf3e7ebedf315984bdb461b72a8ec01595-tmp-3714577359: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/5f10519134>) returned error, retrying after 587.275613ms: sync MY_REPO_DIR\data\5f\5f10519134056479d44d6e797aa37cd268cf20b659603c1134bdf1ac278ff340-tmp-1164692297: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/66b414b8cb>) returned error, retrying after 594.826393ms: sync MY_REPO_DIR\data\66\66b414b8cbc7f10eb4e6c27fad55d24764dfdfff214473c1fa9312207af908f4-tmp-3938848246: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/6df1702ff4>) returned error, retrying after 884.313507ms: open MY_REPO_DIR\data\6d\6df1702ff49a95c810f8f9820ee641ecbd8afddeeb7a216a12c3bcdff0def14a-tmp-904534454: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/c1c59b5418>) returned error, retrying after 538.914789ms: sync MY_REPO_DIR\data\c1\c1c59b54186de8f365b98a26840defe2f917d6b5c641a8691309e20a84123720-tmp-4292072526: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/d600c09134>) returned error, retrying after 527.390157ms: sync MY_REPO_DIR\data\d6\d600c091348b82fea0f2298cbe26c38376adc6f6cb8efd68eaf1deb63b35e428-tmp-2936972869: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/f209f18896>) returned error, retrying after 645.653563ms: open MY_REPO_DIR\data\f2\f209f188967a722482508122e494a3a83f5bfc292cf7abc3b516db8bc515b7a9-tmp-2082923776: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/d6e1f32427>) returned error, retrying after 1.204507436s: sync MY_REPO_DIR\data\d6\d6e1f32427a4973e3bfd030b39857395db8a8195d7d9ac57826c854411de3342-tmp-4003664022: Ein nicht vorhandenes Gerät wurde angegeben.SOME_FILE_TO_BACKUP
Save(<data/708cd5fc8f>) returned error, retrying after 1.532802867s: sync MY_REPO_DIR\data\70\708cd5fc8f0ac0c9cae8707cdbefd117456f784feba776e1d7d9e772049ab528-tmp-2446290647: Ein nicht vorhandenes Gerät wurde angegeben.
Save(<data/718e424bac>) returned error, retrying after 892.253525ms: open MY_REPO_DIR\data\71\718e424bacd96b9e2992242591edd4914608e7e8d06524cf9d220117a266cca0-tmp-677553600: Zugriff verweigert
Save(<data/5f10519134>) returned error, retrying after 896.717884ms: open MY_REPO_DIR\data\5f\5f10519134056479d44d6e797aa37cd268cf20b659603c1134bdf1ac278ff340-tmp-738546655: Das System kann den angegebenen Pfad nicht finden.
Save(<data/66b414b8cb>) returned error, retrying after 1.409144665s: open MY_REPO_DIR\data\66\66b414b8cbc7f10eb4e6c27fad55d24764dfdfff214473c1fa9312207af908f4-tmp-1019629552: Das System kann den angegebenen Pfad nicht finden.
Save(<data/c1c59b5418>) returned error, retrying after 794.905494ms: open MY_REPO_DIR\data\c1\c1c59b54186de8f365b98a26840defe2f917d6b5c641a8691309e20a84123720-tmp-2832053544: Das System kann den angegebenen Pfad nicht finden.
Save(<data/d600c09134>) returned error, retrying after 1.53600189s: open MY_REPO_DIR\data\d6\d600c091348b82fea0f2298cbe26c38376adc6f6cb8efd68eaf1deb63b35e428-tmp-1644103526: Das System kann den angegebenen Pfad nicht finden.
Save(<data/2c6302293c>) returned error, retrying after 1.346309062s: open MY_REPO_DIR\data\2c\2c6302293c7b4da6705b201f01964cbf3e7ebedf315984bdb461b72a8ec01595-tmp-626308927: Das System kann den angegebenen Pfad nicht finden.
Save(<data/d6ff1b6dbb>) returned error, retrying after 1.151797844s: open MY_REPO_DIR\data\d6\d6ff1b6dbb4c004a890a8cff95fd2ea6c81e971cc031d1323a583dea63d66476-tmp-575479102: Das System kann den angegebenen Pfad nicht finden.
Save(<data/f209f18896>) returned error, retrying after 594.340968ms: open MY_REPO_DIR\data\f2\f209f188967a722482508122e494a3a83f5bfc292cf7abc3b516db8bc515b7a9-tmp-294705273: Das System kann den angegebenen Pfad nicht finden.
Save(<data/6df1702ff4>) returned error, retrying after 740.619312ms: open MY_REPO_DIR\data\6d\6df1702ff49a95c810f8f9820ee641ecbd8afddeeb7a216a12c3bcdff0def14a-tmp-1126111569: Das System kann den angegebenen Pfad nicht finden.
Save(<data/c1c59b5418>) returned error, retrying after 1.868490179s: open MY_REPO_DIR\data\c1\c1c59b54186de8f365b98a26840defe2f917d6b5c641a8691309e20a84123720-tmp-2120274623: Das System kann den angegebenen Pfad nicht finden.SOME_OTHER_FILE_TO_BACKUP
Save(<data/718e424bac>) returned error, retrying after 2.489470232s: open MY_REPO_DIR\data\71\718e424bacd96b9e2992242591edd4914608e7e8d06524cf9d220117a266cca0-tmp-143769248: Das System kann den angegebenen Pfad nicht finden.
Save(<data/f209f18896>) returned error, retrying after 977.827989ms: open MY_REPO_DIR\data\f2\f209f188967a722482508122e494a3a83f5bfc292cf7abc3b516db8bc515b7a9-tmp-1495385356: Das System kann den angegebenen Pfad nicht finden.
Save(<data/5f10519134>) returned error, retrying after 1.847489509s: open MY_REPO_DIR\data\5f\5f10519134056479d44d6e797aa37cd268cf20b659603c1134bdf1ac278ff340-tmp-2227406266: Das System kann den angegebenen Pfad nicht finden.
Save(<data/d6e1f32427>) returned error, retrying after 943.516099ms: open MY_REPO_DIR\data\d6\d6e1f32427a4973e3bfd030b39857395db8a8195d7d9ac57826c854411de3342-tmp-952927209: Das System kann den angegebenen Pfad nicht finden.
Save(<data/6df1702ff4>) returned error, retrying after 2.011541491s: open MY_REPO_DIR\data\6d\6df1702ff49a95c810f8f9820ee641ecbd8afddeeb7a216a12c3bcdff0def14a-tmp-3136542873: Das System kann den angegebenen Pfad nicht finden.
Save(<data/d6ff1b6dbb>) returned error, retrying after 1.352569524s: open MY_REPO_DIR\data\d6\d6ff1b6dbb4c004a890a8cff95fd2ea6c81e971cc031d1323a583dea63d66476-tmp-206906514: Das System kann den angegebenen Pfad nicht finden.
Save(<data/66b414b8cb>) returned error, retrying after 1.136136777s: open MY_REPO_DIR\data\66\66b414b8cbc7f10eb4e6c27fad55d24764dfdfff214473c1fa9312207af908f4-tmp-2084344782: Das System kann den angegebenen Pfad nicht finden.
Save(<data/2c6302293c>) returned error, retrying after 1.756856005s: open MY_REPO_DIR\data\2c\2c6302293c7b4da6705b201f01964cbf3e7ebedf315984bdb461b72a8ec01595-tmp-1774502886: Das System kann den angegebenen Pfad nicht finden.
Save(<data/708cd5fc8f>) returned error, retrying after 1.762012529s: open MY_REPO_DIR\data\70\708cd5fc8f0ac0c9cae8707cdbefd117456f784feba776e1d7d9e772049ab528-tmp-2914735476: Das System kann den angegebenen Pfad nicht finden.
Save(<data/d600c09134>) returned error, retrying after 1.313731612s: open MY_REPO_DIR\data\d6\d600c091348b82fea0f2298cbe26c38376adc6f6cb8efd68eaf1deb63b35e428-tmp-1538557121: Das System kann den angegebenen Pfad nicht finden.

Files:        1217 new,    57 changed, 142635 unmodified
Dirs:          155 new,    76 changed, 10191 unmodified
Added to the repo: 1.746 GiB

processed 143909 files, 105.670 GiB in 3:46
snapshot 9d113114 saved
Warning: at least one source file could not be read

e:\>

Questions:
What should I conclude from all those „returned error, retrying after“-messages?
What do you recommend doing to analyze further and/or verify the repo’s health?

Thanks!

2

That E: is not available. Ein nicht vorhandenes Gerät wurde angegeben. I would double-check if your (external hard disk?) E:-Drive is available and has no loose connections. (Assuming E is an USB-Drive, you could test other ports)

I would go for restic check

1 Like
3

Hi,

thanks @MelcomX

Here is what I did:

1.) copied repo to another device

2.) compared sha256-hashes of all repo files with filenames

3.) found a couple of mismatches

4.) run restic check --read_data on the repo

checkPack: Load: open \\?\e:\MY_REPO_DIR\data\1f\1fe430c512d4527c0aaac9e538f9e8ec475ece1d99c50d2f2915bb0a3b9eed8f: Das System kann die angegebene Datei nicht finden.

5.)

cp -p MY_REPO_DIR/data/1f/1fe430c512d4527c0aaac9e538f9e8ec475ece1d99c50d2f2915bb0a3b9eed8f-tmp-3721865006 MY_REPO_DIR/data/1f/1fe430c512d4527c0aaac9e538f9e8ec475ece1d99c50d2f2915bb0a3b9eed8f

6.) rerun restic check --read_data on the repo

no errors were found

Idea what might have happened:

  • when building what should have ended with a pack called 1fe430c512d4527c0aaac9e538f9e8ec475ece1d99c50d2f2915bb0a3b9eed8f, restic created temporary versions named …-tmp-… (all …-tmp-… files except the above did not have their sha256-hash in their names)

  • fortunately the only operation that finally failed was renaming 1fe430c512d4527c0aaac9e538f9e8ec475ece1d99c50d2f2915bb0a3b9eed8f-tmp-3721865006 to 1fe430c512d4527c0aaac9e538f9e8ec475ece1d99c50d2f2915bb0a3b9eed8f

Does this make sense?

Should I do further checks to verify that my copy operation completely fixed the issue caused by the questionable backup run?

Would increased verbosity during backup have given further comments on what exactly failed / was retried successfully?

Does “snapshot 9d113114 saved” mean restic thought everything finally went ok, except “at least one source file could not be read”?

Any comments welcome!

4

If the rename operation fails, then restic will simply repeat writing the pack file. The only way for restic to complete the backup and still end up with outdated filenames, is if the operating system confirmed that the rename succeeded but then forgot about it later on.

Judging from the log output above, the disk on which the repository is stored disappeared for a few seconds at which point the rename was likely lost. Please run chkdsk for the disk to make sure the filesystem is intact.

Since restic 0.15.0, it will log when a retry was successful. The actual behavior hasn’t changed: if writing to the repository fails despite retries, then the backup will always fail. Or in other words: if restic stops printing these retrying after ... warnings, then everything is fine.

As described above, storing data in the repository must succeed. Any failure will abort the backup. In contrast, if restic cannot read one file of the backup dataset (that’s what that final warning refers to), then it will continue the backup and just skip that file.