Backup fails afte 1020 errors

[mirQtio]

Hi all,

 

I am having an issue with my backup failing. I have attached one of the backup logs below so you can see the details, but thie gist is several files are (expectantly) skipped during the backup, then the final selection hangs for a considerable time (between 5-10 hours) then reports that the Execution stopped by operator. Any thoughts or advice would be greatly appreciated.

 

Thanks,

 

Charlie Irwin

 

[edit] fat fingers...

 

---------------------------------------------------------------------------------

 

 

+ Recycle backup using Tuesday Backup at 10/24/2006 10:00 PM (Execution unit 1)

To Backup Set Tuesday Media...

10/24/2006 10:00:03 PM: Recycle backup: The Backup Set was reset

 

- 10/24/2006 10:00:03 PM: Copying Main (C:)

File "C:\Program Files\Symantec AntiVirus\SAVRT\0322NAV~.TMP": can't read, error -1020 (sharing violation)

File "C:\Program Files\Symantec AntiVirus\SAVRT\0674NAV~.TMP": can't read, error -1020 (sharing violation)

File "C:\WINDOWS\SoftwareDistribution\EventCache\{D2470687-79EC-4C77-811B-A9A501F45533}.bin": can't read, error -1020 (sharing violation)

File "C:\WINDOWS\system32\dhcp\dhcp.mdb": can't read, error -1020 (sharing violation)

File "C:\WINDOWS\system32\dhcp\j50.log": can't read, error -1020 (sharing violation)

File "C:\WINDOWS\system32\dhcp\j50tmp.log": can't read, error -1020 (sharing violation)

File "C:\WINDOWS\system32\dhcp\tmp.edb": can't read, error -1020 (sharing violation)

File "C:\WINDOWS\Temp\hsperfdata_SYSTEM\348": can't read, error -1020 (sharing violation)

10/24/2006 10:23:50 PM: Snapshot stored, 217.7 MB

10/24/2006 10:24:01 PM: Comparing Main (C:)

File "C:\WINDOWS\repair\default": different creation date/time (set: 10/18/2006 8:58:11 AM, vol: 10/24/2006 10:21:51 PM)

File "C:\WINDOWS\repair\SAM": different creation date/time (set: 10/18/2006 8:58:11 AM, vol: 10/24/2006 10:21:52 PM)

File "C:\WINDOWS\repair\SECURITY": different creation date/time (set: 10/18/2006 8:58:11 AM, vol: 10/24/2006 10:21:52 PM)

File "C:\WINDOWS\repair\software": different creation date/time (set: 10/18/2006 8:58:11 AM, vol: 10/24/2006 10:21:52 PM)

File "C:\WINDOWS\repair\system": different creation date/time (set: 10/18/2006 8:58:13 AM, vol: 10/24/2006 10:21:57 PM)

File "C:\WINDOWS\repair\Backup\BootableSystemState\ComRegistrationDatabase\ComRegDb.bak": different creation date/time (set: 10/18/2006 8:58:11 AM, vol: 10/24/2006 10:21:51 PM)

File "C:\WINDOWS\repair\Backup\ServiceState\EventLogs\AppEvent.Evt": different creation date/time (set: 10/18/2006 8:58:11 AM, vol: 10/24/2006 10:21:51 PM)

File "C:\WINDOWS\repair\Backup\ServiceState\EventLogs\DnsEvent.Evt": different creation date/time (set: 10/18/2006 8:58:11 AM, vol: 10/24/2006 10:21:53 PM)

File "C:\WINDOWS\repair\Backup\ServiceState\EventLogs\NTDS.Evt": different creation date/time (set: 10/18/2006 8:58:11 AM, vol: 10/24/2006 10:21:52 PM)

File "C:\WINDOWS\repair\Backup\ServiceState\EventLogs\NtFrs.Evt": different creation date/time (set: 10/18/2006 8:58:11 AM, vol: 10/24/2006 10:21:53 PM)

File "C:\WINDOWS\repair\Backup\ServiceState\EventLogs\SecEvent.Evt": different creation date/time (set: 10/18/2006 8:58:11 AM, vol: 10/24/2006 10:21:53 PM)

File "C:\WINDOWS\repair\Backup\ServiceState\EventLogs\SysEvent.Evt": different creation date/time (set: 10/18/2006 8:58:16 AM, vol: 10/24/2006 10:22:29 PM)

File "C:\WINDOWS\system32\wbem\Logs\wbemprox.log": different modify date/time (set: 10/24/2006 10:21:00 PM, vol: 10/24/2006 10:40:00 PM)

