View Issue Details

IDProjectCategoryView StatusLast Update
0001532bareos-corefile daemonpublic2024-01-30 10:42
Reporterhostedpower Assigned Tobruno-at-bareos  
PrioritynormalSeveritymajorReproducibilityalways
Status closedResolutionreopened 
Platformx86OSWindowsOS Version2016
Product Version22.0.3 
Summary0001532: Windows backups fails on a lot of files, seems vss is not used properly
DescriptionUsing Windows 2022

mdf": ERR=The process cannot access the file because it is being used by another process.

Cannot open "E:/SQLLogs/xxxxx/xxxx_Cbro_log.ldf": ERR=The process cannot access the file because it is being used by another proces

But we see lot's of these errors (easily 100's at moments which is quite weird).

I cannot remember seeing so many errors with Windows backups as we experience now on Windows 2022 and Baroes 22.x (Not sure which one causes it)

Could you provide me any troubleshooting steps so I can report back?
Tagsmssql, VSS, Windows

Activities

hostedpower

hostedpower

2023-04-28 16:21

reporter   ~0004993

Maybe a similar issue here: https://groups.google.com/g/bareos-users/c/F46rRPh7Hf8
bruno-at-bareos

bruno-at-bareos

2023-05-03 15:39

manager   ~0004997

Are the "E:/SQLLogs" directory pick into account by the VSS SQL Writer ?
hostedpower

hostedpower

2023-11-27 22:16

reporter   ~0005536

Hi, wouldn't it find those by default? We still have these errors atm :(
hostedpower

hostedpower

2023-11-28 08:10

reporter   ~0005537

I checked and I saw indeed that the vss writer didn't have systadmin privileges to the database, I changed and fixed this now without any change.

It's almost as Bareos doesn't trigger the VSS from the SQL. I would expect errors in the Windows logs otherwise, but I don't seem to find any vss errors.

I see this in the logs:
14 2023-11-28 00:48:41 myclient.xxx.com JobId 196538: Generate VSS snapshots. Driver="Win64 VSS", Drive(s)="CDE"

Is this sufficient for it to work?
backup-fails.txt (27,244 bytes)   
139	2023-11-28 00:58:32	yyy-dir JobId 196538: console command: run AfterJob ".bvfs_update JobId=196538"
138	2023-11-28 00:58:32	yyy-dir JobId 196538: Bareos yyy-dir 22.1.1 (23Oct23):
Build OS: Debian GNU/Linux 11 (bullseye)
JobId: 196538
Job: myclient.xxx.com-files.2023-11-27_23.05.02_37
Backup Level: Incremental, since=2023-11-27 00:38:02
Client: "myclient.xxx.com" 22.1.0 (13Jun23) Microsoft Windows Server 2012 Standard Edition (build 9200), 64-bit,Cross-compile
FileSet: "windows-files" 2022-07-06 23:05:00
Pool: "AI-Incremental" (From Job resource)
Catalog: "MyCatalog" (From Client resource)
Storage: "AI-Incremental" (From Pool resource)
Scheduled time: 27-Nov-2023 23:05:02
Start time: 28-Nov-2023 00:48:22
End time: 28-Nov-2023 00:58:32
Elapsed time: 10 mins 10 secs
Priority: 10
FD Files Written: 161,364
SD Files Written: 161,364
FD Bytes Written: 7,370,765,464 (7.370 GB)
SD Bytes Written: 7,416,406,426 (7.416 GB)
Rate: 12083.2 KB/s
Software Compression: 55.4 % (gzip3)
VSS: yes
Encryption: no
Accurate: yes
Volume name(s): vol-incr-0648
Volume Session Id: 130650
Volume Session Time: 1678051949
Last Volume Bytes: 49,153,528,316 (49.15 GB)
Non-fatal FD errors: 106
SD Errors: 0
FD termination status: OK
SD termination status: OK
Bareos binary info: Bareos subscription release
Job triggered by: Scheduler
Termination: Backup OK -- with warnings

