SBS2003 Exchange Backup Problems (& musings)

I'm convinced (after ten years in this game) that tape backups are HIGHLY
unreliable, and only work reliably on brand spanking new installs. Native
Windows Backup, Backup Exec, ArcServe, you name it. Sooner or later, if you
have a system that has been around any length of time with anything "extra"
installed - such as BlackBerry - it will blow out your backups. You'll never
get it to work again. You might as well just wipe the whole server and start
over. I hate it.

Now that I've got that out of the way, I'll show you a "bad" backup that
isn't working properly. Nothing fancy about it. Just went with the plain ol'
vanilla Backup Wizard from Server Management. Unsurprisingly, it doesn't work.

I'm going to reply to this posting immediately, and show you a "good" backup
on a brand new system i just installed. No problem, of course...because, like
i said, it's brand new. Give it a few months and it will break as well, never
to work again until I wipe the entire server.

Have a nice day everyone! Here's the BAD job log:

4/16/2005 6:59 PM
-------------------------------
Date: 4/16/2005
Time: 6:59 PM
User: Administrator
-------------------------------

Backup Runner started.
NTMS session started successfully.
EnumerateNtmsObject(NTMS_LIBRARY) succeeded.
Will enumerate on 3 media libraries found.
GetNtmsObjectInformation(NtmsLibraryInfo) succeeded.
GetNtmsObjectInformation(NtmsLibraryInfo) succeeded.
Found an enabled library.
InventoryNtmsLibrary(NtmsInventoryOmid) succeeded.
Identify Media completed
EnumerateNtmsObject(NTMS_MEDIA_TYPE) succeeded.
Will enumerate on 1 media types found.
GetNtmsObjectInformation(NtmsMediaTypeInfo) succeeded.
GetNtmsObjectInformation(NtmsLibraryInfo) succeeded.
Found an enabled library.
InventoryNtmsLibrary(NtmsInventoryOmid) succeeded.
Identify Media completed
EnumerateNtmsObject(NTMS_MEDIA_TYPE) succeeded.
Will enumerate on 1 media types found.
GetNtmsObjectInformation(NtmsMediaTypeInfo) succeeded.
Found a tape media type in the library (4mm DDS).
Launching NTBackup: ntbackup.exe backup "@C:\Program Files\Microsoft Windows
Small Business Server\Backup\Small Business Backup Script.bks" /d "SBS Backup
created on 4/16/2005 at 6:59 PM" /v:yes /r:no /rs:no /hc:on /m normal /j
"Small Business Server Backup Job" /l:s /p "4mm DDS" /UM
NTBACKUP LOG FILE: C:\Documents and Settings\SBS Backup User\Local
Settings\Application Data\Microsoft\Windows NT\NTBackup\data\backup02.log
=====================<BEGIN NTBACKUP LOG FILE>=====================
Backup Status
Operation: Backup
Active backup destination: 4mm DDS
Media name: "Media created 4/16/2005 at 6:59 PM"


Error returned while creating the volume shadow copy:800423f4
Reverting to non-shadow copy backup mode.
Backup of "C: "
Backup set #1 on media #1
Backup description: "SBS Backup created on 4/16/2005 at 6:59 PM"
Media name: "Media created 4/16/2005 at 6:59 PM"

Backup Type: Normal