File "C:\WINDOWS\system32\wbem\Repository\FS\MAPPING.VER": different modify date/time (set: 10/19/2006 4:57:21 PM, vol: 10/24/2006 10:22:30 PM)

10/24/2006 10:41:19 PM: 21 execution errors

Completed: 28415 files, 5.7 GB

Performance: 315.5 MB/minute (273.1 copy, 373.7 compare)

Duration: 00:41:16 (00:04:49 idle/loading/preparing)

 

 

- 10/24/2006 10:41:19 PM: Copying Documents and Settings on Main (C:)

File "C:\Documents and Settings\Administrator\NTUSER.DAT": can't read, error -1020 (sharing violation)

File "C:\Documents and Settings\Administrator\ntuser.dat.LOG": can't read, error -1020 (sharing violation)

File "C:\Documents and Settings\Administrator\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat": can't read, error -1020 (sharing violation)

File "C:\Documents and Settings\Administrator\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG": can't read, error -1020 (sharing violation)

File "C:\Documents and Settings\LocalService\NTUSER.DAT": can't read, error -1020 (sharing violation)

File "C:\Documents and Settings\LocalService\ntuser.dat.LOG": can't read, error -1020 (sharing violation)

File "C:\Documents and Settings\LocalService\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat": can't read, error -1020 (sharing violation)

File "C:\Documents and Settings\LocalService\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG": can't read, error -1020 (sharing violation)

File "C:\Documents and Settings\NetworkService\NTUSER.DAT": can't read, error -1020 (sharing violation)

File "C:\Documents and Settings\NetworkService\ntuser.dat.LOG": can't read, error -1020 (sharing violation)

File "C:\Documents and Settings\NetworkService\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat": can't read, error -1020 (sharing violation)

File "C:\Documents and Settings\NetworkService\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG": can't read, error -1020 (sharing violation)

10/24/2006 10:42:29 PM: Snapshot stored, 1,722 KB

10/24/2006 10:42:32 PM: Comparing Documents and Settings on Main (C:)

10/24/2006 10:45:20 PM: 12 execution errors

Completed: 2767 files, 247.9 MB

Performance: 309.7 MB/minute (232.3 copy, 479.6 compare)

Duration: 00:04:01 (00:02:25 idle/loading/preparing)

 

 

- 10/24/2006 10:45:20 PM: Copying Program Files on Main (C:)

File "C:\Program Files\Symantec AntiVirus\SAVRT\0322NAV~.TMP": can't read, error -1020 (sharing violation)

File "C:\Program Files\Symantec AntiVirus\SAVRT\0674NAV~.TMP": can't read, error -1020 (sharing violation)

10/24/2006 10:50:01 PM: Snapshot stored, 4,239 KB

10/24/2006 10:50:04 PM: Comparing Program Files on Main (C:)

10/24/2006 10:55:59 PM: 2 execution errors

Completed: 7619 files, 2.0 GB

Performance: 472.8 MB/minute (441.5 copy, 511.0 compare)

Duration: 00:10:38 (00:02:10 idle/loading/preparing)

 

 

- 10/24/2006 10:55:59 PM: Copying replication on Main (C:)

10/24/2006 10:56:02 PM: Snapshot stored, 7 KB

10/24/2006 10:56:05 PM: Comparing replication on Main (C:)

10/24/2006 10:57:37 PM: Execution completed successfully

Completed: 2 files, 8 KB

Performance: 0.4 MB/minute (0.2 copy, 0.4 compare)

Duration: 00:01:37 (00:01:34 idle/loading/preparing)

 

 

- 10/24/2006 10:57:37 PM: Copying System Volume Information on Main (C:)

10/24/2006 10:57:40 PM: Snapshot stored, 7 KB

10/24/2006 10:57:43 PM: Comparing System Volume Information on Main (C:)

10/24/2006 10:59:14 PM: Execution completed successfully

Completed: 2 files, 20 KB

Performance: 1.1 MB/minute (0.5 copy, 1.1 compare)

Duration: 00:01:37 (00:01:35 idle/loading/preparing)

 

 

- 10/24/2006 10:59:14 PM: Copying Data (E:)

10/25/2006 12:16:20 AM: Snapshot stored, 54.7 MB

10/25/2006 12:16:26 AM: Comparing Data (E:)

10/25/2006 1:30:59 AM: Execution completed successfully

Completed: 63103 files, 28.9 GB

Performance: 402.6 MB/minute (396.3 copy, 409.2 compare)

