Video Screencast Help
Symantec to Separate Into Two Focused, Industry-Leading Technology Companies. Learn more.

Snapshot provider error (0xE000851C)

Created: 31 Jan 2007 • Updated: 21 May 2010 | 14 comments

V-79-57344-34110 - AOFO: Initialization failure on: "C:". Advanced Open File Option used: Symantec Volume Snapshot Provider (VSP).
Snapshot provider error (0xE000851C): Cache files required for the Symantec Volume Snapshot Provider (VSP) snapshot could not be created. Check that there is at least 50 MB of free disk space, and review the settings for the snapshot that are reported in the job log.
Check the Windows Event Viewer for details.

I am getting this every time I try to backup C: or D: using VSP.

I have tried uninstalling/reinstalling AOFO option.

I have tried AOFO set on Default. I have tried settings AOFO to use the E:\ drive(500GB FREE SPACE).

I have tried Manually Configuring the Cache size.

Nothing will work to allow VSP.

Comments 14 CommentsJump to latest comment

Joshua Kane's picture

Eric,

have you tried the steps outlined in the Technote below?

http://seer.entsupport.symantec.com/docs/274096.htm




-- Joshua

Backup Exec for Windows Servers Free E-mail Support
http://seer.entsupport.symantec.com/email_forms/in...

Joshua Kane

Escalations Manager
ECRT (Engineering Customer Response Team)
Backup Exec Engineering
Symantec Corporation

DanielBickford's picture

My first thought would be to make sure that rights have not been resticted in some way that would prevent VSP from writing to the root of the drive. You may also want to make sure the option "Process logical volumes for backup one at a time (on the Advanced Open File section of the job properties) is enabled.

The only other thing I can think of based on the error would be if this is a Windows 2003 server, you could try using VSS as a test to see if there are any issues there.

Joshua Kane's picture

What about the suggestions made by Dan?

Joshua Kane

Escalations Manager
ECRT (Engineering Customer Response Team)
Backup Exec Engineering
Symantec Corporation

Eric Kufrin's picture

Process Logical Volumes One At A Time is enabled.

I went in and specifically added FULL CONTROL on the E:\ drive and the Backup Exec AOFO Store folder.

I tried it using VSS instead of VSP and it worked without error.

Joshua Kane's picture

Eric

Please enable debugging on the remote agent and attempt your job again, and then post the log to the forum.

The easiest way to enable this is to stop the Remote Agent for Windows Servers.
double click on the service and under startup paramaters insert the following
"-debug"
then press the start button.
The log will be located under your backupexec\logs directory. It will have BERemote in the name.

Joshua Kane

Escalations Manager
ECRT (Engineering Customer Response Team)
Backup Exec Engineering
Symantec Corporation

Eric Kufrin's picture

Just to be clear, this is a single server running Windows Server 2003 Small Business Edition w/ SP1. Backing up only locally.

I will perform the debuging and post the log.

Eric Kufrin's picture

I replaced my real domain name with mydomainname