137	2023-11-28 00:58:32	yyy-dir JobId 196538: Insert of attributes batch table done
136	2023-11-28 00:58:25	yyy-dir JobId 196538: Insert of attributes batch table with 161363 entries start
135	2023-11-28 00:58:24	yyy-sd JobId 196538: Elapsed time=00:09:45, Transfer rate=12.67 M Bytes/second
134	2023-11-28 00:58:24	yyy-sd JobId 196538: Releasing device "AI-Incremental0005" (/var/lib/bareos/storage).
133	2023-11-28 00:58:24	myclient.xxx.com JobId 196538: VSS Writer (BackupComplete): "COM+ REGDB Writer", State: 0x1 (VSS_WS_STABLE)
132	2023-11-28 00:58:24	myclient.xxx.com JobId 196538: VSS Writer (BackupComplete): "Registry Writer", State: 0x1 (VSS_WS_STABLE)
131	2023-11-28 00:58:24	myclient.xxx.com JobId 196538: VSS Writer (BackupComplete): "Shadow Copy Optimization Writer", State: 0x1 (VSS_WS_STABLE)
130	2023-11-28 00:58:24	myclient.xxx.com JobId 196538: VSS Writer (BackupComplete): "ASR Writer", State: 0x1 (VSS_WS_STABLE)
129	2023-11-28 00:58:24	myclient.xxx.com JobId 196538: VSS Writer (BackupComplete): "WMI Writer", State: 0x1 (VSS_WS_STABLE)
128	2023-11-28 00:58:24	myclient.xxx.com JobId 196538: VSS Writer (BackupComplete): "SqlServerWriter", State: 0x1 (VSS_WS_STABLE)
127	2023-11-28 00:58:24	myclient.xxx.com JobId 196538: VSS Writer (BackupComplete): "System Writer", State: 0x1 (VSS_WS_STABLE)
126	2023-11-28 00:58:24	myclient.xxx.com JobId 196538: VSS Writer (BackupComplete): "Performance Counters Writer", State: 0x1 (VSS_WS_STABLE)
125	2023-11-28 00:58:24	myclient.xxx.com JobId 196538: VSS Writer (BackupComplete): "VSS Metadata Store Writer", State: 0x1 (VSS_WS_STABLE)
124	2023-11-28 00:58:24	myclient.xxx.com JobId 196538: VSS Writer (BackupComplete): "Task Scheduler Writer", State: 0x1 (VSS_WS_STABLE)
123	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/vtldata_log.ldf": ERR=The process cannot access the file because it is being used by another process.
.
122	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/VFData_log.ldf": ERR=The process cannot access the file because it is being used by another process.
.
121	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/SQLTestDB_log.ldf": ERR=The process cannot access the file because it is being used by another process.
.
120	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/rsnetdata_rd_log.ldf": ERR=The process cannot access the file because it is being used by another process.
.
119	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/rsnetdata.LDF": ERR=The process cannot access the file because it is being used by another process.
.
118	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_vijverman.ldf": ERR=The process cannot access the file because it is being used by another process.
.
117	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_stas.ldf": ERR=The process cannot access the file because it is being used by another process.
.
116	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_Solmat_1.LDF": ERR=The process cannot access the file because it is being used by another process.
.
115	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_Snels_log.ldf": ERR=The process cannot access the file because it is being used by another process.
.
114	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_raamprof_log_new.ldf": ERR=The process cannot access the file because it is being used by another process.
.
113	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_PetersLeon_1.LDF": ERR=The process cannot access the file because it is being used by another process.
.
112	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_Maes_1.LDF": ERR=The process cannot access the file because it is being used by another process.
.
111	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_lindebrings.ldf": ERR=The process cannot access the file because it is being used by another process.
.
110	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_Jlk_1.LDF": ERR=The process cannot access the file because it is being used by another process.
.
109	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_cope.ldf": ERR=The process cannot access the file because it is being used by another process.
.
108	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_Cbro_log.ldf": ERR=The process cannot access the file because it is being used by another process.
.
107	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_America_1.LDF": ERR=The process cannot access the file because it is being used by another process.
.
106	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_Aludesign_log.ldf": ERR=The process cannot access the file because it is being used by another process.
.
105	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/rsnetdata_Alucoplast_1.LDF": ERR=The process cannot access the file because it is being used by another process.
.
104	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft Externen/Nuyts/rsnetdata_Nuyts.ldf": ERR=The process cannot access the file because it is being used by another process.
.
103	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Ramasoft/rsnetdata_dealer_1.LDF": ERR=The process cannot access the file because it is being used by another process.
.
102	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Planning_log.LDF": ERR=The process cannot access the file because it is being used by another process.
.
101	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "E:/SQLLogs/Planning/PlanningTest_Log": ERR=The process cannot access the file because it is being used by another process.
.
100	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/vtldata.mdf": ERR=The process cannot access the file because it is being used by another process.
.
99	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/VFData.mdf": ERR=The process cannot access the file because it is being used by another process.
.
98	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/SQLTestDB.mdf": ERR=The process cannot access the file because it is being used by another process.
.
97	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/rsnetdata_rd.mdf": ERR=The process cannot access the file because it is being used by another process.
.
96	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/rsnetdata.mdf": ERR=The process cannot access the file because it is being used by another process.
.
95	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_vijverman.mdf": ERR=The process cannot access the file because it is being used by another process.
.
94	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_stas.mdf": ERR=The process cannot access the file because it is being used by another process.
.
93	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_Solmat.mdf": ERR=The process cannot access the file because it is being used by another process.
.
92	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_Snels.mdf": ERR=The process cannot access the file because it is being used by another process.
.
91	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_raamprof.mdf": ERR=The process cannot access the file because it is being used by another process.
.
90	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_PetersLeon.mdf": ERR=The process cannot access the file because it is being used by another process.
.
89	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_Maes.mdf": ERR=The process cannot access the file because it is being used by another process.
.
88	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_lindebrings.mdf": ERR=The process cannot access the file because it is being used by another process.
.
87	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_Jlk.mdf": ERR=The process cannot access the file because it is being used by another process.
.
86	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_cope.mdf": ERR=The process cannot access the file because it is being used by another process.
.
85	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_Cbro.mdf": ERR=The process cannot access the file because it is being used by another process.
.
84	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_America.mdf": ERR=The process cannot access the file because it is being used by another process.
.
83	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_Aludesign.mdf": ERR=The process cannot access the file because it is being used by another process.
.
82	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/rsnetdata_Alucoplast.mdf": ERR=The process cannot access the file because it is being used by another process.
.
81	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft Externen/Nuyts/rsnetdata_Nuyts.mdf": ERR=The process cannot access the file because it is being used by another process.
.
80	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Ramasoft/rsnetdata_dealer.mdf": ERR=The process cannot access the file because it is being used by another process.
.
79	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Planning.mdf": ERR=The process cannot access the file because it is being used by another process.
.
78	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Cannot open "D:/SQLData/Planning/PlanningTest": ERR=The process cannot access the file because it is being used by another process.
.
77	2023-11-28 00:58:21	myclient.xxx.com JobId 196538: Could not stat "D:/DumpStack.log.tmp": ERR=The process cannot access the file because it is being used by another process.