Backup started on 4/16/2005 at 7:05 PM.
Warning: Unable to open "C:\Documents and
Settings\Administrator\Cookies\index.dat" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Documents and Settings\Administrator\Local
Settings\History\History.IE5\index.dat" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Documents and Settings\Administrator\Local
Settings\History\History.IE5\MSHist012005041620050417\index.dat" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Documents and Settings\Administrator\Local
Settings\Temporary Internet Files\Content.IE5\index.dat" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Documents and Settings\All Users\Application
Data\Microsoft\Shared Fax\ActivityLog\InboxLOG.txt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Documents and Settings\All Users\Application
Data\Microsoft\Shared Fax\ActivityLog\OutboxLOG.txt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Documents and Settings\BESAdmin\Local
Settings\Temp\hsperfdata_BESAdmin\436" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Documents and
Settings\LocalService\Cookies\index.dat" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Documents and Settings\LocalService\Local
Settings\History\History.IE5\index.dat" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Documents and Settings\LocalService\Local
Settings\Temporary Internet Files\Content.IE5\index.dat" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Documents and Settings\NetworkService\Local
Settings\Application Data\ApplicationHistory\2502a0a.95004e01.ini.inuse" -
skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Documents and Settings\NetworkService\Local
Settings\Application Data\ApplicationHistory\w3wp.exe.95004e01.ini.inuse" -
skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\APC\PowerChute Business
Edition\agent\data.dat" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\APC\PowerChute Business
Edition\agent\debug.txt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\APC\PowerChute Business
Edition\agent\EventLog" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\APC\PowerChute Business
Edition\server\data.dat" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\APC\PowerChute Business
Edition\server\debug.txt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\BESMgmt.mdf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\BESMgmtlog.ldf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\master.mdf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\mastlog.ldf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\model.mdf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\modellog.ldf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\msdbdata.mdf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\msdblog.ldf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\northwnd.ldf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\northwnd.mdf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\pubs.mdf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\pubs_log.ldf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\tempdb.mdf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\Data\templog.ldf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL\LOG\ERRORLOG" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL$SHAREPOINT\Data\master.mdf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL$SHAREPOINT\Data\mastlog.ldf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL$SHAREPOINT\Data\model.mdf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL$SHAREPOINT\Data\modellog.ldf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL$SHAREPOINT\Data\STS_Config.mdf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL$SHAREPOINT\Data\STS_Config_log.LDF" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL$SHAREPOINT\Data\STS_SASSYSERVER_1.mdf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL$SHAREPOINT\Data\STS_SASSYSERVER_1_log.LDF" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL$SHAREPOINT\Data\tempdb.mdf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL$SHAREPOINT\Data\templog.ldf" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Microsoft SQL
Server\MSSQL$SHAREPOINT\LOG\ERRORLOG" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\ORF Enterprise
Edition\orfee-2005-04-16.log" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Research In Motion\BlackBerry
Enterprise Server\Logs\20050416_BlackBerry Enterprise
Server_WIFBBYSERVER.txt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Research In Motion\BlackBerry
Enterprise
Server\MDS\Servers\WIFBBYSERVER\logs\webserver\MDS_web_access_log.2005-04-16.txt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Research In Motion\BlackBerry
Enterprise
Server\MDS\Servers\WIFBBYSERVER\logs\webserver\MDS_web_log.2005-04-16.txt" -
skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\Program Files\Research In Motion\BlackBerry
Enterprise Server\Servers\controllerdebuglog20050416.txt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\security\logs\scepol.log" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\h323log.txt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\hmdebug.log" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\config\AppEvent.Evt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\config\DnsEvent.Evt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\config\NTDS.Evt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\config\NtFrs.Evt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\config\SecEvent.Evt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\config\SysEvent.Evt" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\dhcp\dhcp.mdb" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\dhcp\DhcpSrvLog-Sat.log" -
skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\dhcp\j50.log" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\dhcp\tmp.edb" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\wins\j50.log" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\wins\wins.mdb" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\system32\wins\winstmp.mdb" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "C:\WINNT\Temp\DWH8BD5.tmp" - skipped.
Reason: The system cannot find the file specified.


Warning: Unable to open "C:\WINNT\Temp\DWH92E0.tmp" - skipped.
Reason: The system cannot find the file specified.


Warning: Unable to open "C:\WINNT\Temp\DWH934E.tmp" - skipped.
Reason: The system cannot find the file specified.


Warning: Unable to open "C:\WINNT\Temp\LB8C.tmp" - skipped.
Reason: Access is denied.


Warning: Unable to open "C:\WINNT\Temp\LB8D.tmp" - skipped.
Reason: Access is denied.


Backup completed on 4/16/2005 at 7:37 PM.
Directories: 3011
Files: 30016
Bytes: 3,985,117,787
Time: 31 minutes and 33 seconds
Backup of "D: "
Backup set #2 on media #1
Backup description: "SBS Backup created on 4/16/2005 at 6:59 PM"
Media name: "Media created 4/16/2005 at 6:59 PM"

Backup Type: Normal

Backup started on 4/16/2005 at 7:37 PM.
Warning: Unable to open "D:\Exchsrvr\BIN\store.fcl" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "D:\Exchsrvr\MDBDATA\E00.log" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "D:\Exchsrvr\MDBDATA\E00tmp.log" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "D:\Exchsrvr\MDBDATA\priv1.edb" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "D:\Exchsrvr\MDBDATA\priv1.stm" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "D:\Exchsrvr\MDBDATA\pub1.edb" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "D:\Exchsrvr\MDBDATA\pub1.stm" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "D:\Exchsrvr\MDBDATA\tmp.edb" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Warning: Unable to open "D:\Exchsrvr\SASSYSERVER.log\20050417.log" - skipped.
Reason: The process cannot access the file because it is being used by
another process.