02/01/07 09:58:32 Opened debug log file C:\Program Files\Symantec\Backup Exec\logs\SBS01-beremote01.log
02/01/07 09:58:32 CleanupOrphanedSnapshots(). Lauching cleanup thread..
02/01/07 09:58:32 CleanupOrphanedSnapshots(). Cleanup thread lauched. Exiting.
02/01/07 09:58:32 VssSnapshotVolume::CleanupOrphanedSnapshots(). No orphaned snaphots found
02/01/07 09:58:32 FS_InitFileSys
02/01/07 09:58:32 loaded bedsnt5.dll
02/01/07 09:58:32 loaded bedsadc.dll
02/01/07 09:58:32 loaded bedssql2.dll
02/01/07 09:58:32 loaded bedsxchg.dll
02/01/07 09:58:32 VirtApi DLL WAS LOADED FROM C:\WINDOWS\FltMgr\VirtApi.dll! Virtual DB's WILL BE USED!
02/01/07 09:58:32 loaded bedsxese.dll
02/01/07 09:58:32 loaded bedsmbox.dll
02/01/07 09:58:32 bedspush.dll could not be loaded: The specified module could not be found.
02/01/07 09:58:32 loaded bedsnote.dll
02/01/07 09:58:32 loaded bedsmdoc.dll
02/01/07 09:58:32 loaded bedssps2.dll
02/01/07 09:58:32 loaded bedsupfs.dll
02/01/07 09:58:32 loaded bedsshadow.dll
02/01/07 09:58:32 loaded bedsoffhost.dll
02/01/07 09:58:32 ENTER DpmSettings::DpmSettings
02/01/07 09:58:32 EXIT DpmSettings::DpmSettings return=
02/01/07 09:58:32 loaded bedsdpm.dll
02/01/07 09:58:32 loaded bedscps.dll
02/01/07 09:58:32 bedsvx.dll could not be loaded: The specified module could not be found.
02/01/07 09:58:32 bedsorcl.dll could not be loaded: The specified module could not be found.
02/01/07 09:58:32 loaded bedsagnt.dll
02/01/07 09:58:32 loaded bedssmsp.dll
02/01/07 09:58:32 loaded bedsra.dll
02/01/07 09:58:32 loaded bedsrman.dll
02/01/07 09:58:32 loaded bedsdb2.dll
02/01/07 09:58:32 loaded bedsss.dll
02/01/07 09:58:32 VirtApi DLL WAS LOADED FROM C:\WINDOWS\FltMgr\VirtApi.dll! Virtual DB's WILL BE USED!
02/01/07 09:58:32 loaded bedsadgran.dll
02/01/07 09:58:32 Initializing FSs
02/01/07 09:58:32 calling mapi initialize
02/01/07 09:58:32 Mailbox: InitializeDAPI failed.
02/01/07 09:58:32 Notes Agent:CLNPartitions::InitializeLNUCJWrapper
02/01/07 09:58:32 Notes Agent:CLNPartitions::InitializeLNUCJWrapper - Exiting
02/01/07 09:58:32 Notes Agent:CLNPartitions::InitializeAllVolumes
02/01/07 09:58:32 Notes Agent - CLNVolume::InitInstance - ReturnValue
02/01/07 09:58:32 Notes Agent - CLNVolume::InitInstance - ReturnValue
02/01/07 09:58:32 Notes Agent - CLNVolume::InitInstance - ReturnValue
02/01/07 09:58:32 Notes Agent:CLNPartitions::InitializeAllVolumes - Exiting
02/01/07 09:58:32 Notes Agent:CLNPartitions::InitInstance - Exiting
02/01/07 09:58:32 Function called: RMAN_InitFileSys
02/01/07 09:58:32 IsIDRInProgressPriv: 0x0
02/01/07 09:58:32 IsIDRInProgressPriv: 0x0
02/01/07 09:58:32 Informational: Initializing the BeDiskFind library 'BEDiskFind.dll' in SHADOW::InitBeDiskFindHelperApis
02/01/07 09:58:32 Informational: BeDiskFind library 'BEDiskFind.dll' initialized in SHADOW::InitBeDiskFindHelperApis
02/01/07 09:58:32 Event: Global\RxService CREATED
02/01/07 09:58:32 Informational: Initializing the BeDisk library 'BeDisk.dll' in SHADOW::InitBeDiskHelperApis
02/01/07 09:58:32 Informational: BeDisk library 'BeDisk.dll' initialized in SHADOW::InitBeDiskHelperApis
02/01/07 09:58:32 first load attempt of esebcli2.dll failed: The specified module could not be found.
02/01/07 09:58:32 esebcli2.dll found in BackupRestore dll directory
02/01/07 09:58:32 ESE_InitPlatinum loaded esebcli2.dll from C:\Program Files\Exchsrvr\bin\esebcli2.dll.
02/01/07 09:58:32 Status Unknown (0x00000002) opening Cps registry key 'Software\Symantec\Backup Exec CPS' in CPS::InitCpsHelperApis:379
02/01/07 09:58:32 Informational: Initializing the Cps library 'C:\Program Files\Symantec\Continuous Protection Server\Services\CPSVersion.dll' in CPS::InitCpsHelperApis:410
02/01/07 09:58:32 Status Unknown (0x0000007E) loading Cps library 'C:\Program Files\Symantec\Continuous Protection Server\Services\CPSVersion.dll' in CPS::InitCpsHelperApis:417
02/01/07 09:58:32 Status Unknown (0x0000007E) initializing Cps library in CPS::InitFsys:85
02/01/07 09:58:32 ENTER DPM::InitFsys
02/01/07 09:58:32 ENTER DpmSettings::LoadSettings
02/01/07 09:58:32 DPM: Software\Symantec\Backup Exec For Windows\Backup Exec\Engine\Agents\DPM not found.
02/01/07 09:58:32 ENTER DpmSettings::Print
02/01/07 09:58:32
02/01/07 09:58:32 Software\Symantec\Backup Exec For Windows\Backup Exec\Engine\Agents\DPM
02/01/07 09:58:32 OnServer='\Volumes\Replica\'
02/01/07 09:58:32 VolumeKey='\Volumes\Replica\'
02/01/07 09:58:32 Replica='Replica'
02/01/07 09:58:32 ReplicaDir='ReplicaDir'
02/01/07 09:58:32 Dash='-'
02/01/07 09:58:32 WriterServiceName='DpmWriter'
02/01/07 09:58:32 ServiceName='MSDPM'
02/01/07 09:58:32 SqlInstance='$DPM$'
02/01/07 09:58:32 SecondsToWaitForDpm='90'
02/01/07 09:58:32 WriterStartType=DPM_WRITER_START_TYPE_INITFS
02/01/07 09:58:32 PsBackupType=PS_BACKUP_TYPE_COPY
02/01/07 09:58:32 EXIT DpmSettings::Print return=
02/01/07 09:58:32 EXIT DpmSettings::LoadSettings return=
02/01/07 09:58:32 ENTER DPM::IsServicePresent
02/01/07 09:58:32 DPM: Failed OpenService
02/01/07 09:58:32 DPM: Service is present:
02/01/07 09:58:32 EXIT DPM::IsServicePresent
02/01/07 09:58:32 DPM: Data Protection Manager not installed.
02/01/07 09:58:32 EXIT DPM::InitFsys return=
02/01/07 09:58:32 Function called: DB2_InitFileSys
02/01/07 09:58:32 ADC_InitFileSys entered
02/01/07 09:58:33 ADC_InitFileSys: established top domain
02/01/07 09:58:33 Could not resolve the "ndmp" service, error code: 10109, using port 10000
02/01/07 09:58:33 Could not create an IPv6 socket at this time, reason:An error occurred during a socket creation operation: Error Code: 10047, System Error Message: An address incompatible with the requested protocol was used.
02/01/07 09:58:33 @@@@@@@MyCloseSocket called with sockfd = 640(0x280)retval = 0
02/01/07 09:58:33 SocketService::IsSystemDualIP: No support found for IPv6 currently
02/01/07 09:58:33 Started NDMP Listener on port 10000
02/01/07 09:58:34 Running... 'Q' to stop
02/01/07 09:58:43 NrdsAdvertiserThread: advertisement cycle started.
02/01/07 09:58:43 Informational: Restrict Anonymous Support is enabled
02/01/07 09:58:43 creating DLE for local machine
02/01/07 09:58:43 BENetConfigEx: Successfully refreshed adapter information.
02/01/07 09:58:43 EnumClusterDLEs: Could not opening cluster : The system could not find the environment option that was entered.
02/01/07 09:58:43 NrdsAdvertiserThread: EnumSelfDLE for file system 7 returned 0(0x0) and 1 DLEs
02/01/07 09:58:43 NrdsAdvertiserThread: Nrds Message Len : 129.
02/01/07 09:58:43 RMAN_EnumSelfDLE: AgentConfig GetOracleDBNames returned error. If Oracle Agent is installed, please run AgentConfig.
02/01/07 09:58:43 NrdsAdvertiserThread: EnumSelfDLE for file system 14 returned 0(0x0) and 0 DLEs
02/01/07 09:58:43 ConnectToServerEndPoint: dest=127.0.0.1, service=6101
02/01/07 09:58:43 CreateConnection type=0 on socket 848 via BESocket OK
02/01/07 09:58:43 NrdsAdvertiserThread: send of sbs01.local.mydomainname.com type 7 subtype 2 to target=127.0.0.1 port=6101 succeeded
02/01/07 09:58:43 @@@@@@@MyCloseSocket called with sockfd = 848(0x350)retval = 0
02/01/07 09:58:43 ConnectToServerEndPoint: dest=SBS01, service=6101
02/01/07 09:58:43 CreateConnection type=0 on socket 856 via BESocket OK
02/01/07 09:58:43 NrdsAdvertiserThread: send of sbs01.local.mydomainname.com type 7 subtype 2 to target=SBS01 port=6101 succeeded
02/01/07 09:58:43 @@@@@@@MyCloseSocket called with sockfd = 856(0x358)retval = 0
02/01/07 09:58:43 NrdsAdvertiserThread: advertisement cycle complete. Waiting 240 minutes before advertising again.
02/01/07 09:58:48 NrdsAdvertiserThread: negative (purge) advertisement cycle started.
02/01/07 09:58:48 NrdsAdvertiserThread: no purge is pending.
02/01/07 09:58:48 NrdsAdvertiserThread: negative (purge) advertisement cycle complete. Waiting 240 minutes before advertising again.
02/01/07 09:59:04 DS_LogonSelectionService: mydomainname\svc.BACKUP
02/01/07 09:59:04 DsWorkerThread starting as mydomainname\svc.BACKUP
02/01/07 09:59:04 GetServerType for local machine
02/01/07 09:59:04 GetServerType for local machine
02/01/07 09:59:04 GetServerType for local machine
02/01/07 09:59:04 Finding MNET entries using PunchDownWithWNetCalls()
02/01/07 09:59:04 No Oracle SID's were discovered
02/01/07 09:59:04 GetServerType for local machine
02/01/07 09:59:04 Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
02/01/07 09:59:04 No utility partitions found on any of the disks
02/01/07 09:59:04 NRDS_RA_FindDrives entered
02/01/07 09:59:04 FS_CreateTempDLE
02/01/07 09:59:04 NRDS cache-hit for sbs01.local.mydomainname.com
02/01/07 09:59:04 NRDS_RA_FindDrives completed
02/01/07 09:59:04 Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:687
02/01/07 09:59:04 Informational: Cps library not available. Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:691
02/01/07 09:59:04 Function called: DB2_FindDrives
02/01/07 09:59:04 Status 0xE0008488 returned calling FindDrives for file system 28 in DLE_UpdateList
02/01/07 09:59:04 AD:DeviceName "System?State" in SystemState::CreateDLEs:314
02/01/07 09:59:04 AD:Full Device Path "System?State" in SystemState::CreateDLEs:319
02/01/07 09:59:04 AD:ADRO Agent is authorized for System?State.
02/01/07 09:59:04 AD:Found 0 instances of Active Directory Applcation Mode in SystemState::GetADAMInstanceCount:1246
02/01/07 09:59:04 ADC_FindAgents entered
02/01/07 09:59:04 ADC_FindEntries: Created ADC instance 0x00C147A0
02/01/07 09:59:04 BlowOutRoot: entered, instance=0x00C147A0
02/01/07 09:59:04 ADC_FindAgents completed
02/01/07 09:59:04 SQL2_FindDrives - the default SQL Service is not running on SBS01.
02/01/07 09:59:04 SQL2_FindDrives - checking named instance SBSMONITORING.
02/01/07 09:59:04 IsServiceClusterOk called on SBS01
02/01/07 09:59:04 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:04 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:04 SQL2_CreateDLE - creating SBS01\SBSMONITORING.
02/01/07 09:59:04 SQL Version 2000
02/01/07 09:59:04 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:04 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:04 SQL2_FindDrives - checking named instance SHAREPOINT.
02/01/07 09:59:04 IsServiceClusterOk called on SBS01
02/01/07 09:59:04 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:04 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:04 SQL2_CreateDLE - creating SBS01\SHAREPOINT.
02/01/07 09:59:04 SQL Version 2000
02/01/07 09:59:04 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:04 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:04 SQL2_FindDrives - checking named instance BKUPEXEC.
02/01/07 09:59:04 IsServiceClusterOk called on SBS01
02/01/07 09:59:04 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:04 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:04 SQL2_CreateDLE - creating SBS01\BKUPEXEC.
02/01/07 09:59:04 SQL Version 2005
02/01/07 09:59:04 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:04 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:04 Setting 2K5 extended feature bit.
02/01/07 09:59:04 AddESE_DLEs( )
02/01/07 09:59:04 AddESE_DLEs for sever name SBS01
02/01/07 09:59:04 HrESEBackupRestoreGetRegistered: SBS01, NULL = 0x00000000
02/01/07 09:59:04 AreYouSureThisIsAnExchangeServer: SBS01
02/01/07 09:59:04 HrESEBackupRestoreNodes: SBS01 = 0x00000000
02/01/07 09:59:04 Recursing
02/01/07 09:59:04 AreYouSureThisIsAnExchangeServer: SBS01
02/01/07 09:59:04 SBS01 is an Exchange server
02/01/07 09:59:04 AreYouSureThisIsAnExchangeServer SBS01: 1
02/01/07 09:59:04 HrESEBackupFreeNodes:
02/01/07 09:59:04 AreYouSureThisIsAnExchangeServer SBS01: 1
02/01/07 09:59:04 HrESEBackupPrepare: Microsoft Information Store, SBS01 = 0x00000000
02/01/07 09:59:04 HrESEBackupFreeInstance:
02/01/07 09:59:04 HrESEBackupEnd: Microsoft Information Store = 0x00000000
02/01/07 09:59:04 AddESE_DLEs( )
02/01/07 09:59:04 AddESE_DLEs for sever name SBS01
02/01/07 09:59:04 AddESE_DLEs: annotation != NULL
02/01/07 09:59:04 HrESEBackupPrepare: Microsoft Information Store, SBS01 = 0x00000000
02/01/07 09:59:04 ESE_CheckForRSG( )
02/01/07 09:59:05 HrESEBackupFreeInstance:
02/01/07 09:59:05 HrESEBackupEnd: Microsoft Information Store = 0x00000000
02/01/07 09:59:05 HrESEFreeRegistered:
02/01/07 09:59:05 ndmpConnect : Control Connection information: A connection was established between end-points 127.0.0.1:28361 and 127.0.0.1:10000.
02/01/07 09:59:05 ndmpRun: Control connection accepted : connection established between end-points 127.0.0.1:10000 and 127.0.0.1:28361
02/01/07 09:59:05 NDMP version 3 connection CONNECTED
02/01/07 09:59:06 BELogonUser: beclass::IsThisMe() returned error: 87
02/01/07 09:59:06 LogonType set =
02/01/07 09:59:06 LogonUser(LOGON32_LOGON_INTERACTIVE-0x2) success
02/01/07 09:59:06 Successfully impersonated mydomainname\svc.BACKUP
02/01/07 09:59:06 WhoAmI( ) reports: mydomainname\svc.BACKUP
02/01/07 09:59:06 NDMPEngine::SetupNDMPConnection(): Using proxy authentication as requested
02/01/07 09:59:06 Successfully impersonated mydomainname\svc.BACKUP
02/01/07 09:59:06 process ready?
02/01/07 09:59:08 @@@@@@@MyCloseSocket called with sockfd = 1148(0x47c)retval = 0
02/01/07 09:59:08 @@@@@@@MyCloseSocket called with sockfd = -1(0xffffffff)retval = -1
02/01/07 09:59:08 ENTER DPM::FindDrives
02/01/07 09:59:08 ENTER DPM::IsServicePresent
02/01/07 09:59:08 DPM: Failed OpenService
02/01/07 09:59:08 @@@@@@@MyCloseSocket called with sockfd = 932(0x3a4)retval = 0
02/01/07 09:59:08 DPM: Service is present:
02/01/07 09:59:08 EXIT DPM::IsServicePresent
02/01/07 09:59:08 DPM: DPM Service not present
02/01/07 09:59:08 EXIT DPM::FindDrives return=
02/01/07 09:59:08 @@@@@@@MyCloseSocket called with sockfd = -1(0xffffffff)retval = -1
02/01/07 09:59:08 GetServerType for local machine
02/01/07 09:59:08 GetServerType for local machine
02/01/07 09:59:08 GetServerType for local machine
02/01/07 09:59:08 Finding MNET entries using PunchDownWithWNetCalls()
02/01/07 09:59:08 No Oracle SID's were discovered
02/01/07 09:59:08 GetServerType for local machine
02/01/07 09:59:08 Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
02/01/07 09:59:08 No utility partitions found on any of the disks
02/01/07 09:59:08 NRDS_RA_FindDrives entered
02/01/07 09:59:08 FS_CreateTempDLE
02/01/07 09:59:08 NRDS cache-hit for sbs01.local.mydomainname.com
02/01/07 09:59:08 NRDS_RA_FindDrives completed
02/01/07 09:59:08 Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:687
02/01/07 09:59:08 Informational: Cps library not available. Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:691
02/01/07 09:59:08 Function called: DB2_FindDrives
02/01/07 09:59:08 Status 0xE0008488 returned calling FindDrives for file system 28 in DLE_UpdateList
02/01/07 09:59:08 AD:DeviceName "System?State" in SystemState::CreateDLEs:314
02/01/07 09:59:08 AD:Full Device Path "System?State" in SystemState::CreateDLEs:319
02/01/07 09:59:08 AD:ADRO Agent is authorized for System?State.
02/01/07 09:59:08 AD:Found 0 instances of Active Directory Applcation Mode in SystemState::GetADAMInstanceCount:1246
02/01/07 09:59:08 ADC_FindAgents entered
02/01/07 09:59:08 ADC_FindEntries: Created ADC instance 0x00C147A0
02/01/07 09:59:08 BlowOutRoot: entered, instance=0x00C147A0
02/01/07 09:59:08 ADC_FindAgents completed
02/01/07 09:59:08 SQL2_FindDrives - the default SQL Service is not running on SBS01.
02/01/07 09:59:08 SQL2_FindDrives - checking named instance SBSMONITORING.
02/01/07 09:59:08 IsServiceClusterOk called on SBS01
02/01/07 09:59:08 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:08 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:08 SQL2_CreateDLE - creating SBS01\SBSMONITORING.
02/01/07 09:59:08 SQL Version 2000
02/01/07 09:59:08 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:08 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:08 SQL2_FindDrives - checking named instance SHAREPOINT.
02/01/07 09:59:08 IsServiceClusterOk called on SBS01
02/01/07 09:59:08 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:08 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:08 SQL2_CreateDLE - creating SBS01\SHAREPOINT.
02/01/07 09:59:08 SQL Version 2000
02/01/07 09:59:08 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:08 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:08 SQL2_FindDrives - checking named instance BKUPEXEC.
02/01/07 09:59:08 IsServiceClusterOk called on SBS01
02/01/07 09:59:08 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:08 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:08 SQL2_CreateDLE - creating SBS01\BKUPEXEC.
02/01/07 09:59:08 SQL Version 2005
02/01/07 09:59:08 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:08 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:08 Setting 2K5 extended feature bit.
02/01/07 09:59:08 AddESE_DLEs( )
02/01/07 09:59:08 AddESE_DLEs for sever name SBS01
02/01/07 09:59:08 HrESEBackupRestoreGetRegistered: SBS01, NULL = 0x00000000
02/01/07 09:59:08 AreYouSureThisIsAnExchangeServer: SBS01
02/01/07 09:59:08 HrESEBackupRestoreNodes: SBS01 = 0x00000000
02/01/07 09:59:08 Recursing
02/01/07 09:59:08 AreYouSureThisIsAnExchangeServer: SBS01
02/01/07 09:59:08 SBS01 is an Exchange server
02/01/07 09:59:08 AreYouSureThisIsAnExchangeServer SBS01: 1
02/01/07 09:59:08 HrESEBackupFreeNodes:
02/01/07 09:59:08 AreYouSureThisIsAnExchangeServer SBS01: 1
02/01/07 09:59:08 HrESEBackupPrepare: Microsoft Information Store, SBS01 = 0x00000000
02/01/07 09:59:08 HrESEBackupFreeInstance:
02/01/07 09:59:08 HrESEBackupEnd: Microsoft Information Store = 0x00000000
02/01/07 09:59:08 AddESE_DLEs( )
02/01/07 09:59:08 AddESE_DLEs for sever name SBS01
02/01/07 09:59:08 AddESE_DLEs: annotation != NULL
02/01/07 09:59:08 HrESEBackupPrepare: Microsoft Information Store, SBS01 = 0x00000000
02/01/07 09:59:08 ESE_CheckForRSG( )
02/01/07 09:59:08 HrESEBackupFreeInstance:
02/01/07 09:59:08 HrESEBackupEnd: Microsoft Information Store = 0x00000000
02/01/07 09:59:08 HrESEFreeRegistered:
02/01/07 09:59:08 ndmpConnect : Control Connection information: A connection was established between end-points 127.0.0.1:28370 and 127.0.0.1:10000.
02/01/07 09:59:08 ndmpRun: Control connection accepted : connection established between end-points 127.0.0.1:10000 and 127.0.0.1:28370
02/01/07 09:59:08 NDMP version 3 connection CONNECTED
02/01/07 09:59:09 BELogonUser: beclass::IsThisMe() returned error: 87
02/01/07 09:59:09 LogonType set =
02/01/07 09:59:09 LogonUser(LOGON32_LOGON_INTERACTIVE-0x2) success
02/01/07 09:59:09 Successfully impersonated mydomainname\svc.BACKUP
02/01/07 09:59:09 WhoAmI( ) reports: mydomainname\svc.BACKUP
02/01/07 09:59:09 NDMPEngine::SetupNDMPConnection(): Using proxy authentication as requested
02/01/07 09:59:09 @@@@@@@MyCloseSocket called with sockfd = 936(0x3a8)retval = 0
02/01/07 09:59:09 @@@@@@@MyCloseSocket called with sockfd = -1(0xffffffff)retval = -1
02/01/07 09:59:09 ENTER DPM::FindDrives
02/01/07 09:59:09 ENTER DPM::IsServicePresent
02/01/07 09:59:09 @@@@@@@MyCloseSocket called with sockfd = 1232(0x4d0)retval = 0
02/01/07 09:59:09 DPM: Failed OpenService
02/01/07 09:59:09 @@@@@@@MyCloseSocket called with sockfd = -1(0xffffffff)retval = -1
02/01/07 09:59:09 DPM: Service is present:
02/01/07 09:59:09 EXIT DPM::IsServicePresent
02/01/07 09:59:09 DPM: DPM Service not present
02/01/07 09:59:09 EXIT DPM::FindDrives return=
02/01/07 09:59:15 DS_CloseSelectionService
02/01/07 09:59:15 DsWorkerThread terminating with exit code 0
02/01/07 09:59:24 ndmpRun: Control connection accepted : connection established between end-points 127.0.0.1:10000 and 127.0.0.1:28384
02/01/07 09:59:25 BELogonUser: beclass::IsThisMe() returned error: 87
02/01/07 09:59:25 LogonType set =
02/01/07 09:59:25 LogonUser(LOGON32_LOGON_INTERACTIVE-0x2) success
02/01/07 09:59:25 Successfully impersonated mydomainname\svc.BACKUP
02/01/07 09:59:25 WhoAmI( ) reports: mydomainname\svc.BACKUP
02/01/07 09:59:27 ndmpdExecuteCommand: cmd=D:\Scripts\Stop.cmd, status=0, exitcode=0
02/01/07 09:59:27 @@@@@@@MyCloseSocket called with sockfd = 856(0x358)retval = 0
02/01/07 09:59:27 @@@@@@@MyCloseSocket called with sockfd = -1(0xffffffff)retval = -1
02/01/07 09:59:28 ndmpRun: Control connection accepted : connection established between end-points 127.0.0.1:10000 and 127.0.0.1:28385
02/01/07 09:59:28 BELogonUser: beclass::IsThisMe() returned error: 87
02/01/07 09:59:28 LogonType set =
02/01/07 09:59:28 LogonUser(LOGON32_LOGON_INTERACTIVE-0x2) success
02/01/07 09:59:28 Successfully impersonated mydomainname\svc.BACKUP
02/01/07 09:59:28 WhoAmI( ) reports: mydomainname\svc.BACKUP
02/01/07 09:59:28 GetServerType for local machine
02/01/07 09:59:28 GetServerType for local machine
02/01/07 09:59:28 GetServerType for local machine
02/01/07 09:59:28 Finding MNET entries using PunchDownWithWNetCalls()
02/01/07 09:59:28 No Oracle SID's were discovered
02/01/07 09:59:28 GetServerType for local machine
02/01/07 09:59:28 Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
02/01/07 09:59:28 No utility partitions found on any of the disks
02/01/07 09:59:28 NRDS_RA_FindDrives entered
02/01/07 09:59:28 NRDS_RA_FindDrives completed immediately because we aren't browsing
02/01/07 09:59:28 Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:687
02/01/07 09:59:28 Informational: Cps library not available. Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:691
02/01/07 09:59:28 Function called: DB2_FindDrives
02/01/07 09:59:28 Status 0xE0008488 returned calling FindDrives for file system 28 in DLE_UpdateList
02/01/07 09:59:28 AD:DeviceName "System?State" in SystemState::CreateDLEs:314
02/01/07 09:59:28 AD:Full Device Path "System?State" in SystemState::CreateDLEs:319
02/01/07 09:59:28 AD:ADRO Agent is authorized for System?State.
02/01/07 09:59:28 AD:Found 0 instances of Active Directory Applcation Mode in SystemState::GetADAMInstanceCount:1246
02/01/07 09:59:28 ADC_FindAgents entered
02/01/07 09:59:28 ADC_FindAgents completed immediately because we aren't browsing
02/01/07 09:59:28 SQL2_FindDrives - the default SQL Service is not running on SBS01.
02/01/07 09:59:28 SQL2_FindDrives - checking named instance SBSMONITORING.
02/01/07 09:59:28 IsServiceClusterOk called on SBS01
02/01/07 09:59:28 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:28 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:28 SQL2_CreateDLE - creating SBS01\SBSMONITORING.
02/01/07 09:59:28 SQL Version 2000
02/01/07 09:59:28 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:28 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:28 SQL2_FindDrives - checking named instance SHAREPOINT.
02/01/07 09:59:28 IsServiceClusterOk called on SBS01
02/01/07 09:59:28 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:28 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:28 SQL2_CreateDLE - creating SBS01\SHAREPOINT.
02/01/07 09:59:28 SQL Version 2000
02/01/07 09:59:28 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:28 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:28 SQL2_FindDrives - checking named instance BKUPEXEC.
02/01/07 09:59:28 IsServiceClusterOk called on SBS01
02/01/07 09:59:28 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:28 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:28 SQL2_CreateDLE - creating SBS01\BKUPEXEC.
02/01/07 09:59:28 SQL Version 2005
02/01/07 09:59:28 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:28 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:28 Setting 2K5 extended feature bit.
02/01/07 09:59:28 AddESE_DLEs( )
02/01/07 09:59:28 AddESE_DLEs for sever name SBS01
02/01/07 09:59:28 HrESEBackupRestoreGetRegistered: SBS01, NULL = 0x00000000
02/01/07 09:59:28 AreYouSureThisIsAnExchangeServer: SBS01
02/01/07 09:59:28 HrESEBackupRestoreNodes: SBS01 = 0x00000000
02/01/07 09:59:28 Recursing
02/01/07 09:59:28 AreYouSureThisIsAnExchangeServer: SBS01
02/01/07 09:59:28 SBS01 is an Exchange server
02/01/07 09:59:28 AreYouSureThisIsAnExchangeServer SBS01: 1
02/01/07 09:59:28 HrESEBackupFreeNodes:
02/01/07 09:59:28 AreYouSureThisIsAnExchangeServer SBS01: 1
02/01/07 09:59:28 HrESEBackupPrepare: Microsoft Information Store, SBS01 = 0x00000000
02/01/07 09:59:28 HrESEBackupFreeInstance:
02/01/07 09:59:28 HrESEBackupEnd: Microsoft Information Store = 0x00000000
02/01/07 09:59:28 AddESE_DLEs( )
02/01/07 09:59:28 AddESE_DLEs for sever name SBS01
02/01/07 09:59:28 AddESE_DLEs: annotation != NULL
02/01/07 09:59:28 HrESEBackupPrepare: Microsoft Information Store, SBS01 = 0x00000000
02/01/07 09:59:28 ESE_CheckForRSG( )
02/01/07 09:59:28 HrESEBackupFreeInstance:
02/01/07 09:59:28 HrESEBackupEnd: Microsoft Information Store = 0x00000000
02/01/07 09:59:28 HrESEFreeRegistered:
02/01/07 09:59:28 ndmpConnect : Control Connection information: A connection was established between end-points 127.0.0.1:28388 and 127.0.0.1:10000.
02/01/07 09:59:28 ndmpRun: Control connection accepted : connection established between end-points 127.0.0.1:10000 and 127.0.0.1:28388
02/01/07 09:59:28 NDMP version 3 connection CONNECTED
02/01/07 09:59:29 BELogonUser: beclass::IsThisMe() returned error: 87
02/01/07 09:59:29 LogonType set =
02/01/07 09:59:29 LogonUser(LOGON32_LOGON_INTERACTIVE-0x2) success
02/01/07 09:59:29 Successfully impersonated mydomainname\svc.BACKUP
02/01/07 09:59:29 WhoAmI( ) reports: mydomainname\svc.BACKUP
02/01/07 09:59:29 NDMPEngine::SetupNDMPConnection(): Using proxy authentication as requested
02/01/07 09:59:29 @@@@@@@MyCloseSocket called with sockfd = 1160(0x488)retval = 0
02/01/07 09:59:29 @@@@@@@MyCloseSocket called with sockfd = 1196(0x4ac)retval = 0
02/01/07 09:59:29 @@@@@@@MyCloseSocket called with sockfd = -1(0xffffffff)retval = -1
02/01/07 09:59:29 @@@@@@@MyCloseSocket called with sockfd = -1(0xffffffff)retval = -1
02/01/07 09:59:29 ENTER DPM::FindDrives
02/01/07 09:59:29 ENTER DPM::IsServicePresent
02/01/07 09:59:29 DPM: Failed OpenService
02/01/07 09:59:29 DPM: Service is present:
02/01/07 09:59:29 EXIT DPM::IsServicePresent
02/01/07 09:59:29 DPM: DPM Service not present
02/01/07 09:59:29 EXIT DPM::FindDrives return=
02/01/07 09:59:29 FS_BlowOutMachine: entered -->D:<--
02/01/07 09:59:29 FS_BlowOutMachine: no machine name possible
02/01/07 09:59:29 ndmpdSnapshotPrepare2: Calling DLE_FindByName for device: D:
02/01/07 09:59:29 dir = OfficeShare
02/01/07 09:59:29 file = *.*
02/01/07 09:59:29 oper = Include
02/01/07 09:59:29 subs = True
02/01/07 09:59:29 wild = True
02/01/07 09:59:29 dir = Scripts
02/01/07 09:59:29 file = *.*
02/01/07 09:59:29 oper = Include
02/01/07 09:59:29 subs = True
02/01/07 09:59:29 wild = True
02/01/07 09:59:29 dir = Share
02/01/07 09:59:29 file = *.*
02/01/07 09:59:29 oper = Include
02/01/07 09:59:29 subs = True
02/01/07 09:59:29 wild = True
02/01/07 09:59:29 Attempting VSP Provider
02/01/07 09:59:29 Snapshot factory, using VSP as the snapshot provider.
02/01/07 09:59:29 Initialized VSP Snapshot Provider
02/01/07 09:59:29 Entering SetupLocalShareInfo
02/01/07 09:59:29 Informational: Not enumerating DFS
02/01/07 09:59:29 Attach to D:
02/01/07 09:59:29 SnapshotBackupEngine::scan_file_system() : Volume List size (before prune): 1
02/01/07 09:59:29 SnapshotBackupEngine::scan_file_system(): Volume List size (after prune): 1
02/01/07 09:59:29 Adding volume: D:
02/01/07 09:59:29 VspSnapshotVolume::AddVolumeToSnapSet( D: )
02/01/07 09:59:29 SnapshotBackupEngine::snap_file_systems. Start...
02/01/07 09:59:29 VspSnapshotVolume::PrepareToSnapVolumeSet( ), calling broker
02/01/07 09:59:29 CacheFile Broker - List of volumes on system:
02/01/07 09:59:29 Drive VolGUID DriveType FileSys
02/01/07 09:59:29 --------------------------------------------------------------------------------
02/01/07 09:59:29 C:\ \\?\Volume{800e5247-c169-11da-8298-806e6f6e6963}\ Fixed NTFS
02/01/07 09:59:29 D:\ \\?\Volume{800e5249-c169-11da-8298-806e6f6e6963}\ Fixed NTFS
02/01/07 09:59:29 \\?\Volume{8bae48c4-c16a-11da-bcf8-806e6f6e6963}\ CD-ROM
02/01/07 09:59:29 E:\ \\?\Volume{1e1c5e3a-ae2c-11db-aad6-005056c00008}\ Fixed NTFS
02/01/07 09:59:29 ------- End of list --------
02/01/07 09:59:29 CacheFile Broker - Checking if user-specified volume is a valid cache file target: \\?\Volume{1e1c5e3a-ae2c-11db-aad6-005056c00008}\ Target Path: E:\Backup Exec AOFO Store Num vols: 1
02/01/07 09:59:29 CacheFile Broker - Valid cache file target: E:\Backup Exec AOFO Store
02/01/07 09:59:29 CacheFile Broker:
02/01/07 09:59:29 Num vols to snap: 1
02/01/07 09:59:29 Num Preferred vols: 1
02/01/07 09:59:29 Num Target vol: 1
02/01/07 09:59:29 Default Target Path: Backup Exec AOFO Store
02/01/07 09:59:29 User-defined target paths:
02/01/07 09:59:29 E:\Backup Exec AOFO Store
02/01/07 09:59:29 Volumes to snap:
02/01/07 09:59:29 \\?\Volume{800e5249-c169-11da-8298-806e6f6e6963}\
02/01/07 09:59:29 Target volumes available for cache file:
02/01/07 09:59:29 \\?\Volume{1e1c5e3a-ae2c-11db-aad6-005056c00008}\
02/01/07 09:59:29 Preferred volumes for cache file:
02/01/07 09:59:29 \\?\Volume{1e1c5e3a-ae2c-11db-aad6-005056c00008}\
02/01/07 09:59:29 CacheFile Broker. Cache file is located on volume other than source volume.
02/01/07 09:59:29 CacheFile Broker - Size Parameters:
02/01/07 09:59:29 sourceVol : \\?\Volume{800e5249-c169-11da-8298-806e6f6e6963}\
02/01/07 09:59:29 cacheVol : \\?\Volume{1e1c5e3a-ae2c-11db-aad6-005056c00008}\
02/01/07 09:59:29 free space : 429597
02/01/07 09:59:29 used space : 17524
02/01/07 09:59:29 min (percent): 0
02/01/07 09:59:29 max (percent): 30
02/01/07 09:59:29 min (MB) : 0
02/01/07 09:59:29 max (MB) : 128879
02/01/07 09:59:29 CacheFile Broker - Cache File Name is (\\?\Volume{1e1c5e3a-ae2c-11db-aad6-005056c00008}\Backup Exec AOFO Store\_BEVspCacheFile_0.VSP)
02/01/07 09:59:29 VspSnapshotvolume::PrepareToSnapVolumeSet() - cache files are
02/01/07 09:59:29 \\?\Volume{1e1c5e3a-ae2c-11db-aad6-005056c00008}\Backup Exec AOFO Store\_BEVspCacheFile_0.VSP
02/01/07 09:59:29 Dumping snap params:
02/01/07 09:59:29 SourceVolumeObject = 000004A4
02/01/07 09:59:29 SnapshotVolumeName = Volume{61dd5e95-5e45-4377-a477-ce06dc6b1d40}
02/01/07 09:59:29 CacheFileName = \\?\Volume{1e1c5e3a-ae2c-11db-aad6-005056c00008}\Backup Exec AOFO Store\_BEVspCacheFile_0.VSP
02/01/07 09:59:29 InitialCacheFileSize = 0
02/01/07 09:59:29 MaximumCacheFileSize = 128879
02/01/07 09:59:29 Reserved = 0
02/01/07 09:59:29 List of SourceVolumeNames, SourceRawVolumeNames, SnapVolumeNames, CacheFileNames:
02/01/07 09:59:29
02/01/07 09:59:29 calling vsp::Prepare for all volumes
02/01/07 09:59:29 VspSnapshotVolume::PrepareToSnapVolumeSet() - error during Prepare.
02/01/07 09:59:29 VSP SnapshotError (87). Reason: The parameter is incorrect.
02/01/07 09:59:29 Error SnapshotBackupEngine::snap_file_systems failed.
02/01/07 09:59:29 ndmpdSnapshotPrepare2: Snapshot error. ErrorCode: 0xe000851c ErrorLevel: 2 Error Src: 2
02/01/07 09:59:29 ndmpdSnapshotPrepare2: sending reply...
02/01/07 09:59:29 Detach from D:
02/01/07 09:59:29 ndmpdSnapshotPrepare2: cleanup: all done
02/01/07 09:59:29 ENV: USERNAME=
02/01/07 09:59:29 ENV: NOPASSWORD=
02/01/07 09:59:29 ENV: USERNAME=mydomainname\svc.BACKUP
02/01/07 09:59:29 ENV: PASSWORD=
02/01/07 09:59:29 ENV: INITIATOR_SID=0@D0000000DE0000lOCm>=nNcSQOMTY1U`@000
02/01/07 09:59:29 ENV: PRESCANDLE=0
02/01/07 09:59:29 ENV: OPER_TYPE=1
02/01/07 09:59:29 ENV: BLOCKSIZE=400
02/01/07 09:59:29 ENV: SSETRESERVED=400
02/01/07 09:59:29 ENV: BU_SQL_PRE_BKUP_DBCC_TYPE=0
02/01/07 09:59:29 ENV: BU_SQL_POST_BKUP_DBCC_TYPE=0
02/01/07 09:59:29 ENV: REST_SQL_POST_REST_DBCC_TYPE=0
02/01/07 09:59:29 ENV: LAST_SET=0
02/01/07 09:59:29 ENV: BU_REGISTRY=0
02/01/07 09:59:29 ENV: BU_INUSE=1
02/01/07 09:59:29 ENV: BU_MIGRATED=0
02/01/07 09:59:29 ENV: BU_EXPANDED=0
02/01/07 09:59:29 ENV: PROCESS_EMPTY=0
02/01/07 09:59:29 ENV: SWCOMPMODE=0
02/01/07 09:59:29 ENV: SWCOMPLEVEL=0
02/01/07 09:59:29 ENV: SWCOMPTHRESH=10
02/01/07 09:59:29 ENV: BACKUPTYPE=1
02/01/07 09:59:29 ENV: BU_SPS_METHOD=1
02/01/07 09:59:29 ENV: BU_SQL_METHOD=0
02/01/07 09:59:29 ENV: BU_SQL_HOTCOPY=0
02/01/07 09:59:29 ENV: BU_SQL_HOTCOPY_PATH=C:\TEMP
02/01/07 09:59:29 ENV: BU_SQL_NO_RECOVER=0
02/01/07 09:59:29 ENV: BU_SQL_STANDBY=0
02/01/07 09:59:29 ENV: BU_SQL_CHECKSUMS=0
02/01/07 09:59:29 ENV: BU_SQL_NUMSNAPS_TO_KEEP=4
02/01/07 09:59:29 ENV: BU_SQL_ALWAYS_SNAP=0
02/01/07 09:59:29 ENV: BU_XCH_METHOD=1
02/01/07 09:59:29 ENV: BU_MBOX_METHOD=1
02/01/07 09:59:29 ENV: BU_MBOX_SIS=0
02/01/07 09:59:29 ENV: BU_NTFS_SIS=0
02/01/07 09:59:29 ENV: AA_PRIORITY=0
02/01/07 09:59:29 ENV: BU_RSM=0
02/01/07 09:59:29 ENV: BU_EXCLUDE_ACTIVE_FILES=1
02/01/07 09:59:29 ENV: TRAVERSE_LOCAL_MP=1
02/01/07 09:59:29 ENV: TRAVERSE_REMOTE_MP=0
02/01/07 09:59:29 ENV: DO_SNAPSHOT=1
02/01/07 09:59:29 ENV: SQL_FORCE_NP=0
02/01/07 09:59:29 ENV: SQL_OVERRIDE_FGDEPS=0
02/01/07 09:59:29 ENV: SQL_ALERT_FGDEP_OVERRIDE=1
02/01/07 09:59:29 ENV: BU_SFC_WITH_SS=1
02/01/07 09:59:29 ENV: BU_REMOTE_STORAGE_HSM=0
02/01/07 09:59:29 ENV: SKIP_OPEN_FILES=0
02/01/07 09:59:29 ENV: WAIT_SKIP=0
02/01/07 09:59:29 ENV: HIDDEN=1
02/01/07 09:59:29 ENV: PROC_SYSTEM_FILES=1
02/01/07 09:59:29 ENV: BU_LDM_STATE=0
02/01/07 09:59:29 ENV: BU_DISK_QUOTA=0
02/01/07 09:59:29 ENV: BU_IN_DOC_FMT=0
02/01/07 09:59:29 ENV: REST_REGISTRY=0
02/01/07 09:59:29 ENV: REST_HW_REGISTRY=0
02/01/07 09:59:29 ENV: IGNORE_TREE_RESTORE=0
02/01/07 09:59:29 ENV: REST_SECURITY=1
02/01/07 09:59:29 ENV: VOL_RESTRICTIONS=0
02/01/07 09:59:29 ENV: REST_XCH_PUBLIC=1
02/01/07 09:59:29 ENV: REST_MBOX_USER_FLAG=0
02/01/07 09:59:29 ENV: REST_MBOX_REDIR_TYPE=0
02/01/07 09:59:29 ENV: REST_MBOX_USER_PASSWORD=
02/01/07 09:59:29 ENV: MEDIA_SERVER=SBS01
02/01/07 09:59:29 ENV: SPS_SERVER_LIST=Server Farm 1 (SBS01)\
02/01/07 09:59:29 ENV: SPS_COMMIT_RESTORE=0
02/01/07 09:59:29 ENV: SPS_REST_OVER_EXISTING=0
02/01/07 09:59:29 ENV: BU_SPS_PRE_BKUP_DBCC_TYPE=0
02/01/07 09:59:29 ENV: BU_SPS_POST_BKUP_DBCC_TYPE=0
02/01/07 09:59:29 ENV: REST_SPS_POST_REST_DBCC_TYPE=2
02/01/07 09:59:29 ENV: CONTINUE_ON_SPS_DBCC_ERROR=0
02/01/07 09:59:29 ENV: JOBNAME=D-Data - Daily Full
02/01/07 09:59:29 ENV: REST_XCH_PRIVATE=1
02/01/07 09:59:29 ENV: REST_REMOTE_HSM=0
02/01/07 09:59:29 ENV: REST_RSM=0
02/01/07 09:59:29 ENV: REST_DISK_QUOTA=0
02/01/07 09:59:29 ENV: REST_JUNC_AS_DIR=0
02/01/07 09:59:29 ENV: REST_PRIM_REPLICA=0
02/01/07 09:59:29 ENV: REST_TERMINAL_SERVICES=0
02/01/07 09:59:29 ENV: REST_WMI=0
02/01/07 09:59:29 ENV: REST_CLUSTER_QUORUM_DB=0
02/01/07 09:59:29 ENV: REST_FORCE_RECOVERY=0
02/01/07 09:59:29 ENV: REST_EXISTING=3
02/01/07 09:59:29 ENV: REST_XCH_NO_LOSS=1
02/01/07 09:59:29 ENV: REST_ESE_MOUNT=0
02/01/07 09:59:29 ENV: REST_ESE_DISMOUNT=0
02/01/07 09:59:29 ENV: REST_ESE_LOG_PATH=C:\TEMP\
02/01/07 09:59:29 ENV: REST_ESE_LAST_SET=0
02/01/07 09:59:29 ENV: REST_ESE_NO_LOSS=1
02/01/07 09:59:29 ENV: REST_ESE_CONSISTENCY_CHECK=1
02/01/07 09:59:29 ENV: REST_ESE_CONTINUE_CONSISTENCY_CHECK=1
02/01/07 09:59:29 ENV: REST_SQL_DATABASE_OVERWRITE=0
02/01/07 09:59:29 ENV: REST_SQL_KEEP_REPLICATION=0
02/01/07 09:59:29 ENV: REST_SQL_VERIFY_ONLY=0
02/01/07 09:59:29 ENV: REST_SQL_RESTORE_TO=0
02/01/07 09:59:29 ENV: REST_SQL_RESTORE_TO_PATH=
02/01/07 09:59:29 ENV: REST_SQL_CONTINUE_ON_ERROR=0
02/01/07 09:59:29 ENV: REST_SQL_POINT_IN_TIME=0
02/01/07 09:59:29 ENV: REST_SQL_POINT_IN_TIME_DATE=0
02/01/07 09:59:29 ENV: REST_SQL_POINT_IN_TIME_TIME=0
02/01/07 09:59:29 ENV: BU_SQL_PRE_BKUP_DBCC=3
02/01/07 09:59:29 ENV: BU_SQL_POST_BKUP_DBCC=0
02/01/07 09:59:29 ENV: REST_SQL_POST_REST_DBCC=2
02/01/07 09:59:29 ENV: CONTINUE_ON_DBCC_ERROR=1
02/01/07 09:59:29 ENV: REST_SQL_AUTO_MASTER=0
02/01/07 09:59:29 ENV: REST_SQL_DATABASE_STANDBY=0
02/01/07 09:59:29 ENV: REST_SQL_DATABASE_FORCERESTORE=0
02/01/07 09:59:29 ENV: REST_SQL_DATABASE_RECOVER=1
02/01/07 09:59:29 ENV: REST_SQL_LOG_MARK_RESTORE=0
02/01/07 09:59:29 ENV: REST_SQL_LOG_MARK_NAME=
02/01/07 09:59:29 ENV: REST_SQL_LOG_MARK_STOP_BEFORE=0
02/01/07 09:59:29 ENV: REST_SQL_LOG_MARK_AFTER_TIME=0
02/01/07 09:59:29 ENV: REST_SQL_LOG_MARK_DATE=0
02/01/07 09:59:29 ENV: REST_SQL_LOG_MARK_TIME=0
02/01/07 09:59:29 ENV: REST_SQL_DEF_INSTANCE_DIR=0
02/01/07 09:59:29 ENV: REST_SQL_USE_DEFAULT_DRIVE=0
02/01/07 09:59:29 ENV: REST_SQL_ALL_TO_DEFAULT_DRIVE=0
02/01/07 09:59:29 ENV: REST_SQL_DEFAULT_DRIVE=0
02/01/07 09:59:29 ENV: ARCHIVE_PRESERVE_TREE=0
02/01/07 09:59:29 ENV: UTILITY_PARTITION_OEMIDS=
02/01/07 09:59:29 ENV: APPLY_CPR_TO_BACKUPSET=0
02/01/07 09:59:29 ENV: IMAGE_METHOD=0
02/01/07 09:59:29 ENV: GUARANTEED_FROZEN_IMAGE=0
02/01/07 09:59:29 ENV: FULL_IMAGE_METHOD=0
02/01/07 09:59:29 ENV: TESTRUN_JOB_OPTIONS=0
02/01/07 09:59:29 ENV: USE_CHANGE_JOURNAL=0
02/01/07 09:59:29 ENV: DOMINO_BACKUP_METHOD=1
02/01/07 09:59:29 ENV: DOMINO_BACKUP_RECYCLE_LOGFILE=0
02/01/07 09:59:29 ENV: DOMINO_SCRATCH_DB2_DB_NAME=
02/01/07 09:59:29 ENV: DB2_HIDE_CATALOG_ENTRY=0
02/01/07 09:59:29 ENV: DOMINO_LAST_BACKUP_DATE=0
02/01/07 09:59:29 ENV: DOMINO_LAST_BACKUP_TIME=0
02/01/07 09:59:29 ENV: DOMINO_MAX_TRANLOG_EXTENTS=46
02/01/07 09:59:29 ENV: DOMINO_RESTORE_DBRECOVEROPTION=0
02/01/07 09:59:29 ENV: DOMINO_RESTORE_WAITINUSE=0
02/01/07 09:59:29 ENV: DOMINO_RESTORE_MSECSFORWAIT=1e
02/01/07 09:59:29 ENV: DOMINO_RESTORE_POINTINTIMERESTORE=0
02/01/07 09:59:29 ENV: DOMINO_RESTORE_PITTIME_DATE=0
02/01/07 09:59:29 ENV: DOMINO_RESTORE_PITTIME_TIME=0
02/01/07 09:59:29 ENV: SAP_JOB_FLAG=0
02/01/07 09:59:29 ENV: IMAGE_DBLK_TYPE=0
02/01/07 09:59:29 ENV: PROC_CHECKSUM_STRM=1
02/01/07 09:59:29 ENV: DOMINO_OFFLINE_BACKUP=0
02/01/07 09:59:29 ENV: ENABLE_IDR_INFO_GATHERING=1
02/01/07 09:59:29 ENV: IMAGE_OPTION_AUTHORIZED=0
02/01/07 09:59:29 ENV: DPM_OPTION_AUTHORIZED=1
02/01/07 09:59:29 ENV: SPS_OPTION_AUTHORIZED=1
02/01/07 09:59:29 ENV: DO_OFF_HOST_BACKUP=0
02/01/07 09:59:29 ENV: OFF_HOST_BACKUP_OPER_TYPE=0
02/01/07 09:59:29 ENV: OFF_HOST_METADATA_COLL_NAME=
02/01/07 09:59:29 ENV: PRESERVE_CTIME=0
02/01/07 09:59:29 ENV: FOLLOW_SYMDIRS=0
02/01/07 09:59:29 ENV: INCLUDE_REMOTE=0
02/01/07 09:59:29 ENV: NO_NFS_LOCKING=0
02/01/07 09:59:29 ENV: FOLLOW_MOUNTPOINTS=1
02/01/07 09:59:29 ENV: TRUE_IMAGE_BACKUP=0
02/01/07 09:59:29 ENV: NDMP_PROP_PORT_RANGE_ENABLED=0
02/01/07 09:59:29 ENV: NDMP_PORT_RANGE=
02/01/07 09:59:29 ENV: REVERSE_CONNECTION=1
02/01/07 09:59:29 ENV: ENABLE_GRANULAR_RESTORE=0
02/01/07 09:59:29 ENV: PDI_OPERATION_TYPE=0
02/01/07 09:59:29 ENV: PDI_DATA_TRANSFER_PHASE=0
02/01/07 09:59:29 ENV: PDI_GENERAL_ATTRIBUTES=0
02/01/07 09:59:29 ENV: PDI_IPC_OBJECT=
02/01/07 09:59:29 ENV: PDI_LOCATION=E:\SBS01\D-Data
02/01/07 09:59:29 ENV: PDI_TEMP_LOCATION=
02/01/07 09:59:29 ENV: POLICY_GUID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: JOB_FAMILY_GUID={4682CFDB-2FBE-4CEB-9FB3-20FE6E0951B0}
02/01/07 09:59:29 ENV: JOB_HISTORY_GUID={F15C3DA0-0154-4E9C-8ABE-CA07A7E6A466}
02/01/07 09:59:29 ENV: JOB_INSTANCE_GUID={FCE69A83-B68D-4622-AF1D-40E69C33A415}
02/01/07 09:59:29 ENV: JOB_EXECUTION_GUID={F15C3DA0-0154-4E9C-8ABE-CA07A7E6A466}
02/01/07 09:59:29 ENV: MEDIA_SET_GUID={A66058B3-0082-43D8-95CF-BF949EAF0BEB}
02/01/07 09:59:29 ENV: DEVICE_GUID={043BBCBB-4459-4814-A605-8635C987005E}
02/01/07 09:59:29 ENV: MEDIA_SET_RETENSION_HOURS=18
02/01/07 09:59:29 ENV: MEDIA_TYPE=f
02/01/07 09:59:29 ENV: PDI_ANCESTRY_LOCATIONS=
02/01/07 09:59:29 ENV: IMAGE_LINK_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: RECREATE_AD_OBJECTS=0
02/01/07 09:59:29 ENV: PDI_SET_COUNT=0
02/01/07 09:59:29 ENV: PDI_MAX_SET_COUNT=0
02/01/07 09:59:29 ENV: CPS_JOB_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: CPS_JOB_INCR=0
02/01/07 09:59:29 ENV: REST_ESE_POINT_IN_TIME_LOWWORD=0
02/01/07 09:59:29 ENV: REST_ESE_POINT_IN_TIME_HIGHWORD=0
02/01/07 09:59:29 ENV: B2D_RESERVED_DISKSPACE_MB=0
02/01/07 09:59:29 ENV: SNAPSHOT_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: OFF_HOST_SNAPSHOT_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: DEVICENAME="D:"
02/01/07 09:59:29 ENV: DEVICE_OS_ID=e
02/01/07 09:59:29 ENV: DEVICE_OS_VER=3
02/01/07 09:59:29 ENV: DEVICE_MAINTYPE=1
02/01/07 09:59:29 ENV: DEVICE_SUBTYPE=4
02/01/07 09:59:29 ENV: FILESYSTEM="D:\OfficeShare\*.*",s,v0,t0,l0,n0,f0
02/01/07 09:59:29 ENV: FILESYSTEM="D:\Scripts\*.*",s,v0,t0,l0,n0,f0
02/01/07 09:59:29 ENV: FILESYSTEM="D:\Share\*.*",s,v0,t0,l0,n0,f0
02/01/07 09:59:29 ENV: DEVICE_REDIRECT=0
02/01/07 09:59:29 ENV: DEVICE_REDIRECT_FILE_SYSTEM=0
02/01/07 09:59:29 ENV: NBBSA_TOTAL_STREAMS=0
02/01/07 09:59:29 ENV: BSA_SERVICE_HOST=SBS01
02/01/07 09:59:29 ENV: ORACLE_BACKUP_TYPE=2
02/01/07 09:59:29 ENV: ORACLE_SHUTDOWN=0
02/01/07 09:59:29 ENV: ORACLE_BK_AUTO_ARCHDELETE=0
02/01/07 09:59:29 ENV: ORACLE_BK_ARCHLOGS_INCR=1
02/01/07 09:59:29 ENV: ORACLE_RE_RESTORE=0
02/01/07 09:59:29 ENV: ORACLE_RE_RESTOREOPTS_DATETIME=0
02/01/07 09:59:29 ENV: ORACLE_RE_RESTOREOPTS_SCN=0
02/01/07 09:59:29 ENV: ORACLE_RE_RESTOREOPTS_OMIT_READONLY=0
02/01/07 09:59:29 ENV: ORACLE_RE_RECOVER=0
02/01/07 09:59:29 ENV: ORACLE_RE_RECOVEROPTS_DATETIME=0
02/01/07 09:59:29 ENV: ORACLE_RE_RECOVEROPTS_SCN=0
02/01/07 09:59:29 ENV: ORACLE_RE_RECOVEROPTS_DELETE_ALOGS=0
02/01/07 09:59:29 ENV: ORACLE_STARTUP=0
02/01/07 09:59:29 ENV: ORACLE_RE_RESTORE_CONTROL_FILE_ONLY=0
02/01/07 09:59:29 ENV: ORACLE_RE_RESTORE_VALIDATE=0
02/01/07 09:59:29 ENV: ORACLE_RE_RECOVER_IF_VALID=0
02/01/07 09:59:29 ENV: DB2_BACKUP_TYPE=1
02/01/07 09:59:29 ENV: DB2_SHUTDOWN=0
02/01/07 09:59:29 ENV: DB2_RE_RESTORE=0
02/01/07 09:59:29 ENV: DB2_RE_RESTOREOPTS_DATETIME=0
02/01/07 09:59:29 ENV: DB2_RE_RECOVER=0
02/01/07 09:59:29 ENV: DB2_RE_ROLLFWDOPTS_DATETIME=0
02/01/07 09:59:29 ENV: DB2_RE_REDIRECTED_RESTORE=0
02/01/07 09:59:29 ENV: DB2_RE_REDIRECTED_INSTANCE=0
02/01/07 09:59:29 ENV: DB2_RE_PUT_DB_ONLINE=0
02/01/07 09:59:29 ENV: DB2_RE_REDIRECT_DATABASE=0
02/01/07 09:59:29 ENV: DB2_RE_REDIRECT_CONTAINER=0
02/01/07 09:59:29 ENV: DB2_RE_OVERRIDE_RECO_LOG_PATH=0
02/01/07 09:59:29 ENV: DB2_QUIESCE_DB=1
02/01/07 09:59:29 ENV: DSBK_BACKUP_METHOD=0
02/01/07 09:59:29 ENV: DSBK_BACKUP_STREAM_FILES=0
02/01/07 09:59:29 ENV: DSBK_BACKUP_USER_INCLUDE_FILES=
02/01/07 09:59:29 ENV: DSBK_RESTORE_RESTORE_DIBSET=0
02/01/07 09:59:29 ENV: DSBK_RESTORE_ACTIVATE_DIB_AFTER_VERIFY=0
02/01/07 09:59:29 ENV: DSBK_RESTORE_OPEN_DATABASE_WHEN_FINISHED=0
02/01/07 09:59:29 ENV: DSBK_RESTORE_DONOT_VERIFY_DIB_AFTER_RESTORE=0
02/01/07 09:59:29 ENV: DSBK_RESTORE_RESTORE_USER_INCLUDED_FILES=0
02/01/07 09:59:29 ENV: DSBK_RESTORE_ROLL_FORWARD_LOG_DIRECTORY_PATH=
02/01/07 09:59:29 ENV: DSBK_WORKING_DIRECTORY_PATH=
02/01/07 09:59:29 ENV: DSBK_LEAVE_BACKUP_FILE_ON_DISK=0
02/01/07 09:59:29 ENV: NO_DATA_CONNECTION=0
02/01/07 09:59:29 ENV: PDI_VCB_PASSWORD_ENCRYPT_ALG=0
02/01/07 09:59:29 ENV: PDI_VCB_DATA_COMP_ALG=0
02/01/07 09:59:29 ENV: PDI_VCB_SOFTWARE_MAJOR_VER=0
02/01/07 09:59:29 ENV: PDI_VCB_SOFTWARE_MINOR_VER=0
02/01/07 09:59:29 ENV: PDI_VCB_TIME_ZONE=0
02/01/07 09:59:29 ENV: PDI_VCB_IMAGEID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_IMAGECONTENTID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_GEN0SOURCEIMAGEID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_CATALOGSOURCEID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_GENERATIONNUMBER=0
02/01/07 09:59:29 ENV: PDI_VCB_DERIVEDSOURCEIMAGEID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_POLICY_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_JOB_FAMILY_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_JOB_HISTORY_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_JOB_INSTANCE_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_JOB_EXECUTION_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_MEDIA_SET_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_DEVICE_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_MEDIA_SET_RETENSION_HRS=0
02/01/07 09:59:29 ENV: PDI_VCB_MEDIA_TYPE=0
02/01/07 09:59:29 ENV: PDI_VCB_PREVIOUSIMAGECONTENTID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_SELECTION_LIST_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_SET_SEQUENCE_NUM=0
02/01/07 09:59:29 ENV: PDI_VCB_IMAGE_LINK_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_MEDIA_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_ATTRIB=0
02/01/07 09:59:29 ENV: PDI_VCB_ATTRIB2=0
02/01/07 09:59:29 ENV: PDI_VCB_COMPRESSED_OBJ=0
02/01/07 09:59:29 ENV: BSD_DEVICE_ATTRIBUTES=0
02/01/07 09:59:29 ENV: MEDIA_LABEL_KEY=0
02/01/07 09:59:29 ENV: MEDIA_LABEL_PREFIX=
02/01/07 09:59:29 ENV: MEDIA_LABEL_SUFFIX=
02/01/07 09:59:29 ENV: MEDIA_LABEL_NEXTNUM=0
02/01/07 09:59:29 ENV: MEDIA_LABEL_NUMDIGITS=0
02/01/07 09:59:29 ENV: MEDIA_LABEL=
02/01/07 09:59:29 ENV: REST_MBOX_USER_PASSWORD=
02/01/07 09:59:29 ENV: JOBNAME=D-Data - Daily Full
02/01/07 09:59:29 ENV: REST_ESE_LOG_PATH=C:\TEMP\
02/01/07 09:59:29 ENV: BU_SQL_HOTCOPY_PATH=C:\TEMP
02/01/07 09:59:29 ENV: REST_SQL_RESTORE_TO_PATH=
02/01/07 09:59:29 ENV: REST_SQL_LOG_MARK_NAME=
02/01/07 09:59:29 ModifiedOnly is 0
02/01/07 09:59:29 SWCompMode is 0
02/01/07 09:59:29 ENV: DOMINO_SCRATCH_DB2_DB_NAME=
02/01/07 09:59:29 ENV: MEDIA_SERVER=SBS01
02/01/07 09:59:29 ENV: SPS_SERVER_LIST=Server Farm 1 (SBS01)\
02/01/07 09:59:29 ENV: SPS_COMMIT_RESTORE=0
02/01/07 09:59:29 ENV: SPS_REST_OVER_EXISTING=0
02/01/07 09:59:29 ENV: DO_OFF_HOST_BACKUP=0
02/01/07 09:59:29 ENV: OFF_HOST_BACKUP_OPER_TYPE=0
02/01/07 09:59:29 ENV: OFF_HOST_METADATA_COLL_NAME=
02/01/07 09:59:29 ENV: PRESERVE_CTIME=0
02/01/07 09:59:29 ENV: FOLLOW_SYMDIRS=0
02/01/07 09:59:29 ENV: INCLUDE_REMOTE=0
02/01/07 09:59:29 ENV: NO_NFS_LOCKING=0
02/01/07 09:59:29 ENV: FOLLOW_MOUNTPOINTS=1
02/01/07 09:59:29 ENV: TRUE_IMAGE_BACKUP=0
02/01/07 09:59:29 ENV: NBBSA_TOTAL_STREAMS=0
02/01/07 09:59:29 ENV: BSA_SERVICE_HOST=SBS01
02/01/07 09:59:29 ENV: DB2_BACKUP_TYPE=1
02/01/07 09:59:29 ENV: DB2_SHUTDOWN=0
02/01/07 09:59:29 ENV: DB2_RE_RESTORE=0
02/01/07 09:59:29 ENV: DB2_RE_RESTOREOPTS_DATETIME=0
02/01/07 09:59:29 ENV: DB2_RE_RECOVER=0
02/01/07 09:59:29 ENV: DB2_RE_ROLLFWDOPTS_DATETIME=0
02/01/07 09:59:29 ENV: DB2_RE_REDIRECTED_RESTORE=0
02/01/07 09:59:29 ENV: DB2_RE_REDIRECTED_INSTANCE=0
02/01/07 09:59:29 ENV: DB2_RE_PUT_DB_ONLINE=0
02/01/07 09:59:29 ENV: DB2_RE_REDIRECT_DATABASE=0
02/01/07 09:59:29 ENV: DB2_RE_REDIRECT_CONTAINER=0
02/01/07 09:59:29 ENV: DB2_RE_OVERRIDE_RECO_LOG_PATH=0
02/01/07 09:59:29 ENV: DB2_QUIESCE_DB=1
02/01/07 09:59:29 ENV: ORACLE_BACKUP_TYPE=2
02/01/07 09:59:29 ENV: ORACLE_SHUTDOWN=0
02/01/07 09:59:29 ENV: ORACLE_STARTUP=0
02/01/07 09:59:29 ENV: ORACLE_BK_AUTO_ARCHDELETE=0
02/01/07 09:59:29 ENV: ORACLE_RE_RESTORE=0
02/01/07 09:59:29 ENV: ORACLE_RE_RESTOREOPTS_DATETIME=0
02/01/07 09:59:29 ENV: ORACLE_RE_RESTOREOPTS_SCN=0
02/01/07 09:59:29 ENV: ORACLE_RE_RESTOREOPTS_OMIT_READONLY=0
02/01/07 09:59:29 ENV: ORACLE_RE_RECOVER=0
02/01/07 09:59:29 ENV: ORACLE_RE_RECOVEROPTS_DATETIME=0
02/01/07 09:59:29 ENV: ORACLE_RE_RECOVEROPTS_SCN=0
02/01/07 09:59:29 ENV: ORACLE_RE_RECOVEROPTS_DELETE_ALOGS=0
02/01/07 09:59:29 ENV: ORACLE_RE_RESTORE_CONTROL_FILE_ONLY=0
02/01/07 09:59:29 ENV: ORACLE_RE_RESTORE_VALIDATE=0
02/01/07 09:59:29 ENV: ORACLE_RE_RECOVER_IF_VALID=0
02/01/07 09:59:29 ENV: ENABLE_GRANULAR_RESTORE=0
02/01/07 09:59:29 ENV: CPS_JOB_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: CPS_JOB_INCR=0
02/01/07 09:59:29 ENV: DO_PDI_DATA_TRANSFER=0
02/01/07 09:59:29 ENV: PDI_DATA_TRANSFER_PHASE=0
02/01/07 09:59:29 ENV: PDI_GENERAL_ATTRIBUTES=0
02/01/07 09:59:29 ENV: PDI_IPC_OBJECT=
02/01/07 09:59:29 ENV: PDI_LOCATION=E:\SBS01\D-Data
02/01/07 09:59:29 ENV: PDI_TEMP_LOCATION=
02/01/07 09:59:29 ENV: PDI_VCB_PASSWORD_ENCRYPT_ALG=0
02/01/07 09:59:29 ENV: PDI_VCB_DATA_COMP_ALG=0
02/01/07 09:59:29 ENV: PDI_VCB_SOFTWARE_MAJOR_VER=0
02/01/07 09:59:29 ENV: PDI_VCB_SOFTWARE_MINOR_VER=0
02/01/07 09:59:29 ENV: PDI_VCB_TIME_ZONE=0
02/01/07 09:59:29 ENV: PDI_VCB_IMAGEID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_IMAGECONTENTID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_GEN0SOURCEIMAGEID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_CATALOGSOURCEID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_GENERATIONNUMBER=0
02/01/07 09:59:29 ENV: PDI_VCB_DERIVEDSOURCEIMAGEID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_POLICY_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_JOB_FAMILY_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_JOB_HISTORY_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_JOB_INSTANCE_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_JOB_EXECUTION_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_MEDIA_SET_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_DEVICE_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_MEDIA_SET_RETENSION_HRS=0
02/01/07 09:59:29 ENV: PDI_VCB_MEDIA_TYPE=0
02/01/07 09:59:29 ENV: PDI_VCB_PREVIOUSIMAGECONTENTID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_SELECTION_LIST_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_SET_SEQUENCE_NUM=0
02/01/07 09:59:29 ENV: PDI_VCB_IMAGE_LINK_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_MEDIA_ID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: PDI_VCB_ATTRIB1=0
02/01/07 09:59:29 ENV: PDI_VCB_ATTRIB2=0
02/01/07 09:59:29 ENV: PDI_VCB_COMPRESSED_OBJ=0
02/01/07 09:59:29 ENV: DSBK_BACKUP_METHOD=0
02/01/07 09:59:29 ENV: DSBK_RESTORE_RESTORE_DIBSET=0
02/01/07 09:59:29 ENV: DSBK_RESTORE_ACTIVATE_DIB_AFTER_VERIFY=0
02/01/07 09:59:29 ENV: DSBK_RESTORE_OPEN_DATABASE_WHEN_FINISHED=0
02/01/07 09:59:29 ENV: DSBK_RESTORE_DONOT_VERIFY_DIB_AFTER_RESTORE=0
02/01/07 09:59:29 ENV: DSBK_RESTORE_ROLL_FORWARD_LOG_DIRECTORY_PATH=
02/01/07 09:59:29 ENV: DSBK_LEAVE_BACKUP_FILE_ON_DISK=0
02/01/07 09:59:29 ENV: POLICY_GUID={00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: JOB_FAMILY_GUID={4682CFDB-2FBE-4CEB-9FB3-20FE6E0951B0}
02/01/07 09:59:29 ENV: JOB_HISTORY_GUID={F15C3DA0-0154-4E9C-8ABE-CA07A7E6A466}
02/01/07 09:59:29 ENV: JOB_INSTANCE_GUID={FCE69A83-B68D-4622-AF1D-40E69C33A415}
02/01/07 09:59:29 ENV: JOB_EXECUTION_GUID={F15C3DA0-0154-4E9C-8ABE-CA07A7E6A466}
02/01/07 09:59:29 ENV: MEDIA_SET_GUID={A66058B3-0082-43D8-95CF-BF949EAF0BEB}
02/01/07 09:59:29 ENV: DEVICE_GUID={043BBCBB-4459-4814-A605-8635C987005E}
02/01/07 09:59:29 ENV: MEDIA_SET_RETENSION_HOURS=24
02/01/07 09:59:29 ENV: TARGET_MEDIA_TYPE=15
02/01/07 09:59:29 ENV: PDI_ANCESTRY_LOCATIONS=
02/01/07 09:59:29 ENV: IMAGE_LINK_ID = {00000000-0000-0000-0000-000000000000}
02/01/07 09:59:29 ENV: RECREATE_AD_OBJECTS=0
02/01/07 09:59:29 ENV: PDI_SET_COUNT=0
02/01/07 09:59:29 ENV: PDI_MAX_SET_COUNT=0
02/01/07 09:59:29 ENV: MEDIA_LABEL_KEY=0
02/01/07 09:59:29 ENV: MEDIA_LABEL_PREFIX=
02/01/07 09:59:29 ENV: MEDIA_LABEL_SUFFIX=
02/01/07 09:59:29 ENV: MEDIA_LABEL_NEXTNUM=0
02/01/07 09:59:29 ENV: MEDIA_LABEL_NUMDIGITS=0
02/01/07 09:59:29 ENV: MEDIA_LABEL=
02/01/07 09:59:29 ENV: REST_ESE_POINT_IN_TIME_LOWWORD=0
02/01/07 09:59:29 ENV: REST_ESE_POINT_IN_TIME_HIGHWORD=0
02/01/07 09:59:29 ENV: B2D_RESERVED_DISKSPACE_MB=0
02/01/07 09:59:29 GetServerType for local machine
02/01/07 09:59:29 GetServerType for local machine
02/01/07 09:59:29 GetServerType for local machine
02/01/07 09:59:29 Finding MNET entries using PunchDownWithWNetCalls()
02/01/07 09:59:29 No Oracle SID's were discovered
02/01/07 09:59:29 GetServerType for local machine
02/01/07 09:59:29 Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
02/01/07 09:59:29 No utility partitions found on any of the disks
02/01/07 09:59:29 NRDS_RA_FindDrives entered
02/01/07 09:59:29 NRDS_RA_FindDrives completed immediately because we aren't browsing
02/01/07 09:59:29 Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:687
02/01/07 09:59:29 Informational: Cps library not available. Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:691
02/01/07 09:59:29 Function called: DB2_FindDrives
02/01/07 09:59:29 Status 0xE0008488 returned calling FindDrives for file system 28 in DLE_UpdateList
02/01/07 09:59:29 AD:DeviceName "System?State" in SystemState::CreateDLEs:314
02/01/07 09:59:29 AD:Full Device Path "System?State" in SystemState::CreateDLEs:319
02/01/07 09:59:29 AD:ADRO Agent is authorized for System?State.
02/01/07 09:59:29 AD:Found 0 instances of Active Directory Applcation Mode in SystemState::GetADAMInstanceCount:1246
02/01/07 09:59:29 ADC_FindAgents entered
02/01/07 09:59:29 ADC_FindAgents completed immediately because we aren't browsing
02/01/07 09:59:29 SQL2_FindDrives - the default SQL Service is not running on SBS01.
02/01/07 09:59:29 SQL2_FindDrives - checking named instance SBSMONITORING.
02/01/07 09:59:29 IsServiceClusterOk called on SBS01
02/01/07 09:59:29 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:29 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:29 SQL2_CreateDLE - creating SBS01\SBSMONITORING.
02/01/07 09:59:29 SQL Version 2000
02/01/07 09:59:29 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:29 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SBSMONITORING in the registry.
02/01/07 09:59:29 SQL2_FindDrives - checking named instance SHAREPOINT.
02/01/07 09:59:29 IsServiceClusterOk called on SBS01
02/01/07 09:59:29 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:29 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:29 SQL2_CreateDLE - creating SBS01\SHAREPOINT.
02/01/07 09:59:29 SQL Version 2000
02/01/07 09:59:29 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:29 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\SHAREPOINT in the registry.
02/01/07 09:59:29 SQL2_FindDrives - checking named instance BKUPEXEC.
02/01/07 09:59:29 IsServiceClusterOk called on SBS01
02/01/07 09:59:29 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:29 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:29 SQL2_CreateDLE - creating SBS01\BKUPEXEC.
02/01/07 09:59:29 SQL Version 2005
02/01/07 09:59:29 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:29 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
02/01/07 09:59:29 Setting 2K5 extended feature bit.
02/01/07 09:59:29 AddESE_DLEs( )
02/01/07 09:59:29 AddESE_DLEs for sever name SBS01
02/01/07 09:59:29 HrESEBackupRestoreGetRegistered: SBS01, NULL = 0x00000000
02/01/07 09:59:29 AreYouSureThisIsAnExchangeServer: SBS01
02/01/07 09:59:29 HrESEBackupRestoreNodes: SBS01 = 0x00000000
02/01/07 09:59:29 Recursing
02/01/07 09:59:29 AreYouSureThisIsAnExchangeServer: SBS01
02/01/07 09:59:29 SBS01 is an Exchange server
02/01/07 09:59:29 AreYouSureThisIsAnExchangeServer SBS01: 1
02/01/07 09:59:29 HrESEBackupFreeNodes:
02/01/07 09:59:29 AreYouSureThisIsAnExchangeServer SBS01: 1
02/01/07 09:59:29 HrESEBackupPrepare: Microsoft Information Store, SBS01 = 0x00000000
02/01/07 09:59:29 HrESEBackupFreeInstance:
02/01/07 09:59:29 HrESEBackupEnd: Microsoft Information Store = 0x00000000
02/01/07 09:59:29 AddESE_DLEs( )
02/01/07 09:59:29 AddESE_DLEs for sever name SBS01
02/01/07 09:59:29 AddESE_DLEs: annotation != NULL
02/01/07 09:59:29 HrESEBackupPrepare: Microsoft Information Store, SBS01 = 0x00000000
02/01/07 09:59:29 ESE_CheckForRSG( )
02/01/07 09:59:29 HrESEBackupFreeInstance:
02/01/07 09:59:29 HrESEBackupEnd: Microsoft Information Store = 0x00000000
02/01/07 09:59:29 HrESEFreeRegistered:
02/01/07 09:59:29 ndmpConnect : Control Connection information: A connection was established between end-points 127.0.0.1:28391 and 127.0.0.1:10000.
02/01/07 09:59:29 ndmpRun: Control connection accepted : connection established between end-points 127.0.0.1:10000 and 127.0.0.1:28391
02/01/07 09:59:29 NDMP version 3 connection CONNECTED
02/01/07 09:59:29 BELogonUser: beclass::IsThisMe() returned error: 87
02/01/07 09:59:29 LogonType set =
02/01/07 09:59:29 LogonUser(LOGON32_LOGON_INTERACTIVE-0x2) success
02/01/07 09:59:29 Successfully impersonated mydomainname\svc.BACKUP
02/01/07 09:59:29 WhoAmI( ) reports: mydomainname\svc.BACKUP
02/01/07 09:59:29 NDMPEngine::SetupNDMPConnection(): Using proxy authentication as requested
02/01/07 09:59:29 @@@@@@@MyCloseSocket called with sockfd = 1156(0x484)retval = 0
02/01/07 09:59:29 @@@@@@@MyCloseSocket called with sockfd = -1(0xffffffff)retval = -1
02/01/07 09:59:29 @@@@@@@MyCloseSocket called with sockfd = 932(0x3a4)retval = 0
02/01/07 09:59:29 ENTER DPM::FindDrives
02/01/07 09:59:29 ENTER DPM::IsServicePresent
02/01/07 09:59:29 @@@@@@@MyCloseSocket called with sockfd = -1(0xffffffff)retval = -1
02/01/07 09:59:29 DPM: Failed OpenService
02/01/07 09:59:29 DPM: Service is present:
02/01/07 09:59:29 EXIT DPM::IsServicePresent
02/01/07 09:59:29 DPM: DPM Service not present
02/01/07 09:59:29 EXIT DPM::FindDrives return=
02/01/07 09:59:29 FS_BlowOutMachine: entered -->D:<--
02/01/07 09:59:29 FS_BlowOutMachine: no machine name possible
02/01/07 09:59:29 Entering SetupLocalShareInfo
02/01/07 09:59:29 Informational: Not enumerating DFS
02/01/07 09:59:29 Attach to D:
02/01/07 09:59:29 Detach from D:
02/01/07 09:59:29 Entering SetupLocalShareInfo
02/01/07 09:59:29 Informational: Not enumerating DFS
02/01/07 09:59:29 Attach to D:
02/01/07 09:59:29 line = "D:\OfficeShare\*.*",s,v0,t0,l0,n0,f0
02/01/07 09:59:29 dir = OfficeShare
02/01/07 09:59:29 file = *.*
02/01/07 09:59:29 oper = Include
02/01/07 09:59:29 subs = True
02/01/07 09:59:29 wild = True
02/01/07 09:59:29 attr_on_mask = 0
02/01/07 09:59:29 attr_off_mask = 0
02/01/07 09:59:29 line = "D:\Scripts\*.*",s,v0,t0,l0,n0,f0
02/01/07 09:59:29 dir = Scripts
02/01/07 09:59:29 file = *.*
02/01/07 09:59:29 oper = Include
02/01/07 09:59:29 subs = True
02/01/07 09:59:29 wild = True
02/01/07 09:59:29 attr_on_mask = 0
02/01/07 09:59:29 attr_off_mask = 0
02/01/07 09:59:29 line = "D:\Share\*.*",s,v0,t0,l0,n0,f0
02/01/07 09:59:29 dir = Share
02/01/07 09:59:29 file = *.*
02/01/07 09:59:29 oper = Include
02/01/07 09:59:29 subs = True
02/01/07 09:59:29 wild = True
02/01/07 09:59:29 attr_on_mask = 0
02/01/07 09:59:29 attr_off_mask = 0
02/01/07 09:59:29 AddFsExcludes:
02/01/07 09:59:29 BSD for D:
02/01/07 09:59:29 + \OfficeShare\*.* /s
02/01/07 09:59:29 + \Scripts\*.* /s
02/01/07 09:59:29 + \Share\*.* /s
02/01/07 09:59:29 INFORMATIONAL: REG_MULTI_SZ registry value "SYSTEM\CurrentControlSet\Control\BackupRestore\FilesNotToBackup\DRM" lacks proper termination
02/01/07 09:59:29 INFORMATIONAL: Changed c:\windows\sysvol\domain\DO_NOT_REMOVE_NtFrs_PreInstall_Directory\* from interal to external exclude
02/01/07 09:59:29 FilesNotToBackup and Hardcoded exclusion files:
02/01/07 09:59:29 C:\WINDOWS\Cluster\MajorityNodeSet_FileMutex
02/01/07 09:59:29 C:\WINDOWS\Cluster\MNS*\*.* /s
02/01/07 09:59:29 C:\WINDOWS\repair\asr.log
02/01/07 09:59:29 C:\WINDOWS\repair\asr.err
02/01/07 09:59:29 C:\WINDOWS\csc\* /s
02/01/07 09:59:29 C:\Documents and Settings\svc.BACKUP\index.dat /s
02/01/07 09:59:29 D:\Pagefile.sys
02/01/07 09:59:29 C:\WINDOWS\Registration\*.clb
02/01/07 09:59:29 D:\*.crmlog /s
02/01/07 09:59:29 D:\System Volume Information\MountPointManagerRemoteDatabase
02/01/07 09:59:29 C:\WINDOWS\netlogon.chg
02/01/07 09:59:29 D:\hiberfil.sys
02/01/07 09:59:29 D:\System Volume Information\*{3808876B-C176-4e48-B7AE-04046E6CC752} /s
02/01/07 09:59:29 D:\System Volume Information\*.{7cc467ef-6865-4831-853f-2a4817fd1bca}DB
02/01/07 09:59:29 D:\System Volume Information\*.{7cc467ef-6865-4831-853f-2a4817fd1bca}ALT
02/01/07 09:59:29 C:\WINDOWS\Tasks\schedlgu.txt
02/01/07 09:59:29 C:\WINDOWS\TEMP\* /s
02/01/07 09:59:29 C:\WINDOWS\debug\*
02/01/07 09:59:29 C:\WINDOWS\SoftwareDistribution\* /s
02/01/07 09:59:29 C:\WINDOWS\System32\CatRoot2\* /s
02/01/07 09:59:29 C:\WINDOWS\system32\MSDTC\MSDTC.LOG
02/01/07 09:59:29 C:\WINDOWS\system32\MSDtc\trace\dtctrace.log
02/01/07 09:59:29 C:\Documents and Settings\All Users\DRM\* /s
02/01/07 09:59:29 C:\WINDOWS\NTDS\*
02/01/07 09:59:29 C:\WINDOWS\system32\dns\backup\dns.log
02/01/07 09:59:29 C:\WINDOWS\system32\dns\dns.log
02/01/07 09:59:29 c:\windows\ntfrs\jet\* /s
02/01/07 09:59:29 C:\WINDOWS\debug\NtFrs\NtFrs*
02/01/07 09:59:29 c:\windows\sysvol\domain\DO_NOT_REMOVE_NtFrs_PreInstall_Directory\* /s
02/01/07 09:59:29 c:\windows\sysvol\domain\NtFrs_PreExisting___See_EventLog\* /s
02/01/07 09:59:29 c:\windows\sysvol\staging\domain\NTFRS_*
02/01/07 09:59:29 C:\Documents and Settings\All Users\Application Data\Microsoft\Network\Downloader\*
02/01/07 09:59:29 C:\WINDOWS\system32\CertLog\*.edb
02/01/07 09:59:29 C:\WINDOWS\system32\CertLog\*
02/01/07 09:59:29 D:\win386.swp /s
02/01/07 09:59:29 D:\pagefile.sys /s
02/01/07 09:59:29 D:\386spart.par
02/01/07 09:59:29 D:\ea data. sf
02/01/07 09:59:29 D:\SSH??P*.SSS /s
02/01/07 09:59:29 D:\SSH?P*.SSS /s
02/01/07 09:59:29 D:\SIS COMMON STORE\*.* /s
02/01/07 09:59:29 D:\dblspace.*
02/01/07 09:59:29 D:\drvspace.*
02/01/07 09:59:29 D:\stacvol.*
02/01/07 09:59:29 D:\_swap_.mem
02/01/07 09:59:29 D:\_BEVspCacheFile_*.VSP /s
02/01/07 09:59:29 D:\system\q_*.* /s
02/01/07 09:59:29 D:\system\*.q /s
02/01/07 09:59:29 D:\system\btrieve.trn
02/01/07 09:59:29 D:\cdrom$$.rom\*.* /s
02/01/07 09:59:29 D:\desktop.afp\*.*
02/01/07 09:59:29 D:\snapshot\pool*.dat /s
02/01/07 09:59:29 D:\Backup Exec AOFO Store\* /s
02/01/07 09:59:29 C:\Program Files\Symantec\Backup Exec\Catalogs\FD??????.FDD
02/01/07 09:59:29 C:\Program Files\Symantec\Backup Exec\Catalogs\EM??????.FDD
02/01/07 09:59:29 C:\Program Files\Symantec\Backup Exec\Catalogs\SM??????.SM
02/01/07 09:59:29 C:\Program Files\Symantec\Backup Exec\Catalogs\*.tmp
02/01/07 09:59:29 BSD for D:
02/01/07 09:59:29 + \OfficeShare\*.* /s
02/01/07 09:59:29 + \Scripts\*.* /s
02/01/07 09:59:29 + \Share\*.* /s
02/01/07 09:59:29 - \Pagefile.sys
02/01/07 09:59:29 - \*.crmlog /s
02/01/07 09:59:29 - \System Volume Information\MountPointManagerRemoteDatabase
02/01/07 09:59:29 - \hiberfil.sys
02/01/07 09:59:29 - \System Volume Information\*{3808876B-C176-4e48-B7AE-04046E6CC752} /s
02/01/07 09:59:29 - \System Volume Information\*.{7cc467ef-6865-4831-853f-2a4817fd1bca}DB
02/01/07 09:59:29 - \System Volume Information\*.{7cc467ef-6865-4831-853f-2a4817fd1bca}ALT
02/01/07 09:59:29 - \win386.swp /s
02/01/07 09:59:29 - \pagefile.sys /s
02/01/07 09:59:29 - \386spart.par
02/01/07 09:59:29 - \ea data. sf
02/01/07 09:59:29 - \SSH??P*.SSS /s
02/01/07 09:59:29 - \SSH?P*.SSS /s
02/01/07 09:59:29 - \SIS COMMON STORE\*.* /s
02/01/07 09:59:29 - \dblspace.*
02/01/07 09:59:29 - \drvspace.*
02/01/07 09:59:29 - \stacvol.*
02/01/07 09:59:29 - \_swap_.mem
02/01/07 09:59:29 - \_BEVspCacheFile_*.VSP /s
02/01/07 09:59:29 - \system\q_*.* /s
02/01/07 09:59:29 - \system\*.q /s
02/01/07 09:59:29 - \system\btrieve.trn
02/01/07 09:59:29 - \cdrom$$.rom\*.* /s
02/01/07 09:59:29 - \desktop.afp\*.*
02/01/07 09:59:29 - \snapshot\pool*.dat /s
02/01/07 09:59:29 - \Backup Exec AOFO Store\* /s
02/01/07 09:59:29 Detach from D:
02/01/07 09:59:29 Backup Job Start - Thu Feb 01 09:59:29 2007
02/01/07 09:59:29 Added the media server SBS01 to the advertisement list.
02/01/07 09:59:29 Entering SetupLocalShareInfo
02/01/07 09:59:29 Informational: Enumerating DFS
02/01/07 09:59:29 Attach to D:
02/01/07 09:59:29 Informational status 0xE000FE03 calling FS_AttachToDLE for device C: in LP_ENV::LoadEnumSpecFileExcludes
02/01/07 09:59:29 Informational status 0xE000FE03 calling FS_AttachToDLE for device D: in LP_ENV::LoadEnumSpecFileExcludes
02/01/07 09:59:29 Informational status 0xE000FE03 calling FS_AttachToDLE for device E: in LP_ENV::LoadEnumSpecFileExcludes
02/01/07 09:59:29 calling CreateMAPIPRov
02/01/07 09:59:29 making a new session
02/01/07 09:59:29 Using MAPI Provider for Restore.
02/01/07 09:59:29 ConfigureMsgService() MAPI_FAILED - return code 81002746.
user svc.BACKUP
02/01/07 09:59:29 Logon: m_lpMAPISession->Logon returned 81002746
02/01/07 09:59:29 Informational status 0xE0008488 calling FS_AttachToDLE for device \\SBS01\Microsoft Exchange Mailboxes in LP_ENV::LoadEnumSpecFileExcludes
02/01/07 09:59:29 calling CreateMAPIPRov
02/01/07 09:59:29 making a new session
02/01/07 09:59:29 Using MAPI Provider for Restore.
02/01/07 09:59:29 ConfigureMsgService() MAPI_FAILED - return code 81002746.
user svc.BACKUP
02/01/07 09:59:29 Logon: m_lpMAPISession->Logon returned 81002746
02/01/07 09:59:29 Informational status 0xE0008488 calling FS_AttachToDLE for device \\SBS01\Microsoft Exchange Public Folders in LP_ENV::LoadEnumSpecFileExcludes
02/01/07 09:59:29 SQL2: Attempting attach with username ''
02/01/07 09:59:29 SQL2_Connect worked.
02/01/07 09:59:29 SQL Agent: Version String { 9.00.2047.00 }
02/01/07 09:59:29 Attach to SBS01\BKUPEXEC
02/01/07 09:59:29 Detach from SBS01\BKUPEXEC
02/01/07 09:59:29 SQL DBClose
02/01/07 09:59:29 SQL2_CleanUpSnapInfoList called.
02/01/07 09:59:29 SQL2: Attempting attach with username ''
02/01/07 09:59:29 SQL2_Connect worked.
02/01/07 09:59:29 SQL Agent: Version String { 8.00.2039 }
02/01/07 09:59:29 SQL 2000 Service Pack 4 or later.
02/01/07 09:59:29 Build = 2039
02/01/07 09:59:29 Attach to SBS01\SBSMONITORING
02/01/07 09:59:29 Detach from SBS01\SBSMONITORING
02/01/07 09:59:29 SQL DBClose
02/01/07 09:59:29 SQL2_CleanUpSnapInfoList called.
02/01/07 09:59:29 SQL2: Attempting attach with username ''
02/01/07 09:59:29 SQL2_Connect worked.
02/01/07 09:59:29 SQL Agent: Version String { 8.00.2039 }
02/01/07 09:59:29 SQL 2000 Service Pack 4 or later.
02/01/07 09:59:29 Build = 2039
02/01/07 09:59:29 Attach to SBS01\SHAREPOINT
02/01/07 09:59:29 Detach from SBS01\SHAREPOINT
02/01/07 09:59:29 SQL DBClose
02/01/07 09:59:29 SQL2_CleanUpSnapInfoList called.
02/01/07 09:59:29 Status RPC_E_TOO_LATE (0x80010119) returned initializing COM when initializing shadow copy
02/01/07 09:59:29 Calling IVssBackupComponents::GatherWriterMetadata...
02/01/07 09:59:31 ...completed IVssBackupComponents::GatherWriterMetadata
02/01/07 09:59:31 brUtil::brUtil( img ) Constructor
02/01/07 09:59:31 Attach to Shadow?Copy?Components
02/01/07 09:59:31 Informational status CODE (0x00000002) returned calling FindFirstFile for C:\WINDOWS\system32\perf?00?.bak when getting additional files
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\BKUPEXEC Component:master exclusions not used
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\BKUPEXEC Component:model exclusions not used
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\BKUPEXEC Component:msdb exclusions not used
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\BKUPEXEC Component:BEDB exclusions not used
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\BKUPEXEC Component:BE_DLO exclusions not used
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\SBSMONITORING Component:master exclusions not used
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\SBSMONITORING Component:model exclusions not used
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\SBSMONITORING Component:msdb exclusions not used
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\SHAREPOINT Component:master exclusions not used
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\SHAREPOINT Component:model exclusions not used
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\SHAREPOINT Component:msdb exclusions not used
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\SHAREPOINT Component:STS_Config exclusions not used
02/01/07 09:59:31 Informational: Writer:SQL Server Logical Path:SBS01\SHAREPOINT Component:STS_sbs01_4 exclusions not used
02/01/07 09:59:31 Detach from Shadow?Copy?Components
02/01/07 09:59:31 brUtil::brUtil Destructor
02/01/07 09:59:31 Attach to \\SBS01\Microsoft Information Store\First Storage Group
02/01/07 09:59:31 Detach from \\SBS01\Microsoft Information Store\First Storage Group
02/01/07 09:59:31 Attach to Configuration DB (SBS01\SHAREPOINT\STS_Config)
02/01/07 09:59:31 Informational status 0xE000FE48 calling FS_EnumSpecFiles for device Configuration DB (SBS01\SHAREPOINT\STS_Config) in LP_ENV::LoadEnumSpecFileExcludes
02/01/07 09:59:31 Detach from Configuration DB (SBS01\SHAREPOINT\STS_Config)
02/01/07 09:59:31 Attach to http://companyweb\Team DB 1 (SBS01\SHAREPOINT\STS_sbs01_4)
02/01/07 09:59:31 Informational status 0xE000FE48 calling FS_EnumSpecFiles for device http://companyweb\Team DB 1 (SBS01\SHAREPOINT\STS_sbs01_4) in LP_ENV::LoadEnumSpecFileExcludes
02/01/07 09:59:31 Detach from http://companyweb\Team DB 1 (SBS01\SHAREPOINT\STS_sbs01_4)
02/01/07 09:59:31 Attach to SBS01(SBS01\SharePoint\STS_Config)
02/01/07 09:59:31 Informational status 0xE000FE48 calling FS_EnumSpecFiles for device SBS01(SBS01\SharePoint\STS_Config) in LP_ENV::LoadEnumSpecFileExcludes
02/01/07 09:59:31 Detach from SBS01(SBS01\SharePoint\STS_Config)
02/01/07 09:59:31 AD:Attach reason (0x800)
02/01/07 09:59:31 AD:Nothing to exclude...
02/01/07 09:59:31 Informational status 0x2000FE1B calling FS_AttachToDLE for device System?State in LP_ENV::LoadEnumSpecFileExcludes
02/01/07 09:59:31 TF_OpenTape()
02/01/07 09:59:31 TF_GetDriveContext ...
02/01/07 09:59:31 TF_GetDriveContext returning 0x00000000, context = 4258D10
02/01/07 09:59:31 Shared Buffers Connection type prepared...
02/01/07 09:59:31 Allocated 10 buffers, size 32768 bytes, total used: 328520
02/01/07 09:59:31 TF_OpenSet()
02/01/07 09:59:31 SetupFormatEnv( fmt=0 )
02/01/07 09:59:31 End of TF_OpenSet() ret_val = 0x00000000, num buffers = 10
02/01/07 09:59:31 Going to perform pre backup dbcc.
02/01/07 09:59:31 Windows Server 2003 (or higher) detected. No S2LP mapping required.
02/01/07 10:00:48 NTFS FetchIoBuffer:Current IO requests is outside range
02/01/07 10:04:39 TF xfer time = 307 seconds.
02/01/07 10:04:39 WRITE: tpreceive_fail_count = 7630
02/01/07 10:04:39 WRITE: waiting_on_buffers_count = 7621
02/01/07 10:04:39 WRITE: buffers_written_count = 176804
02/01/07 10:04:39 TF_CloseSet()
02/01/07 10:04:39 FreeFormatEnv( cur_fmt=0 )
02/01/07 10:04:39 Detach from D:
02/01/07 10:04:39 TF_FreeDriveContext( 4258D10 )
02/01/07 10:04:39 TF_FreeTapeBuffers: from 10 to 0 buffers
02/01/07 10:04:39 Backup Job Stop(0) - Thu Feb 01 10:04:39 2007
02/01/07 10:04:41 @@@@@@@MyCloseSocket called with sockfd = 892(0x37c)retval = 0
02/01/07 10:04:41 @@@@@@@MyCloseSocket called with sockfd = -1(0xffffffff)retval = -1
02/01/07 10:08:41 ndmpRun: Control connection accepted : connection established between end-points 127.0.0.1:10000 and 127.0.0.1:28797
02/01/07 10:08:42 BELogonUser: beclass::IsThisMe() returned error: 87
02/01/07 10:08:42 LogonType set =
02/01/07 10:08:42 LogonUser(LOGON32_LOGON_INTERACTIVE-0x2) success
02/01/07 10:08:42 Successfully impersonated mydomainname\svc.BACKUP
02/01/07 10:08:42 WhoAmI( ) reports: mydomainname\svc.BACKUP
02/01/07 10:08:48 ndmpdExecuteCommand: cmd=D:\Scripts\Start.cmd, status=0, exitcode=0
02/01/07 10:08:48 @@@@@@@MyCloseSocket called with sockfd = 1724(0x6bc)retval = 0
02/01/07 10:08:48 @@@@@@@MyCloseSocket called with sockfd = -1(0xffffffff)retval = -1

Joshua Kane's picture

Eric

One thing that you may want to try is to reboot the machine when you have the chance . If this does not ,you may be able to resolve your problem you may want to let BE figure out the best place to put the cache file and see if that works.



Joshua Kane
Symantec

Backup Exec for Windows Servers Free E-mail Support
http://seer.entsupport.symantec.com/email_forms/in...

Joshua Kane

Escalations Manager
ECRT (Engineering Customer Response Team)
Backup Exec Engineering
Symantec Corporation

Eric Kufrin's picture

Ive rebooted it several times before with no effect.

I have also tried it on the "Default" setting for AOFO wizard to let AOFO figure out the best place for cache files.

I have it set to use VSS for AOFO and that is working without issue. My question at this point is, what(if any) are reasons why I should continue to pursue getting VSP working and not just use VSS?

Joshua Kane's picture

If you are getting satisfactory backups with VSS then there is no disadvantage to using that versus the VSP provider. If you still want to troubleshoot this further then please post your E-mail address so I can contact you directly.

Joshua Kane
Symantec

Backup Exec for Windows Servers Free E-mail Support
http://seer.entsupport.symantec.com/email_forms/in...

Joshua Kane

Escalations Manager
ECRT (Engineering Customer Response Team)
Backup Exec Engineering
Symantec Corporation

Eric Kufrin's picture

Ok. I will monitor it for a week and see how it goes. My daily backups are to disk. And my weekly is to tape. If the weekly works ok with VSS I will just leave all my jobs on VSS.

I will stop back and post my email address if I need more help.

Thanks!!

-Eric

DannyBoy's picture

Hi.

My Name is Daniel. Hi have the same problem, when I performed a backup I have that error. I don't know why this ocurred 'cause before I had backed the information with AOFO without problems, Just the last week I begining to have this problems.

Someone have an Idea?

thanks a lot.

The docuement in http://support.veritas.com/docs/274096 don't work.

Enigma644's picture
I'm getting the same error backing up a Windows 2003 server... but only when I backup the D drive. The main C drive is on local discs. The D drive is on an MSA1000.
 
Looking at the job log snip below, is it the path of \\?\ that's causing the problem?? It looks rather dodgy.
 
The D drive has tons of free space, so it's not that.
 
-------
V-79-57344-34110 - AOFO: Initialization failure on: "\\10.10.0.114\D:". Advanced Open File Option used: Symantec Volume Snapshot Provider (VSP). Snapshot provider error (0xE000851C): Cache files required for the Symantec Volume Snapshot Provider (VSP) snapshot could not be created. Check that there is at least 50 MB of free disk space, and review the settings for the snapshot that are reported in the job log. Check the Windows Event Viewer for details. AOFO: Symantec Volume Snapshot Provider (VSP) snapshot cache file settings for volume "D:" : Initial: 0 MB. Maximum: 40617 MB. File: "\\?\Volume{2335c905-350f-11dc-8adb-806e6f6e6963}\Backup Exec AOFO Store\_BEVspCacheFile_22.VSP". AOFO: Symantec Volume Snapshot Provider (VSP) snapshot settings used: Quiet Time: 5 seconds. Time Out: 2000 seconds. Network control connection is established between 10.10.0.122:4514 <--> 10.10.0.114:10000 Network data connection is established between    10.10.0.122:4521 <--> 10.10.0.114:1500
-------



Message Edited by Enigma644 on 10-05-2007 07:03 AM