76	2023-11-28 00:53:07	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/LogFiles/Sum/Svctmp.log": ERR=The process cannot access the file because it is being used by another process.
.
75	2023-11-28 00:53:07	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/LogFiles/Sum/Svc.log": ERR=The process cannot access the file because it is being used by another process.
.
74	2023-11-28 00:53:07	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/LogFiles/Sum/Current.mdb": ERR=The process cannot access the file because it is being used by another process.
.
73	2023-11-28 00:53:07	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/LogFiles/Sum/Current.jfm": ERR=The process cannot access the file because it is being used by another process.
.
72	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/systemprofile/AppData/Local/DataSharing/Storage/DSTokenDB2.jfm": ERR=The process cannot access the file because it is being used by another process.
.
71	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/systemprofile/AppData/Local/DataSharing/Storage/DSTokenDB2.dat": ERR=The process cannot access the file because it is being used by another process.
.
70	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/systemprofile/AppData/Local/DataSharing/Storage/DSS.log": ERR=The process cannot access the file because it is being used by another process.
.
69	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/SYSTEM.LOG2": ERR=The process cannot access the file because it is being used by another process.
.
68	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/SYSTEM.LOG1": ERR=The process cannot access the file because it is being used by another process.
.
67	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/SYSTEM": ERR=The process cannot access the file because it is being used by another process.
.
66	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/SOFTWARE.LOG2": ERR=The process cannot access the file because it is being used by another process.
.
65	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/SOFTWARE.LOG1": ERR=The process cannot access the file because it is being used by another process.
.
64	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/SOFTWARE": ERR=The process cannot access the file because it is being used by another process.
.
63	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/SECURITY.LOG2": ERR=The process cannot access the file because it is being used by another process.
.
62	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/SECURITY.LOG1": ERR=The process cannot access the file because it is being used by another process.
.
61	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/SECURITY": ERR=The process cannot access the file because it is being used by another process.
.
60	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/SAM": ERR=The process cannot access the file because it is being used by another process.
.
59	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/DEFAULT.LOG2": ERR=The process cannot access the file because it is being used by another process.
.
58	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/DEFAULT.LOG1": ERR=The process cannot access the file because it is being used by another process.
.
57	2023-11-28 00:52:43	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/DEFAULT": ERR=The process cannot access the file because it is being used by another process.
.
56	2023-11-28 00:52:42	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/BBI.LOG2": ERR=The process cannot access the file because it is being used by another process.
.
55	2023-11-28 00:52:42	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/BBI.LOG1": ERR=The process cannot access the file because it is being used by another process.
.
54	2023-11-28 00:52:42	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/config/BBI": ERR=The process cannot access the file because it is being used by another process.
.
53	2023-11-28 00:52:40	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/catroot2/{F750E6C3-38EE-11D1-85E5-00C04FC295EE}/catdb.jfm": ERR=The process cannot access the file because it is being used by another process.
.
52	2023-11-28 00:52:40	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/catroot2/{F750E6C3-38EE-11D1-85E5-00C04FC295EE}/catdb": ERR=The process cannot access the file because it is being used by another process.
.
51	2023-11-28 00:52:40	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/catroot2/{127D0A1D-4EF2-11D1-8608-00C04FC295EE}/catdb.jfm": ERR=The process cannot access the file because it is being used by another process.
.
50	2023-11-28 00:52:40	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/catroot2/{127D0A1D-4EF2-11D1-8608-00C04FC295EE}/catdb": ERR=The process cannot access the file because it is being used by another process.
.
49	2023-11-28 00:52:40	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/catroot2/edbtmp.log": ERR=The process cannot access the file because it is being used by another process.
.
48	2023-11-28 00:52:40	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/System32/catroot2/edb.log": ERR=The process cannot access the file because it is being used by another process.
.
47	2023-11-28 00:50:30	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/ServiceProfiles/SQLTELEMETRY/ntuser.dat.LOG2": ERR=The process cannot access the file because it is being used by another process.
.
46	2023-11-28 00:50:30	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/ServiceProfiles/SQLTELEMETRY/ntuser.dat.LOG1": ERR=The process cannot access the file because it is being used by another process.
.
45	2023-11-28 00:50:30	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/ServiceProfiles/SQLTELEMETRY/NTUSER.DAT": ERR=The process cannot access the file because it is being used by another process.
.
44	2023-11-28 00:50:30	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/ServiceProfiles/SQLTELEMETRY/AppData/Local/Microsoft/Windows/UsrClass.dat": ERR=The process cannot access the file because it is being used by another process.
.
43	2023-11-28 00:50:30	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/ServiceProfiles/NetworkService/NTUSER.DAT.LOG2": ERR=The process cannot access the file because it is being used by another process.
.
42	2023-11-28 00:50:30	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/ServiceProfiles/NetworkService/NTUSER.DAT": ERR=The process cannot access the file because it is being used by another process.
.
41	2023-11-28 00:50:30	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/ServiceProfiles/LocalService/NTUSER.DAT": ERR=The process cannot access the file because it is being used by another process.
.
40	2023-11-28 00:49:41	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/appcompat/Programs/Amcache.hve.LOG2": ERR=The process cannot access the file because it is being used by another process.
.
39	2023-11-28 00:49:41	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/appcompat/Programs/Amcache.hve.LOG1": ERR=The process cannot access the file because it is being used by another process.
.
38	2023-11-28 00:49:41	myclient.xxx.com JobId 196538: Cannot open "C:/Windows/appcompat/Programs/Amcache.hve": ERR=The process cannot access the file because it is being used by another process.
.
37	2023-11-28 00:49:39	myclient.xxx.com JobId 196538: Cannot open "C:/Users/gsma_SQLrama$/ntuser.dat.LOG2": ERR=The process cannot access the file because it is being used by another process.
.
36	2023-11-28 00:49:39	myclient.xxx.com JobId 196538: Cannot open "C:/Users/gsma_SQLrama$/NTUSER.DAT": ERR=The process cannot access the file because it is being used by another process.
.
35	2023-11-28 00:49:12	myclient.xxx.com JobId 196538: Cannot open "C:/ProgramData/Microsoft/Windows Defender/Scans/MpDiag.bin": ERR=The process cannot access the file because it is being used by another process.
.
34	2023-11-28 00:49:06	myclient.xxx.com JobId 196538: Cannot open "C:/ProgramData/Microsoft/Windows Defender/IMpService77BDAF73-B396-481F-9042-AD358843EC24.lock": ERR=The process cannot access the file because it is being used by another process.
.
33	2023-11-28 00:49:06	myclient.xxx.com JobId 196538: Cannot open "C:/ProgramData/Microsoft/Windows Defender/IMpDlpService77BDAF73-B396-481F-9042-AD358843EC24.lock": ERR=The process cannot access the file because it is being used by another process.
.
32	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/templog.ldf": ERR=The process cannot access the file because it is being used by another process.
.
31	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/tempdb_mssql_8.ndf": ERR=The process cannot access the file because it is being used by another process.
.
30	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/tempdb_mssql_7.ndf": ERR=The process cannot access the file because it is being used by another process.
.
29	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/tempdb_mssql_6.ndf": ERR=The process cannot access the file because it is being used by another process.
.
28	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/tempdb_mssql_5.ndf": ERR=The process cannot access the file because it is being used by another process.
.
27	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/tempdb_mssql_4.ndf": ERR=The process cannot access the file because it is being used by another process.
.
26	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/tempdb_mssql_3.ndf": ERR=The process cannot access the file because it is being used by another process.
.
25	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/tempdb_mssql_2.ndf": ERR=The process cannot access the file because it is being used by another process.
.
24	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/tempdb.mdf": ERR=The process cannot access the file because it is being used by another process.
.
23	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/MSDBLog.ldf": ERR=The process cannot access the file because it is being used by another process.
.
22	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/MSDBData.mdf": ERR=The process cannot access the file because it is being used by another process.
.
21	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/modellog.ldf": ERR=The process cannot access the file because it is being used by another process.
.
20	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/model.mdf": ERR=The process cannot access the file because it is being used by another process.
.
19	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/mastlog.ldf": ERR=The process cannot access the file because it is being used by another process.
.
18	2023-11-28 00:48:50	myclient.xxx.com JobId 196538: Cannot open "C:/Program Files/Microsoft SQL Server/MSSQL15.MSSQLSERVER/MSSQL/DATA/master.mdf": ERR=The process cannot access the file because it is being used by another process.
.
17	2023-11-28 00:48:42	myclient.xxx.com JobId 196538: VolumeMountpoints are not processed as onefs = yes.
16	2023-11-28 00:48:42	myclient.xxx.com JobId 196538: VolumeMountpoints are not processed as onefs = yes.
15	2023-11-28 00:48:42	myclient.xxx.com JobId 196538: VolumeMountpoints are not processed as onefs = yes.
14	2023-11-28 00:48:41	myclient.xxx.com JobId 196538: Generate VSS snapshots. Driver="Win64 VSS", Drive(s)="CDE"
13	2023-11-28 00:48:39	yyy-sd JobId 196538: Ready to append to end of Volume "vol-incr-0648" size=41724904576
12	2023-11-28 00:48:39	yyy-sd JobId 196538: Volume "vol-incr-0648" previously written, moving to end of data.
11	2023-11-28 00:48:39	myclient.xxx.com JobId 196538: Encryption: TLS_CHACHA20_POLY1305_SHA256 TLSv1.3
10	2023-11-28 00:48:39	myclient.xxx.com JobId 196538: Connected Storage daemon at yyy.hosted-power.com:9103, encryption: TLS_CHACHA20_POLY1305_SHA256 TLSv1.3
9	2023-11-28 00:48:22	myclient.xxx.com JobId 196538: Created 18 wildcard excludes from FilesNotToBackup Registry key
8	2023-11-28 00:48:39	yyy-dir JobId 196538: Using Device "AI-Incremental0005" to write.
7	2023-11-28 00:48:22	yyy-dir JobId 196538: Sending Accurate information.
6	2023-11-28 00:48:21	yyy-dir JobId 196538: Encryption: TLS_CHACHA20_POLY1305_SHA256 TLSv1.3
5	2023-11-28 00:48:21	yyy-dir JobId 196538: Handshake: Immediate TLS
4	2023-11-28 00:48:21	yyy-dir JobId 196538: Using Client Initiated Connection (myclient.xxx.com).
3	2023-11-28 00:48:21	yyy-dir JobId 196538: Encryption: TLS_CHACHA20_POLY1305_SHA256 TLSv1.3
2	2023-11-28 00:48:21	yyy-dir JobId 196538: Connected Storage daemon at yyy.hosted-power.com:9103, encryption: TLS_CHACHA20_POLY1305_SHA256 TLSv1.3
1	2023-11-28 00:48:21	yyy-dir JobId 196538: Start Backup JobId 196538, Job=myclient.xxx.com-files.2023-11-27_23.05.02_37
backup-fails.txt (27,244 bytes)   
hostedpower