Duration: 02:31:44 (00:04:49 idle/loading/preparing)

 

 

- 10/25/2006 1:30:59 AM: Copying Shared Folders on Data (E:)

10/25/2006 2:14:33 AM: Snapshot stored, 42.4 MB

10/25/2006 2:14:38 AM: Comparing Shared Folders on Data (E:)

10/25/2006 2:54:02 AM: Execution completed successfully

Completed: 43805 files, 16.0 GB

Performance: 409.6 MB/minute (387.5 copy, 434.7 compare)

Duration: 01:23:03 (00:03:09 idle/loading/preparing)

 

 

- 10/25/2006 2:54:02 AM: Copying Extra HD (F:)

10/25/2006 4:01:04 AM: Snapshot stored, 21.8 MB

10/25/2006 4:01:08 AM: Comparing Extra HD (F:)

10/25/2006 5:04:23 AM: Execution completed successfully

Completed: 26269 files, 32.9 GB

Performance: 525.8 MB/minute (512.6 copy, 539.7 compare)

Duration: 02:10:20 (00:02:15 idle/loading/preparing)

 

 

- 10/25/2006 5:04:23 AM: Copying Download on Extra HD (F:)

10/25/2006 5:04:30 AM: Snapshot stored, 8 KB

10/25/2006 5:04:33 AM: Comparing Download on Extra HD (F:)

10/25/2006 5:05:04 AM: Execution completed successfully

Completed: 3 files, 24.4 MB

Performance: 292.7 MB/minute (243.9 copy, 487.9 compare)

Duration: 00:00:41 (00:00:30 idle/loading/preparing)

 

 

- 10/25/2006 5:05:04 AM: Copying server on Extra HD (F:)

10/25/2006 5:05:09 AM: Snapshot stored, 10 KB

10/25/2006 5:05:12 AM: Comparing server on Extra HD (F:)

10/25/2006 5:05:45 AM: Execution completed successfully

Completed: 9 files, 7,396 KB

Performance: 173.3 MB/minute (108.3 copy, 433.3 compare)

Duration: 00:00:41 (00:00:35 idle/loading/preparing)

 

 

- 10/25/2006 5:05:45 AM: Copying Shared Folders on Extra HD (F:)

10/25/2006 3:14:59 PM: Execution stopped by operator

Remaining: 18607 files, 27.3 GB

Completed: 6960 files, 4.5 GB

Performance: 474.9 MB/minute

Duration: 10:09:13 (09:59:32 idle/loading/preparing)

 

10/25/2006 3:15:00 PM: Execution stopped by operator

Total performance: 437.1 MB/minute

Total duration: 17:14:46 (10:23:28 idle/loading/preparing)

[nekr0phage]

Hi Charlie,

 

It looks like everything other than 'Extra HD (F:)' is backing up as expected, with a few errors for open files. My question to you is: what is different about the F: volume that it would fail where everything else completes? Do you have any databases hosted, there? Mapped home directories? Whats on that drive?

[mirQtio]

The folder that is not completing on HD:F is a shared folder - which contains only one folder called "graphics". This is the backup for all of our multimedia and graphics files for the company and website. I recall when Varsity first set the server up for us they put this one on it's on drive b/c it was so large. The two largest sub folders are 11.3 GB and 9 GB - the 11.3GB is for website stuff and the 9 GB one is video stuff. There are video files, flash, windows media movie files and mp3's as well. We have always had some on the server, and have steadily created more so slowly increased our space usage. I wonder if Retrospect has an issue with any of the file types?

[mirQtio]

No further help on this issue? No ideas based on the type of data being backed up?

 

Thanks.

[nekr0phage]

If that directory is shared out to other users there might be some issue with open files taking along time to snap or failing the backup outright. Are there any errors listed in the Windows Event Viewer? Have you ever been able to succesfully backup Shared Folders?

 

Also, what operating system is this? I'm guessing you don't have the open files backup add-on, as you are receiving open file errors on other volumes. Would any files located in those directories be in use at the time of the backup?

[mirQtio]

The OS is Win2k3 Standard SP1. At the time the backup runs, the files would not be in use. I can back up other shared folders without issue. I will look further into the Windows events as soon as I can.

 

Thanks again.

[mirQtio]

I still seem to be having this problem and I can't seem to find anything in the event logs that would indicate the reason. All I can think of is that it is tied to the type of content on this drive. I have seen reference to issues with large encrypted ZIP files causing issues, I am wondering if the compression on various video, audio and image files could lead to the same thing.