Backup completed on 4/16/2005 at 9:24 PM.
Directories: 3613
Files: 52764
Bytes: 15,588,763,050
Time: 1 hour, 46 minutes, and 45 seconds
Backup of "SASSYSERVER\Microsoft Information Store\First Storage Group"
Backup set #3 on media #1
Backup description: "SBS Backup created on 4/16/2005 at 6:59 PM"
Media name: "Media created 4/16/2005 at 6:59 PM"

Backup Type: Normal

Backup started on 4/16/2005 at 9:24 PM.
Backup completed on 4/16/2005 at 9:30 PM.
Directories: 4
Files: 5
Bytes: 1,241,621,042
Time: 6 minutes and 20 seconds
Backup of "System State"
Backup set #4 on media #1
Backup description: "SBS Backup created on 4/16/2005 at 6:59 PM"
Media name: "Media created 4/16/2005 at 6:59 PM"

Backup Type: Copy

Backup started on 4/16/2005 at 9:30 PM.
Backup completed on 4/16/2005 at 9:34 PM.
Directories: 230
Files: 2712
Bytes: 525,689,497
Time: 3 minutes and 54 seconds

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

Verify Status
Operation: Verify After Backup
Active backup destination: 4mm DDS

Verify of "C:"
Backup set #1 on media #1
Backup description: "SBS Backup created on 4/16/2005 at 6:59 PM"
Verify started on 4/16/2005 at 9:36 PM.
Verify completed on 4/16/2005 at 9:52 PM.
Directories: 3011
Files: 30016
Different: 0
Bytes: 3,985,117,787
Time: 16 minutes and 15 seconds

Verify of "D:"
Backup set #2 on media #1
Backup description: "SBS Backup created on 4/16/2005 at 6:59 PM"
Verify started on 4/16/2005 at 9:52 PM.
Verify completed on 4/16/2005 at 11:22 PM.
Directories: 3613
Files: 52764
Different: 0
Bytes: 15,588,763,050
Time: 1 hour, 29 minutes, and 47 seconds

Verify of "SASSYSERVER\Microsoft Information Store\First Storage Group"
Backup set #3 on media #1
Backup description: "SBS Backup created on 4/16/2005 at 6:59 PM"
Verify started on 4/16/2005 at 11:22 PM.
Verify completed on 4/16/2005 at 11:28 PM.
Directories: 4
Files: 0
Different: 0
Bytes: 1,241,621,042
Time: 6 minutes and 17 seconds

Verify of "System State"
Backup set #4 on media #1
Backup description: "SBS Backup created on 4/16/2005 at 6:59 PM"
Verify started on 4/16/2005 at 11:28 PM.
Verify completed on 4/16/2005 at 11:30 PM.
Directories: 230
Files: 2712
Different: 0
Bytes: 525,689,497
Time: 1 minute and 53 seconds

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

=======================<END NTBACKUP LOG FILE>=====================
NTBackup finished the backup with errors.

For more information about failed backups, see the article on
troubleshooting your backup at the following Web page:
http://go.microsoft.com/fwlink/?LinkId=18414

Backup ended at Saturday, April 16, 2005 11:30 PM
Backup Runner finished.


.

Relevant Pages

  • RE: Backups have Shadow Copy Problems
    ... Active backup destination: File ... Reason: The process cannot access the file because it is being used by ... Warning: Unable to open "C:\Documents and Settings\Administrator\Local ... Warning: Unable to open "C:\Program Files\Microsoft SQL ...
    (microsoft.public.windows.server.sbs)
  • RE: Backup issues after changing administrator name
    ... turned it to automatic, then reran backup. ... Warning: Unable to open "C:\Documents and Settings\Administrator\Application ... Reason: The process cannot access the file because it is being used by ... Warning: Unable to open "D:\Program Files\Microsoft SQL ...
    (microsoft.public.windows.server.sbs)
  • Re: Backup erros
    ... You may have a SQL ... Error 800423f4 appears in the backup log file when you back up a volume by ... > Reason: The process cannot access the file because it is being used by> another process. ...
    (microsoft.public.windows.server.sbs)
  • Re: Backups HELP!
    ... I have rerun the backup wizard many times, ... Warning: Unable to open "C:\Documents and Settings\Administrator\Local ... Settings\Temporary Internet Files\Content.IE5\desktop.ini" - skipped. ... Reason: Access is denied. ...
    (microsoft.public.windows.server.sbs)
  • Backup Question
    ... the backup would work for a few days then fail and keep failing until you ... Warning: Unable to open "C:\Documents and Settings\All Users\Application ... Reason: The process cannot access the file because it is being used by ... Warning: Unable to open "C:\Program Files\Microsoft SQL ...
    (microsoft.public.windows.server.sbs)