hostedpower

2023-11-28 08:51

reporter   ~0005538

found here some link, not sure how relevant: https://www.veritas.com/support/en_US/article.100044497 , which show the files are listed under the SqlServerWriter.
Normally the MDF files can be restored correctly, more info here: https://learn.microsoft.com/en-us/sql/relational-databases/backup-restore/sql-server-vss-writer-backup-guide?view=sql-server-ver16
hostedpower

hostedpower

2024-01-12 08:55

reporter   ~0005682

More info was posted here: https://groups.google.com/g/bareos-users/c/F46rRPh7Hf8

Seems to be a Bareos issue, I think the findings are potentially interesting
bruno-at-bareos

bruno-at-bareos

2024-01-16 15:24

manager   ~0005688

The initial root cause describe here should have already been fixed in 23 release.
The code change https://github.com/bareos/bareos/pull/1452

Except if you are hit my a different issue.
hostedpower

hostedpower

2024-01-16 22:29

reporter   ~0005690

Hi, I upgraded our whole installation to version 23, only to find out it has exactly (100% percent) the same problems. Also there was a reply on the google thread, specifying the tests and debugging were done already with v23 ;)
hostedpower

hostedpower

2024-01-16 22:32

reporter   ~0005691

Last edited: 2024-01-16 22:38

Maybe it's conincidence, but the first tests even have 3x more non backuped files than before.

I checked another one, having also lots more warnings. Host was having between 40 and 50 quite consistently, now it has 127.
hostedpower

hostedpower

2024-01-17 09:32

reporter   ~0005692

Ok final result, it seems at first sight the errors are more or less the same. Probably the recent logging on to the tested servers created even more unbackupable files when testing last night.

But in any case, this is not solved. I think the info on the google thread is most likely still relevant and interesting :)
bruno-at-bareos

bruno-at-bareos

2024-01-17 09:39

manager   ~0005693

All our testing report success, so we don't have any clue about what happening in your case.
Please check the ML there's instruction to have a trace, joblog and the fileset used.

I'm attaching here an illustration to the fact that bareos works as documented and expected.
We run a backup job while the registry hive is open in regedit and we tried to remove it so you get the expected error, the file is in use.
In the background you can see the success of the job backing up that file without any error.
See the details about the status of VSS BackupComplete.
image.png (162,471 bytes)   
image.png (162,471 bytes)   
hostedpower

hostedpower

2024-01-17 09:56

reporter   ~0005694

Which Windows OS version do you have? We're using Windows 2022.

I tried the https://download.bareos.org/current/windows/winbareos-23.0.1~pre57.8e89bfe0a-release-64-bit.exe , but I have 100% the same errors.
bruno-at-bareos

bruno-at-bareos

2024-01-17 10:11

manager   ~0005695

Please, may I ask you to either provided the trace and job log as requested.
As I can argue that we are using 2019 to 2022 with 0% of your troubles

That kind of guerilla can be endless.

If we have traces, joblog fileset etc we may have a chance to reproduce.
If it is reproducible, then there's a chance to have a fix.
If we can elaborate that fix, you may have a chance to solve your trouble.
hostedpower

hostedpower

2024-01-17 14:42

reporter   ~0005696

Hello Bruno, with pleasure, here you can find both logs/trace (valid 7 days): https://we.tl/t-A0WwzxrCBS
bruno-at-bareos

bruno-at-bareos

2024-01-17 15:41

manager   ~0005697

Thanks for the share. do you mind to share the fileset used during that job ?
hostedpower

hostedpower

2024-01-17 15:53

reporter   ~0005698

FileSet {
        Name = "windows-files"
        Enable VSS = yes

        Include {
                Options {
                        signature = XXH128
                        compression = GZIP3
                        Drive Type = fixed
                        IgnoreCase = yes
                        Exclude = yes

                        # Exclude junction points
                        WildDir = "[A-Z]:/Dokumente und Einstellungen"
                        WildDir = "[A-Z]:/Documents and Settings"
                        WildDir = "[A-Z]:/Program Files/Gemeinsame Dateien"
                        WildDir = "[A-Z]:/Program Files/Windows NT/Zubehör"
                        WildDir = "[A-Z]:/ProgramData/Anwendungsdaten"
                        WildDir = "[A-Z]:/ProgramData/Application Data"
                        WildDir = "[A-Z]:/ProgramData/Desktop"
                        WildDir = "[A-Z]:/ProgramData/Documents"
                        WildDir = "[A-Z]:/ProgramData/Dokumente"
                        WildDir = "[A-Z]:/ProgramData/Favoriten"
                        WildDir = "[A-Z]:/ProgramData/Favorites"
                        WildDir = "[A-Z]:/ProgramData/Microsoft/Windows/Start Menu/Programme"
                        WildDir = "[A-Z]:/ProgramData/Start Menu"
                        WildDir = "[A-Z]:/ProgramData/Startmenü"
                        WildDir = "[A-Z]:/ProgramData/Templates"
                        WildDir = "[A-Z]:/ProgramData/Vorlagen"
                        WildDir = "[A-Z]:/Programme"
                        WildDir = "[A-Z]:/Documents and Settings"
                        WildDir = "[A-Z]:/Users/All Users"
                        WildDir = "[A-Z]:/Users/Default User"
                        WildDir = "[A-Z]:/Users/*/AppData/Local/Application Data"
                        WildDir = "[A-Z]:/Users/*/AppData/Local/Anwendungsdaten"
                        WildDir = "[A-Z]:/Users/*/AppData/Local/History"
                        WildDir = "[A-Z]:/Users/*/AppData/Local/Verlauf"
                        WildDir = "[A-Z]:/Users/*/AppData/Local/Temporary Internet Files"
                        WildDir = "[A-Z]:/Users/*/Application Data"
                        WildDir = "[A-Z]:/Users/*/Anwendungsdaten"
                        WildDir = "[A-Z]:/Users/*/Gemeinsame Dateien"
                        WildDir = "[A-Z]:/Users/*/Cookies"
                        WildDir = "[A-Z]:/Users/*/Documents/My Music"
                        WildDir = "[A-Z]:/Users/*/Documents/Eigene Musik"
                        WildDir = "[A-Z]:/Users/*/Documents/My Pictures"
                        WildDir = "[A-Z]:/Users/*/Documents/Eigene Bilder"
                        WildDir = "[A-Z]:/Users/*/Documents/My Videos"
                        WildDir = "[A-Z]:/Users/*/Documents/Eigene Videos"
                        WildDir = "[A-Z]:/Users/*/Local Settings"
                        WildDir = "[A-Z]:/Users/*/Lokale Einstellungen"
                        WildDir = "[A-Z]:/Users/*/My Documents"
                        WildDir = "[A-Z]:/Users/*/Eigene Dateien"
                        WildDir = "[A-Z]:/Users/*/NetHood"
                        WildDir = "[A-Z]:/Users/*/Netzwerkumgebung"
                        WildDir = "[A-Z]:/Users/*/PrintHood"
                        WildDir = "[A-Z]:/Users/*/Druckumgebung"
                        WildDir = "[A-Z]:/Users/*/Recent"
                        WildDir = "[A-Z]:/Users/*/SendTo"
                        WildDir = "[A-Z]:/Users/*/Start Menu"
                        WildDir = "[A-Z]:/Users/*/Startmenü"
                        WildDir = "[A-Z]:/Users/*/Templates"
                        WildDir = "[A-Z]:/Users/*/Vorlagen"

                        # Temporary directories & files
                        WildDir = "[A-Z]:/Windows/Temp"
                        WildDir = "[A-Z]:/Users/*/AppData/Local/Mozilla/Firefox/Profiles/*/Cache"

                        # Recycle bins
                        WildDir = "[A-Z]:/RECYCLER"
                        WildDir = "[A-Z]:/$RECYCLE.BIN"

                        # System restores
                        WildDir = "[A-Z]:/System Volume Information"

                        # Swap files
                        WildFile = "[A-Z]:/pagefile.sys"
                        WildFile = "[A-Z]:/hiberfil.sys"
                }

                ExcludeDirContaining = "bkp.exclude"
                File = "/"
                #File = "\\<C:/bkpinclude.txt"
        }
        IgnoreFileSetChanges = yes # If we change the fileset then don't force a full backup next time.
}
hostedpower

hostedpower

2024-01-23 09:16

reporter   ~0005709

It seems to be solved with the test build posted on google groups, does it mean it will be included in Bareos 23.0.1 (or similar)?
bruno-at-bareos

bruno-at-bareos

2024-01-23 09:26

manager   ~0005710

It will be included in next release so mainly for 23.0.2 (23.0.1 has been released last week), and if it is not in the next it will be in the following.
hostedpower

hostedpower

2024-01-23 16:44

reporter   ~0005713

OK thx, we really look forward to release 23.0.2 then, it's a pity now, if we install the built preview, the version number that is saved in registry of the client is 24.x preview, this makes it unlikely an upgrade would be attempted when checking version numbers when 23.0.2 comes out :)
bruno-at-bareos

bruno-at-bareos

2024-01-23 16:59

manager   ~0005714

our repo next is where the change occurs in master branch of github, so actually "next" is 24.0.0~pre.

When the code will be backported mean when PR1666 will be merged https://github.com/bareos/bareos/pull/1666 into bareos-23 a rebuild of the "current" repository will happen, and then bareos current will be tagged 23.0.2~pre

Of course subscription packages are maybe more easy to undestand :-)
bruno-at-bareos

bruno-at-bareos

2024-01-30 10:42

manager   ~0005724

PR have been merged.

Issue History

Date Modified Username Field Change
2023-04-27 10:22 hostedpower New Issue
2023-04-28 16:21 hostedpower Note Added: 0004993
2023-05-03 15:39 bruno-at-bareos Note Added: 0004997
2023-09-13 11:58 bruno-at-bareos Tag Attached: Windows
2023-09-13 11:58 bruno-at-bareos Tag Attached: VSS
2023-09-13 11:58 bruno-at-bareos Tag Attached: mssql
2023-11-27 22:16 hostedpower Note Added: 0005536
2023-11-28 08:10 hostedpower Note Added: 0005537
2023-11-28 08:10 hostedpower File Added: backup-fails.txt
2023-11-28 08:51 hostedpower Note Added: 0005538
2024-01-12 08:55 hostedpower Note Added: 0005682
2024-01-16 15:24 bruno-at-bareos Assigned To => bruno-at-bareos
2024-01-16 15:24 bruno-at-bareos Status new => closed
2024-01-16 15:24 bruno-at-bareos Resolution open => fixed
2024-01-16 15:24 bruno-at-bareos Note Added: 0005688
2024-01-16 22:29 hostedpower Status closed => new
2024-01-16 22:29 hostedpower Resolution fixed => reopened
2024-01-16 22:29 hostedpower Note Added: 0005690
2024-01-16 22:32 hostedpower Note Added: 0005691
2024-01-16 22:38 hostedpower Note Edited: 0005691
2024-01-17 09:32 hostedpower Note Added: 0005692
2024-01-17 09:39 bruno-at-bareos Note Added: 0005693
2024-01-17 09:39 bruno-at-bareos File Added: image.png
2024-01-17 09:56 hostedpower Note Added: 0005694
2024-01-17 10:11 bruno-at-bareos Note Added: 0005695
2024-01-17 14:42 hostedpower Note Added: 0005696
2024-01-17 15:41 bruno-at-bareos Note Added: 0005697
2024-01-17 15:53 hostedpower Note Added: 0005698
2024-01-23 09:16 hostedpower Note Added: 0005709
2024-01-23 09:26 bruno-at-bareos Note Added: 0005710
2024-01-23 16:44 hostedpower Note Added: 0005713
2024-01-23 16:59 bruno-at-bareos Note Added: 0005714
2024-01-30 10:42 bruno-at-bareos Status new => closed
2024-01-30 10:42 bruno-at-bareos Note Added: 0005724