cancel
Showing results for 
Search instead for 
Did you mean: 

Backup Exec 12.5 and SQL 2005

SmithP
Level 3
Hello all

first off Backup Exec is running on Windows 2003 Server Standard.  last week we updated our SQL server from 2000 to SQL 2005.  since we did this i am not able to backup SQL while it is running. i keep getting the below error.

any ideas?

thanks in advance.



Exceptions
Click an exception below to locate it in the job log
Backup- FSE1V-79-57344-65268 - AOFO: Initialization failure on: "***". Advanced Open File Option used: Microsoft Volume Shadow Copy Service (VSS).
V-79-10000-10896 - SQL Prepare for Freeze failed for snapshot.

 


25 REPLIES 25

SmithP
Level 3
***************************************************************************
*****                  SGMon log for \\FSE1                           *****
***************************************************************************
BESERVER: [12/28/09 14:54:20] [4132]     -1 Job Manager: LoadJob() request completed
BESERVER: [12/28/09 14:54:20] [4132]     17 JobManager::UpdateJobInstanceData() new task state=22
BKUPEXEC: [12/28/09 14:54:22] [0000]     UIVirtualObjectView(JobHistoryView) Queried 1 items: 0 to 0
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - Parent = NULL , Entity = MACHINE
PVLSVR:   [12/28/09 14:54:24] [5452]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MACHINE_ENTITY_TYPE

            EntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityName = "

            EntityFlags = 0x00008000
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - hr = 0x0
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - Parent = NULL , Entity = VAULT
PVLSVR:   [12/28/09 14:54:24] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = VAULT_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = "

            EntityFlags = 0x00008000
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - hr = 0x0
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - Parent = NULL , Entity = STORAGE_ARRAY_ENTITY
PVLSVR:   [12/28/09 14:54:24] [5452]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = STORAGE_ARRAY_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = "

            EntityFlags = 0x00008000
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - hr = 0x0
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - Parent = NULL , Entity = DEVICE_POOL
PVLSVR:   [12/28/09 14:54:24] [3312]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = DEVICE_POOL_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = "

            EntityFlags = 0x00008000
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - hr = 0x0
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [12/28/09 14:54:24] [5452]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = DRIVE_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = "

            EntityFlags = 0x00008000
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - hr = 0x0
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [12/28/09 14:54:24] [3312]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = "

            EntityFlags = 0x00008000
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - hr = 0x0
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - Parent = MACHINE , Entity = DRIVE_POOL_DRIVE
PVLSVR:   [12/28/09 14:54:24] [5452]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = DRIVE_POOL_DRIVE_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = "

            EntityFlags = 0x00008000
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - hr = 0x0
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - Parent = MACHINE , Entity = CHANGER
PVLSVR:   [12/28/09 14:54:24] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = LIBRARY_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = "

            EntityFlags = 0x00008000
BESERVER: [12/28/09 14:54:24] [1080]     12 AdammAdminBO::Query() - hr = 0x0
BESERVER: [12/28/09 14:54:24] [0208]     -1 ActiveState::doDispatch( :( 'SQL'
BESERVER: [12/28/09 14:54:24] [0208]     -1 LocalSvr, runTask():{54aec5bc-e788-4ebf-91eb-0bbac5bf86e5}
BESERVER: [12/28/09 14:54:24] [0208]     -1 BengineWrapper runtask() start
BESERVER: [12/28/09 14:54:24] [0208]     -1 BengineWrapper JobEngine.Open() OK
BESERVER: [12/28/09 14:54:24] [6092]     -1 Client requested key (1262033842).
BESERVER: [12/28/09 14:54:24] [2464]     01 Server Configuration: Client added: 11
BESERVER: [12/28/09 14:54:24] [2464]     -1 Client 'FSE1' connected('','NSOI\Administrator'): 0x5ef8b60
BESERVER: [12/28/09 14:54:24] [1080]     17 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
BENGINE:  [12/28/09 14:54:24] [2356]     JobEngine::LaunchJob
BENGINE:  [12/28/09 14:54:24] [2356]     RunJobWithGuidAndServer( {54AEC5BC-E788-4EBF-91EB-0BBAC5BF86E5}, FSE1 ) = 0
BENGINE:  [12/28/09 14:54:24] [3656]     Thread for job SQL ({54AEC5BC-E788-4EBF-91EB-0BBAC5BF86E5}) starting
BESERVER: [12/28/09 14:54:24] [0208]     -1 BengineWrapper JobEngine.RunJobWithGuidAndServer() rc=0
BESERVER: [12/28/09 14:54:24] [0208]     -1 JobManager: BengineWrapper RunJob() done
BESERVER: [12/28/09 14:54:24] [0208]     11 LocalSvr, RunTask: EngineHandedJob SUCCESS, jobid:{54aec5bc-e788-4ebf-91eb-0bbac5bf86e5}.
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork enabled 0
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork useAny 0
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork protocol 0
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork subnet ---><---
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork MAC ---><---
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork IPv4 Enabled 0
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork IPv4 subnetAddress 0.0.0.0
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork IPv4 subnetMask 0.0.0.0
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork IPv4 autoObtain 0
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork IPv4 physical
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork selectedProtocol 0
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork InterfaceIndexProtocol 0
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork InterfaceIndex 0
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork subnet <zero>
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork PrefixLength 0
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork ipAddr <zero>
BENGINE:  [12/28/09 14:54:24] [3656]     viaNetwork FallBackOptions 0xF  Protocol Tunnel NIC Subnet
BESERVER: [12/28/09 14:54:24] [2464]     -1 Client requested key (1262033842).
BESERVER: [12/28/09 14:54:24] [6092]     01 Server Configuration: Client added: 12
BESERVER: [12/28/09 14:54:24] [6092]     -1 Client 'FSE1' connected('','NSOI\Administrator'): 0x5e9a7c8
BESERVER: [12/28/09 14:54:24] [6092]     01 Server Configuration: Client removed: 11
BESERVER: [12/28/09 14:54:24] [6092]     -1 Client 'FSE1' Disconnected:0x5e9a7c8
BENGINE:  [12/28/09 14:54:24] [0372]     Updating status for: 'SQL' (0x0 0x0)
BENGINE:  [12/28/09 14:54:24] [0372]     Status for: 'SQL' updated
BENGINE:  [12/28/09 14:54:24] [3656]     "Cluster" key does not appear to be present in the registry
BENGINE:  [12/28/09 14:54:24] [3656]     Failed to open Microsoft cluster ()
BENGINE:  [12/28/09 14:54:24] [3656]     VCS cluster keys do not appear to be present in the registry
BENGINE:  [12/28/09 14:54:24] [3656]     Failed to open VCS cluster ()
BENGINE:  [12/28/09 14:54:24] [3656]     Checking for Evaluation expiration.
BENGINE:  [12/28/09 14:54:24] [3656]     ENGSCRPT: ConvertDeviceName osId = 0X2b
BENGINE:  [12/28/09 14:54:24] [3656]     ENGSCRPT: IN - oldDeviceName = FSE1
BENGINE:  [12/28/09 14:54:24] [3656]     ENGSCRPT: OUT - newName = FSE1
BENGINE:  [12/28/09 14:54:24] [3656]     SetupCryptInfoInBSD: Backup encryption options: bHWEncryption=0,bSWEncryption=0,bSWEncryptionIfNoHW=0
BENGINE:  [12/28/09 14:54:24] [3656]     ENGSCRPT: No script found
BENGINE:  [12/28/09 14:54:24] [3656]     Failed to Load AllowExcludes key, We will update DR file evenif there are userExcludes. Error: 5
PVLSVR:   [12/28/09 14:54:24] [3312]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = DRIVE_POOL_ENTITY_TYPE

            ParentEntityGuid = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            EntityType = NULL_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [12/28/09 14:54:24] [5452]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            EntityName = ""

            EntityFlags = 0x00000000
BENGINE:  [12/28/09 14:54:24] [3876]     DeviceManager: incoming event fired
BENGINE:  [12/28/09 14:54:24] [3876]     DeviceManager: processing pending requests
BENGINE:  [12/28/09 14:54:24] [3876]     DeviceManager: query cache miss
PVLSVR:   [12/28/09 14:54:24] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = DRIVE_POOL_ENTITY_TYPE

            ParentEntityGuid = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            EntityType = NULL_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [12/28/09 14:54:24] [3312]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            EntityName = ""

            EntityFlags = 0x00000000
BENGINE:  [12/28/09 14:54:24] [3876]     Available and held drives from the pool
BENGINE:  [12/28/09 14:54:24] [3876]         FSE1 {aef0de93-08d2-43f4-b73d-0d354f472b40}.0
BENGINE:  [12/28/09 14:54:24] [3876]     Drives not in use by the Engine
BENGINE:  [12/28/09 14:54:24] [3876]         FSE1 {aef0de93-08d2-43f4-b73d-0d354f472b40}.0
BENGINE:  [12/28/09 14:54:24] [3876]     Drives available (not in use and not held)
BENGINE:  [12/28/09 14:54:24] [3876]         FSE1 {aef0de93-08d2-43f4-b73d-0d354f472b40}.0
PVLSVR:   [12/28/09 14:54:24] [5544]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_DEVICE_GUID )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            TargetDevice = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1" (Backup To Disk)
PVLSVR:   [12/28/09 14:54:24] [3312]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_MEDIA_GUID )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            TargetMedia = {00000009-03E8-0000-0000-000000000000}, "Keep Data Infinitely - Do Not Allow Overwrite" (Media Set)
PVLSVR:   [12/28/09 14:54:24] [3312]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_EXCLUDE_MEDIA_GUIDS )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
BENGINE:  [12/28/09 14:54:24] [3876]     Handing out session {da0edee0-4ca9-4a9b-aa60-2154d0484556} based on available drive:
BENGINE:  [12/28/09 14:54:24] [3876]         FSE1 {aef0de93-08d2-43f4-b73d-0d354f472b40}.0
PVLSVR:   [12/28/09 14:54:24] [5452]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            EntityName = ""

            EntityFlags = 0x00000000
BENGINE:  [12/28/09 14:54:24] [3876]     DeviceManager: returned result to caller 0x00000000
BENGINE:  [12/28/09 14:54:24] [3876]     DeviceManager: going to sleep for 900000 msecs
PVLSVR:   [12/28/09 14:54:24] [5544]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_JOB_INFO )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Job = {54AEC5BC-E788-4EBF-91EB-0BBAC5BF86E5}, "SQL"
PVLSVR:   [12/28/09 14:54:24] [3312]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_DEVICE_HOST )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Device Host = ""

            Device Port = 0000
BENGINE:  [12/28/09 14:54:24] [5160]     BackupJob: thread id 0x00001428 acquired device FSE1.
BENGINE:  [12/28/09 14:54:24] [5160]     BackupJob: thread id 0x00001428 trying to mount appending volume.
PVLSVR:   [12/28/09 14:54:24] [5452]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_MOUNT_APPEND )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
PVLSVR:   [12/28/09 14:54:24] [5452]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_INFO )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
PVLSVR:   [12/28/09 14:54:24] [5452]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_DEVICE_GUID )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            TargetDevice = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1" (Backup To Disk)
PVLSVR:   [12/28/09 14:54:24] [5452]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_MEDIA_GUID )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            TargetMedia = {00000009-03E8-0000-0000-000000000000}, "Keep Data Infinitely - Do Not Allow Overwrite" (Media Set)
PVLSVR:   [12/28/09 14:54:24] [5452]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_EXCLUDE_MEDIA_GUIDS )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
PVLSVR:   [12/28/09 14:54:24] [5452]     AdammSession::CheckTargetDeviceStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Job = {54AEC5BC-E788-4EBF-91EB-0BBAC5BF86E5}, "SQL"

            TargetDevice = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

                State = 0003, ReservationID = 0000, AvailableMovers = 0001
PVLSVR:   [12/28/09 14:54:24] [5452]     AdammSession::MountAppendMedia()
PVLSVR:   [12/28/09 14:54:24] [5452]     AdammSession::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            Slot = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:54:24] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:54:24] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:54:24] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
PVLSVR:   [12/28/09 14:54:24] [5452]     PvlDrive::MountMedia() - Establish connection

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"
PVLSVR:   [12/28/09 14:54:24] [5452]     AdammSession::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0000

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Media = {4D255A8F-B8EE-4647-8A11-6A6023BD3AF9}, "B2D000004"

            Side = 0001

            SUCCESS!
PVLSVR:   [12/28/09 14:54:24] [5452]     AdammSession::IsAppendMediaMounted() -

        Need WORM: No

        Need Encryption: No
PVLSVR:   [12/28/09 14:54:24] [5452]     AdammSession::IsAppendMediaMounted() - SUCCESS!
PVLSVR:   [12/28/09 14:54:24] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            EntityName = ""

            EntityFlags = 0x00000000
BENGINE:  [12/28/09 14:54:24] [5160]     Updating session {da0edee0-4ca9-4a9b-aa60-2154d0484556} with drive FSE1 {aef0de93-08d2-43f4-b73d-0d354f472b40}.1
BENGINE:  [12/28/09 14:54:24] [5160]     BackupJob: thread id 0x00001428 medium successfully mounted.
BENGINE:  [12/28/09 14:54:24] [3656]     Media Label: B2D000004
BENGINE:  [12/28/09 14:54:24] [3656]     Media Label: {4d255a8f-b8ee-4647-8a11-6a6023bd3af9}
BENGINE:  [12/28/09 14:54:24] [3656]     Overwrite Protected Until: 12/30/99 6:00:00 PM
BENGINE:  [12/28/09 14:54:24] [3656]     Appendable Until: 12/30/99 6:00:00 PM
BENGINE:  [12/28/09 14:54:24] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:54:24] [3656]     TAPEALERT: TapeAlert Device Flag  = 0X0
BENGINE:  [12/28/09 14:54:24] [3656]     TAPEALERT: TapeAlert Changer Flag = 0X0
BENGINE:  [12/28/09 14:54:24] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:54:24] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:54:24] [3656]     Job Family ID: {E696DD82-FEEB-48F3-B3E7-1D01EE5E7B89}
BENGINE:  [12/28/09 14:54:24] [3656]     FSE1 Block size:   1024
BENGINE:  [12/28/09 14:54:24] [3656]     FSE1 Buffer size: 32768
BENGINE:  [12/28/09 14:54:24] [3656]     FSE1 Num buffers:    10
BENGINE:  [12/28/09 14:54:24] [3656]     FSE1 High water:      7
BENGINE:  [12/28/09 14:54:24] [3656]     Enter CheckHostBSDsForSnaps
BENGINE:  [12/28/09 14:54:24] [3656]     Exit CheckHostBSDsForSnaps: true
BENGINE:  [12/28/09 14:54:24] [3656]     NDMPAgentConnector:SetupConnection(): Data Server = FSE1
BENGINE:  [12/28/09 14:54:24] [3656]     Could not resolve the "bews-ndmp" or the "ndmp" service, error code: 10109, using port 10000
BENGINE:  [12/28/09 14:54:24] [3656]     ndmpConnectEx: 'FSE1' resolves to the local machine itself. So, we will try and connect to a loopback address ...
BENGINE:  [12/28/09 14:54:24] [3656]     ndmpConnectEx : Control Connection information: A connection was established between end-points 127.0.0.1:2038 and 127.0.0.1:10000.
BEREMOTE: [12/28/09 14:54:24] [2096]     ndmpRun: Control connection accepted : connection established between end-points 127.0.0.1:10000 and 127.0.0.1:2038
BENGINE:  [12/28/09 14:54:24] [3656]     NDMP version 3 connection CONNECTED
BEREMOTE: [12/28/09 14:54:25] [0000]     BECryptoInit: BECrypto non-FIPS mode successfully enabled.
BESERVER: [12/28/09 14:54:24] [2464]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [12/28/09 14:54:24] [5452]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = DRIVE_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [12/28/09 14:54:24] [2464]     12 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [12/28/09 14:54:24] [2464]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [12/28/09 14:54:24] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [12/28/09 14:54:24] [2464]     12 AdammAdminBO::Execute() - hr = 0x0
BENGINE:  [12/28/09 14:54:25] [0000]     BECryptoInit: BECrypto non-FIPS mode successfully enabled.
BEREMOTE: [12/28/09 14:54:24] [2528]     BELogonUser: beclass::IsThisMe() returned error: 87
BEREMOTE: [12/28/09 14:54:24] [2528]     LogonType set = [LOGON32_LOGON_INTERACTIVE][0x2]
BEREMOTE: [12/28/09 14:54:25] [0000]     NPLogonNotify!
BEREMOTE: [12/28/09 14:54:25] [0000]     SvcCtl
BEREMOTE: [12/28/09 14:54:25] [0000]
BEREMOTE: [12/28/09 14:54:24] [2528]     LogonUser(LOGON32_LOGON_INTERACTIVE-0x2) success
BEREMOTE: [12/28/09 14:54:24] [2528]     Successfully impersonated NSOI\Administrator
BEREMOTE: [12/28/09 14:54:24] [2528]     WhoAmI( ) reports: NSOI\Administrator
BENGINE:  [12/28/09 14:54:24] [3656]     Enabling Shared Buffers Connection type
BENGINE:  [12/28/09 14:54:24] [3656]     Enter NDMPSnapHostBackupEngine::ProcessBSDs
BENGINE:  [12/28/09 14:54:24] [3656]     BESC: Parsing OS version info - [Major Version=5 Minor Version=2 Build Number=3790 ServicePack Major=2 ServicePack Minor=0 SuiteMask=272 ProductType=2 ProcessorType=Intel x86]
BENGINE:  [12/28/09 14:54:24] [3656]     Single logical volume snapshot is enabled for this job.
BENGINE:  [12/28/09 14:54:24] [3656]     AOFO is enabled for this job.
BENGINE:  [12/28/09 14:54:24] [3656]     Enter NDMPSnapHostBackupEngine::CreateBSDProcessor
BENGINE:  [12/28/09 14:54:24] [3656]     PDI processor not needed, performing traditional backup
BENGINE:  [12/28/09 14:54:24] [3656]     Failed to Load AllowExcludes key, We will update DR file evenif there are userExcludes. Error: 5
BENGINE:  [12/28/09 14:54:24] [3656]     Enter NDMPSnapHostBackupEngine::SnapAllVolumes
BENGINE:  [12/28/09 14:54:24] [3656]     Exit NDMPSnapHostBackupEngine::SnapAllVolumes
BENGINE:  [12/28/09 14:54:24] [3656]     Enter NDMPSnapHostBackupEngine::TrackSnappedBSD
BENGINE:  [12/28/09 14:54:24] [3656]     Exit NDMPSnapHostBackupEngine::TrackSnappedBSD
BENGINE:  [12/28/09 14:54:24] [3656]     NDMPSnapHostBackupEngine::ProcessBSDs Top of the loop
BENGINE:  [12/28/09 14:54:24] [3656]     snapResult = 0x0, result = 0x0
BENGINE:  [12/28/09 14:54:24] [3656]     Enter NDMPSnapHostBackupEngine::SnapSingleVolume
BENGINE:  [12/28/09 14:54:24] [3656]     ndmpcSnapshotPrepare: adding selection string for device_name: FSE1
BENGINE:  [12/28/09 14:54:24] [3656]     ndmpcSnapshotPrepare2: selection string: "FSE1\*.*",v0,t0,l0,n0,f0
BEREMOTE: [12/28/09 14:54:24] [2528]     "Cluster" key does not appear to be present in the registry
BEREMOTE: [12/28/09 14:54:24] [2528]     Failed to open Microsoft cluster ()
BEREMOTE: [12/28/09 14:54:24] [2528]     VCS cluster keys do not appear to be present in the registry
BEREMOTE: [12/28/09 14:54:24] [2528]     Failed to open VCS cluster ()
BEREMOTE: [12/28/09 14:54:24] [2528]     GetServerType for local machine
BEREMOTE: [12/28/09 14:54:24] [2528]     GetServerType for local machine
BEREMOTE: [12/28/09 14:54:24] [2528]     GetServerType for local machine
BEREMOTE: [12/28/09 14:54:24] [2528]     GetServerType for local machine
BEREMOTE: [12/28/09 14:54:24] [2528]     Finding MNET entries using PunchDownWithWNetCalls()
BEREMOTE: [12/28/09 14:54:25] [0000]     NPGetCaps::WNNC_START
BEREMOTE: [12/28/09 14:54:24] [2528]     Notes Agent:FindDrives
BEREMOTE: [12/28/09 14:54:24] [2528]     RMAN_FindDrives - Oracle RMAN Agent not authorized.
BEREMOTE: [12/28/09 14:54:24] [2528]     GetServerType for local machine
BEREMOTE: [12/28/09 14:54:24] [2528]     Device Shadow?Copy?Components Dle platform 2  major version 5  minor version 2  build 3790
BEREMOTE: [12/28/09 14:54:24] [2528]     No utility partitions found on any of the disks
BEREMOTE: [12/28/09 14:54:24] [2528]     NRDS_RA_FindDrives entered
BEREMOTE: [12/28/09 14:54:24] [2528]     NRDS_RA_FindDrives completed immediately because we aren't browsing
BEREMOTE: [12/28/09 14:54:24] [2528]     Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:696
BEREMOTE: [12/28/09 14:54:24] [2528]     Informational: Cps library not available.  Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:700
BEREMOTE: [12/28/09 14:54:24] [2528]     Function called: DB2_FindDrives
BEREMOTE: [12/28/09 14:54:24] [2528]     DB2_FindDrives - DB2 Agent not autherized.
BEREMOTE: [12/28/09 14:54:24] [2528]       AD:DeviceName "System?State" in SystemState::CreateDLEs:351
BEREMOTE: [12/28/09 14:54:24] [2528]       AD:Full Device Path "System?State" in SystemState::CreateDLEs:356
BEREMOTE: [12/28/09 14:54:24] [2528]       AD:ADRO Agent is NOT authorized for System?State.
BEREMOTE: [12/28/09 14:54:24] [2528]       AD:Found 0 instances of Active Directory Applcation Mode in SystemState::GetADAMInstanceCount:1355
BEREMOTE: [12/28/09 14:54:24] [2528]     ADC_FindAgents entered
BEREMOTE: [12/28/09 14:54:24] [2528]     ADC_FindAgents completed immediately because we aren't browsing
BEREMOTE: [12/28/09 14:54:24] [2528]     Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
BEREMOTE: [12/28/09 14:54:24] [2528]     SQL2_FindDrives - a default SQL Service is installed on FSE1.
BEREMOTE: [12/28/09 14:54:24] [2528]     SQL2_FindDrives - the default SQL Service appears to be SQL 2000.
BEREMOTE: [12/28/09 14:54:24] [2528]     IsServiceClusterOk called on FSE1
BEREMOTE: [12/28/09 14:54:24] [2528]     Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
BEREMOTE: [12/28/09 14:54:24] [2528]     VCS cluster keys do not appear to be present in the registry
BEREMOTE: [12/28/09 14:54:24] [2528]     Failed to open VCS cluster ()
BEREMOTE: [12/28/09 14:54:24] [2528]     SQL2_CreateDLE - creating FSE1.
BEREMOTE: [12/28/09 14:54:24] [2528]     SQL Version 2005
BEREMOTE: [12/28/09 14:54:24] [2528]     Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
BEREMOTE: [12/28/09 14:54:24] [2528]     Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
BEREMOTE: [12/28/09 14:54:24] [2528]          Setting 2K5 extended feature bit.
BEREMOTE: [12/28/09 14:54:24] [2528]     AddESE_DLEs( )
BEREMOTE: [12/28/09 14:54:24] [2528]     AddESE_DLEs for sever name FSE1
BEREMOTE: [12/28/09 14:54:24] [2528]     HrESEBackupRestoreGetRegistered: FSE1, NULL = 0xc7ff07d7
BEREMOTE: [12/28/09 14:54:24] [2528]     ESE_GetBackupAnnotations returned 0xc7ff07d7
BEREMOTE: [12/28/09 14:54:24] [2528]     EV_FindDrives
BEREMOTE: [12/28/09 14:54:24] [2528]     evFileSystem::EV_FindDrives: Agent not authorized.
BEREMOTE: [12/28/09 14:54:24] [2528]     FS_BlowOutMachine: entered -->FSE1<--
BEREMOTE: [12/28/09 14:54:24] [2528]     FS_BlowOutMachine: device already in DLE list
BEREMOTE: [12/28/09 14:54:24] [2528]     ndmpdSnapshotPrepare2: Calling DLE_FindByName for device: FSE1
BEREMOTE: [12/28/09 14:54:24] [2528]     dir  =
BEREMOTE: [12/28/09 14:54:24] [2528]     file = *.*
BEREMOTE: [12/28/09 14:54:24] [2528]     oper = Include
BEREMOTE: [12/28/09 14:54:24] [2528]     subs = False
BEREMOTE: [12/28/09 14:54:24] [2528]     wild = True
BEREMOTE: [12/28/09 14:54:24] [2528]     Attempting VSS Provider
BEREMOTE: [12/28/09 14:54:24] [2528]     Snapshot factory, using VSS as the snapshot provider.
BEREMOTE: [12/28/09 14:54:24] [2528]     OS Version: 5.2.3790 (Service Pack 2). Suite: 0x110, ProductType: 0x2, SP: 2.0
BEREMOTE: [12/28/09 14:54:24] [2528]     VssSnapshotVolume::Initialize() - Using backup type VSS_BT_FULL
BEREMOTE: [12/28/09 14:54:24] [2528]     VssSnapshotVolume::Initialize() - calling IVssBackupComponents::InitializeForBackup
BEREMOTE: [12/28/09 14:54:24] [2528]     VssSnapshotVolume::Initialize() - calling IVssBackupComponents::SetBackupState with backup type 1
BEREMOTE: [12/28/09 14:54:24] [2528]     VssSnapshotVolume::Initialize() - calling IVssBackupComponents::SetContext with context: 0
BEREMOTE: [12/28/09 14:54:25] [2528]     -------Begin Provider property dump------
BEREMOTE: [12/28/09 14:54:25] [2528]     Using fresh IVssBackupComponents for provider gather
BEREMOTE: [12/28/09 14:54:25] [2528]     ==> VSS Provider properties:
BEREMOTE: [12/28/09 14:54:25] [2528]         Provider Name       = Microsoft Software Shadow Copy provider 1.0
BEREMOTE: [12/28/09 14:54:25] [2528]         Provider ID         = {b5946137-7b9f-4925-af80-51abd60b20d5}
BEREMOTE: [12/28/09 14:54:25] [2528]         Provider Type       = System
BEREMOTE: [12/28/09 14:54:25] [2528]         Provider Version    = 1.0.0.7
BEREMOTE: [12/28/09 14:54:25] [2528]         Provider Version ID = {00000001-0000-0000-0007-000000000001}
BEREMOTE: [12/28/09 14:54:25] [2528]         Component Class ID  = {65ee1dba-8ff4-4a58-ac1c-3470ee2f376a}
BEREMOTE: [12/28/09 14:54:25] [2528]     -------End of Provider property dump------
BEREMOTE: [12/28/09 14:54:25] [2528]     Provider GUID = {00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:25] [2528]     VssSnapshotVolume::Initialize() - calling StartSnapshotSet()
BEREMOTE: [12/28/09 14:54:25] [2528]     VSS snapstarted. SnapshotSetID = {8bd1fd8b-5e3c-49c0-bd3c-177d75ecfb50}
BEREMOTE: [12/28/09 14:54:25] [2528]     VssSnapshotVolume::GetWriterMetaData() - calling IVssBackupComponents::GatherWriterMetadata.
BEREMOTE: [12/28/09 14:54:25] [2528]     VssSnapshotVolume::GetWriterMetaData() - waiting for IVssBackupComponents::GatherWriterMetadata to complete.
BEREMOTE: [12/28/09 14:54:25] [2528]     VssSnapshotVolume::GetWriterMetaData() - IVssBackupComponents::GatherWriterMetadata complete.
BEREMOTE: [12/28/09 14:54:25] [2528]     Initialized VSS Snapshot Provider
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2_Connect worked.
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL Agent: Version String { 9.00.1399.06 }
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL edition returned: Standard Edition
BEREMOTE: [12/28/09 14:54:25] [2528]     [no resource for 3893]
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning BEDB
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2: freeing old meta data to make new metadata.
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning FSEGoldmine
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2: freeing old meta data to make new metadata.
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning FSEsmeadlink
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2: freeing old meta data to make new metadata.
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning FSETigerPaw
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2: freeing old meta data to make new metadata.
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning master
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2: freeing old meta data to make new metadata.
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning model
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2: freeing old meta data to make new metadata.
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning msdb
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2: freeing old meta data to make new metadata.
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning ReportServer
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2: freeing old meta data to make new metadata.
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning ReportServerTempDB
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2: freeing old meta data to make new metadata.
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning BEDB
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning FSEGoldmine
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning FSEsmeadlink
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning FSETigerPaw
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning msdb
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning ReportServer
BEREMOTE: [12/28/09 14:54:25] [2528]     Returning ReportServerTempDB
BEREMOTE: [12/28/09 14:54:25] [2528]     SnapshotBackupEngine::scan_file_system() : Volume List size (before prune): 9
BEREMOTE: [12/28/09 14:54:25] [2528]     SnapshotBackupEngine::scan_file_system(): Volume List size (after prune): 2
BEREMOTE: [12/28/09 14:54:25] [2528]     Adding volume: 'C:'
BEREMOTE: [12/28/09 14:54:25] [2528]     VssSnapshotVolume::AddVolumeToSnapSet
BEREMOTE: [12/28/09 14:54:25] [2528]       Device name: [FSE1], Volume name: [C:]
BEREMOTE: [12/28/09 14:54:25] [2528]     Warning: Using null server name
BEREMOTE: [12/28/09 14:54:25] [2528]       Set bsdMachineName_: []
BEREMOTE: [12/28/09 14:54:25] [2528]     Exit VssSnapshotVolume::AddVolumeToSnapSet - successfully
BEREMOTE: [12/28/09 14:54:25] [2528]     Adding volume: 'D:'
BEREMOTE: [12/28/09 14:54:25] [2528]     VssSnapshotVolume::AddVolumeToSnapSet
BEREMOTE: [12/28/09 14:54:25] [2528]       Device name: [FSE1], Volume name: [D:]
BEREMOTE: [12/28/09 14:54:25] [2528]     Warning: Using null server name
BEREMOTE: [12/28/09 14:54:25] [2528]     Exit VssSnapshotVolume::AddVolumeToSnapSet - successfully
BEREMOTE: [12/28/09 14:54:25] [2528]     SnapshotBackupEngine::snap_file_systems. Start...
BEREMOTE: [12/28/09 14:54:25] [2528]     MakeValidVolumeName:
BEREMOTE: [12/28/09 14:54:25] [2528]          volume=[\\?\Volume{0228e6e8-72be-11de-a507-806e6f6e6963}] and vol_name=[\\?\Volume{0228e6e8-72be-11de-a507-806e6f6e6963}\]
BEREMOTE: [12/28/09 14:54:25] [2528]     MakeValidVolumeName:
BEREMOTE: [12/28/09 14:54:25] [2528]          volume=[\\?\Volume{6948efb1-72fc-11de-ba75-003048b81dc1}] and vol_name=[\\?\Volume{6948efb1-72fc-11de-ba75-003048b81dc1}\]
BEREMOTE: [12/28/09 14:54:25] [2528]     VssSnashotVolume::PrepareToSnapVolumeSet() - done. LastError_: 0
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2_PrepareForFreeze: Starting on database ReportServerTempDB.
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL Agent VDI Check.
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL Agent VDI Check: Latest DLL registered.
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2_PrepareForSnapBackup: Could not create component: x8007007E
BEREMOTE: [12/28/09 14:54:25] [2528]     SQL2: PrepareForFreeze failed.
BEREMOTE: [12/28/09 14:54:25] [2528]     SnapshotBackupEngine - SNAPSHOT_NOTIFICATION::SnapshotPrepare failed with fstatus: -536805644
BEREMOTE: [12/28/09 14:54:25] [2528]     Error SnapshotBackupEngine::snap_file_systems failed.
BEREMOTE: [12/28/09 14:54:25] [2528]     ndmpdSnapshotPrepare2: Snapshot error. ErrorCode: 0xe000fef4 ErrorLevel: 2 Error Src: 3
BEREMOTE: [12/28/09 14:54:25] [2528]       Not Found
BEREMOTE: [12/28/09 14:54:25] [2528]       Not Found
BEREMOTE: [12/28/09 14:54:25] [2528]     ndmpdSnapshotPrepare2: sending reply...
BENGINE:  [12/28/09 14:54:25] [3656]     ndmpcSnapshotPrepare2: Snap shot error. ErrorCode: 0xe000fef4 ErrorLevel: 2 Provider: 2
BENGINE:  [12/28/09 14:54:25] [3656]     Exit NDMPSnapHostBackupEngine::SnapSingleVolume
BENGINE:  [12/28/09 14:54:25] [3656]     TF_OpenTape()
BENGINE:  [12/28/09 14:54:25] [3656]     TF_GetChannel( ) reusing channel 02FFA240
BENGINE:  [12/28/09 14:54:25] [3656]     TF_GetDriveContext ...

         sessionGuid = {da0edee0-4ca9-4a9b-aa60-2154d0484556}

         initAsync = 1
BENGINE:  [12/28/09 14:54:25] [3656]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:54:25] [3656]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:54:25] [3656]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:54:25] [3656]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:54:25] [3656]     TF_GetDriveContext returning 0x00000000, context = 2FCBF30
BENGINE:  [12/28/09 14:54:25] [3656]     Allocated 2 buffers, size 32768 bytes, total used: 65696
BENGINE:  [12/28/09 14:54:25] [3656]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:54:25] [3656]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:54:25] [3656]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:54:25] [3656]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:54:25] [3656]     DeviceIsNT4Server: agent info: [Major Version=5 Minor Version=2 Build Number=3790 ServicePack Major=2 ServicePack Minor=0 SuiteMask=272 ProductType=2 ProcessorType=Intel x86].
BENGINE:  [12/28/09 14:54:25] [3656]     DeviceIsIA64Server: agent info: [Major Version=5 Minor Version=2 Build Number=3790 ServicePack Major=2 ServicePack Minor=0 SuiteMask=272 ProductType=2 ProcessorType=Intel x86].
BENGINE:  [12/28/09 14:54:25] [3656]     TF_OpenSet( )
BENGINE:  [12/28/09 14:54:25] [3656]     FreeFormatEnv( cur_fmt=65535 )
BENGINE:  [12/28/09 14:54:25] [3656]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:54:25] [3656]       ret_val = 0
BENGINE:  [12/28/09 14:54:25] [3656]     Requested Set: ID = ffffffff Seq = -1 Set = -1
BENGINE:  [12/28/09 14:54:25] [3656]     Attempting to VCB storage media
BENGINE:  [12/28/09 14:54:25] [3656]       TpRead( :(
BENGINE:  [12/28/09 14:54:25] [3656]     Error = 1101 Req = 6144 Got = 1024
BENGINE:  [12/28/09 14:54:25] [3656]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:54:25] [3656]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:54:25] [3656]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:54:25] [3656]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:54:25] [3656]     FreeFormatEnv( cur_fmt=65535 )
BENGINE:  [12/28/09 14:54:25] [3656]     SetupFormatEnv( fmt=0 )
BENGINE:  [12/28/09 14:54:25] [3656]     Current media tape header was written by "Symantec Backup Exec 12.5.2213".
BENGINE:  [12/28/09 14:54:25] [3656]       TpRead( :(
BENGINE:  [12/28/09 14:54:25] [3656]     Error = 1101 Req = 6144 Got = 2048
BENGINE:  [12/28/09 14:54:25] [3656]     ReadThisSet( cur_fmt=0 )
BENGINE:  [12/28/09 14:54:25] [3656]     Set 1 was written by version 12.5.
BENGINE:  [12/28/09 14:54:25] [3656]     ReadThisSet() return=0x00000000
BENGINE:  [12/28/09 14:54:25] [3656]     Current VCB: ID = 3b9c6a70  Seq = 1  Set = 1
BENGINE:  [12/28/09 14:54:25] [3656]     PositionAtSet( :( TF Msg = b
BENGINE:  [12/28/09 14:54:25] [3656]       UI Msg = 800f
BENGINE:  [12/28/09 14:54:25] [3656]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:54:25] [3656]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:54:25] [3656]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:54:25] [3656]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:54:25] [3656]     F40_SeekEOD starting seek...
BENGINE:  [12/28/09 14:54:25] [3656]     F40_SeekEOD calling OTC_GetPrevSM with expect_sm = 1 ...
BENGINE:  [12/28/09 14:54:25] [3656]     OTC_GetPrevSM spacing back two filemarks...
BENGINE:  [12/28/09 14:54:25] [3656]     OTC_GetPrevSM: ESET position = 6
BENGINE:  [12/28/09 14:54:25] [3656]     OTC_GetPrevSM calling OTC_SMtoFile...
BENGINE:  [12/28/09 14:54:25] [3656]     SetupFormatEnv( fmt=0 )
BENGINE:  [12/28/09 14:54:25] [3656]     End of TF_OpenSet: Ret_val = 0x00000000 Buffs = 2 HiWater = 7
BENGINE:  [12/28/09 14:54:25] [3656]     B2D Buffered Writes ===> Setting buffering to default.
BENGINE:  [12/28/09 14:54:25] [3656]     Current Block is = 10
BENGINE:  [12/28/09 14:54:25] [3656]     Media Server to initiate connection for data transfer
BEREMOTE: [12/28/09 14:54:26] [2528]     Error (0x40202) from VSS - EVENT_S_NOSUBSCRIBERS
BEREMOTE: [12/28/09 14:54:26] [2528]      after calling function: IVssBackupComponents::AbortBackup
BEREMOTE: [12/28/09 14:54:26] [2528]     Error (0x80042301) from VSS -  VSS_E_BAD_STATE
BEREMOTE: [12/28/09 14:54:26] [2528]      after calling function: IVssBackupComponents::BackupComplete
BEREMOTE: [12/28/09 14:54:26] [2528]     Error 0x80042301 calling VSS BackupComplete
BEREMOTE: [12/28/09 14:54:26] [2528]     [no resource for 3894]
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL DBClose
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_CleanUpSnapInfoList called.
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_CleanUpSnapInfoList called.
BEREMOTE: [12/28/09 14:54:26] [2528]     ndmpdSnapshotPrepare2: cleanup: all done
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: USERNAME=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: NOPASSWORD=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: USERNAME=NSOI\Administrator
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PASSWORD=<not displayed>
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: INITIATOR_SID=0@D0000000DE0000ES6U7WITaQ5XU71<m04000
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PRESCANDLE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: OPER_TYPE=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BLOCKSIZE=400
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SSETRESERVED=400
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: HW_ENCRYPT=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_PRE_BKUP_DBCC_TYPE=2b2b
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_POST_BKUP_DBCC_TYPE=2
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_POST_REST_DBCC_TYPE=3b9c69b5
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: LAST_SET=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_REGISTRY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_INUSE=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_MIGRATED=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_EXPANDED=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PROCESS_EMPTY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SWCOMPMODE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SWCOMPLEVEL=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SWCOMPTHRESH=10
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BACKUPTYPE=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SPS_METHOD=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_METHOD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_HOTCOPY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_HOTCOPY_PATH=C:\TEMP
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_NO_RECOVER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_ESE_FROM_REPLICA=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_STANDBY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_CHECKSUMS=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_SOFTWARE_COMPRESSION=3
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_NUMSNAPS_TO_KEEP=4
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_ALWAYS_SNAP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_XCH_METHOD=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_MBOX_METHOD=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_MBOX_SIS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_NTFS_SIS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: AA_PRIORITY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_RSM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_EXCLUDE_ACTIVE_FILES=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: TRAVERSE_LOCAL_MP=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: TRAVERSE_REMOTE_MP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: TRAVERSE_SYMBOLIC_LINKS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DO_SNAPSHOT=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SQL_FORCE_NP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SQL_OVERRIDE_FGDEPS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SQL_ALERT_FGDEP_OVERRIDE=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SFC_WITH_SS=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_REMOTE_STORAGE_HSM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SKIP_OPEN_FILES=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: WAIT_SKIP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: HIDDEN=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PROC_SYSTEM_FILES=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_LDM_STATE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_DISK_QUOTA=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_IN_DOC_FMT=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_REGISTRY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_HW_REGISTRY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: IGNORE_TREE_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SECURITY=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VOL_RESTRICTIONS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_XCH_PUBLIC=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_MBOX_USER_FLAG=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_MBOX_REDIR_TYPE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_MBOX_USER_PASSWORD=<not displayed>
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_SERVER=FSE1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_SERVER_LIST=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_COMMIT_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_COMMIT_DB_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_IGNORE_LOCK=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_PRESERVE_IIS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_REST_OVER_EXISTING=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_VER_REST_OVER_EXISTING=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_RESTORE_SECURITY=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_RESTORE_CURRENT_VER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SPS_PRE_BKUP_DBCC_TYPE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SPS_POST_BKUP_DBCC_TYPE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SPS_POST_REST_DBCC_TYPE=2
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: CONTINUE_ON_SPS_DBCC_ERROR=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: JOBNAME=SQL
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_XCH_PRIVATE=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_REMOTE_HSM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_RSM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_DISK_QUOTA=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_JUNC_AS_DIR=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_PRIM_REPLICA=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_TERMINAL_SERVICES=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_WMI=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_CLUSTER_QUORUM_DB=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_FORCE_RECOVERY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_EXISTING=3
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_XCH_NO_LOSS=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_MOUNT=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_DISMOUNT=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_LOG_PATH=C:\TEMP\
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_REDIR_SG=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_REDIR_DB=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_REDIR_PATH=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_LAST_SET=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_NO_LOSS=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_CONSISTENCY_CHECK=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_CONTINUE_CONSISTENCY_CHECK=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_DATABASE_OVERWRITE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_KEEP_REPLICATION=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_VERIFY_ONLY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_RESTORE_TO=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_RESTORE_TO_PATH=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_CONTINUE_ON_ERROR=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_POINT_IN_TIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_POINT_IN_TIME_DATE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_POINT_IN_TIME_TIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_PRE_BKUP_DBCC=2
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_POST_BKUP_DBCC=2
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_POST_REST_DBCC=2
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: CONTINUE_ON_DBCC_ERROR=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_AUTO_MASTER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_DATABASE_STANDBY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_DATABASE_FORCERESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_DATABASE_RECOVER=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_LOG_MARK_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_LOG_MARK_NAME=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_LOG_MARK_STOP_BEFORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_LOG_MARK_AFTER_TIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_LOG_MARK_DATE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_LOG_MARK_TIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_DEF_INSTANCE_DIR=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_USE_DEFAULT_DRIVE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_ALL_TO_DEFAULT_DRIVE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_DEFAULT_DRIVE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ARCHIVE_PRESERVE_TREE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: UTILITY_PARTITION_OEMIDS=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: APPLY_CPR_TO_BACKUPSET=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: IMAGE_METHOD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: GUARANTEED_FROZEN_IMAGE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: FULL_IMAGE_METHOD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: TESTRUN_JOB_OPTIONS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: USE_CHANGE_JOURNAL=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_BACKUP_METHOD=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_BACKUP_RECYCLE_LOGFILE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_SCRATCH_DB2_DB_NAME=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_HIDE_CATALOG_ENTRY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_LAST_BACKUP_DATE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_LAST_BACKUP_TIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_MAX_TRANLOG_EXTENTS=46
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_RESTORE_DBRECOVEROPTION=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_RESTORE_WAITINUSE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_RESTORE_MSECSFORWAIT=1e
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_RESTORE_POINTINTIMERESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_RESTORE_PITTIME_DATE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_RESTORE_PITTIME_TIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SAP_JOB_FLAG=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: IMAGE_DBLK_TYPE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PROC_CHECKSUM_STRM=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_OFFLINE_BACKUP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_OPTION_AUTHORIZED=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ENABLE_IDR_INFO_GATHERING=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: IMAGE_OPTION_AUTHORIZED=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DPM_OPTION_AUTHORIZED=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_OPTION_AUTHORIZED=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EV_OPTION_AUTHORIZED=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DO_OFF_HOST_BACKUP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: OFF_HOST_BACKUP_OPER_TYPE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: OFF_HOST_METADATA_COLL_NAME=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PRESERVE_CTIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: FOLLOW_SYMDIRS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: INCLUDE_REMOTE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: NO_NFS_LOCKING=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: FOLLOW_MOUNTPOINTS=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: TRUE_IMAGE_BACKUP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: NDMP_PROP_PORT_RANGE_ENABLED=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: NDMP_PORT_RANGE=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REVERSE_CONNECTION=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ENABLE_GRANULAR_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_OPERATION_TYPE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_DATA_TRANSFER_PHASE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_GENERAL_ATTRIBUTES=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_IPC_OBJECT=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_LOCATION=F:
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_TEMP_LOCATION=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: POLICY_GUID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: JOB_FAMILY_GUID={E696DD82-FEEB-48F3-B3E7-1D01EE5E7B89}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: JOB_HISTORY_GUID={627E4838-F0F6-4F4B-A01B-17DA721FD700}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: JOB_INSTANCE_GUID={54AEC5BC-E788-4EBF-91EB-0BBAC5BF86E5}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: JOB_EXECUTION_GUID={627E4838-F0F6-4F4B-A01B-17DA721FD700}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_SET_GUID={00000009-03E8-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DEVICE_GUID={AEF0DE93-08D2-43F4-B73D-0D354F472B40}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_SET_RETENSION_HOURS=85c170
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_TYPE=f
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_ANCESTRY_LOCATIONS=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: IMAGE_LINK_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: RECREATE_AD_OBJECTS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_SET_COUNT=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_MAX_SET_COUNT=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: CPS_JOB_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: CPS_JOB_INCR=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_POINT_IN_TIME_LOWWORD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_POINT_IN_TIME_HIGHWORD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: B2D_RESERVED_DISKSPACE_MB=2800
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ARCHIVE_JOB_DELETE_PHASE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BACKUP_JOB_START_DATE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BACKUP_JOB_START_TIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EV_BACKUP_METHOD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EV_SQL_SERVER=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EV_SITENAME=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EV_FORCE_DB_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EV_SKIP_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EV_LOG_RECVR_OPTN=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_BKUP_TEMP_LOCATION=C:\TEMP
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_BACKUP_METHOD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_EXPORT_AS_MONOLITHIC_FILE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_EXPORT_AS_FLAT_DISK=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_VCB_TRANSPORT_MODE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_USE_MEDIA_SERVER_AS_PROXY=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_VCB_PROXY_SERVER=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_EXPORT_PATH_ON_VCB_PROXY=C:\TEMP
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_RESTORE_RUNNING_VM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_POWER_ON_VM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_RUN_CONVERTER_JOB=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_USE_MEDIA_SERVER_FOR_STAGING=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REMOVE_EXISTING_VCBMOUNTER_SNAPSHOT=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_STAGING_SERVER=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_STAGING_PATH=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_VM_NAME=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_DATACENTER=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_FOLDER=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_HOST=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_DATASTORE=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_NETWORKS=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_NUMBER_OF_NICS=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_SERVER=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_FLAG=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_USE_ORG_DISK_DS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_SERVER_ACCT_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_BACKUP_METHOD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_INCLUDE_VS_CONFIG=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_EXCLUDE_RUNNING_VMS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_DO_GRT_BACKUP=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_DO_SIS_BACKUP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_RESTORE_RUNNING_VM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_POWER_ON_OPTION=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SNAPSHOT_IGNORE_REASONS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_CREATE_VERSION_7_VM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_CREATE_THIN_PROVISIONED_DISK=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SNAPSHOT_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: OFF_HOST_SNAPSHOT_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DEVICENAME="FSE1"
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DEVICE_OS_ID=2b
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DEVICE_OS_VER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DEVICE_MAINTYPE=11
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DEVICE_SUBTYPE=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: FILESYSTEM="FSE1\*.*",v0,t0,l0,n0,f0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DEVICE_REDIRECT=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DEVICE_REDIRECT_FILE_SYSTEM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: NBBSA_TOTAL_STREAMS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BSA_SERVICE_HOST=FSE1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_BACKUP_TYPE=2
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_SHUTDOWN=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_BK_AUTO_ARCHDELETE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_BK_ARCHLOGS_INCR=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RESTOREOPTS_DATETIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RESTOREOPTS_SCN=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RESTOREOPTS_OMIT_READONLY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RECOVER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RECOVEROPTS_DATETIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RECOVEROPTS_SCN=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RECOVEROPTS_DELETE_ALOGS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_STARTUP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RESTORE_CONTROL_FILE_ONLY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RESTORE_VALIDATE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RECOVER_IF_VALID=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_BACKUP_TYPE=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_SHUTDOWN=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_RESTOREOPTS_DATETIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_RECOVER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_ROLLFWDOPTS_DATETIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_REDIRECTED_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_REDIRECTED_INSTANCE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_PUT_DB_ONLINE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_REDIRECT_DATABASE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_REDIRECT_CONTAINER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_OVERRIDE_RECO_LOG_PATH=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_QUIESCE_DB=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_BACKUP_METHOD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_BACKUP_STREAM_FILES=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_BACKUP_USER_INCLUDE_FILES=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_RESTORE_RESTORE_DIBSET=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_RESTORE_ACTIVATE_DIB_AFTER_VERIFY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_RESTORE_OPEN_DATABASE_WHEN_FINISHED=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_RESTORE_DONOT_VERIFY_DIB_AFTER_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_RESTORE_RESTORE_USER_INCLUDED_FILES=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_RESTORE_ROLL_FORWARD_LOG_DIRECTORY_PATH=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_WORKING_DIRECTORY_PATH=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_LEAVE_BACKUP_FILE_ON_DISK=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: NO_DATA_CONNECTION=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_PASSWORD_ENCRYPT_ALG=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_DATA_COMP_ALG=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_SOFTWARE_MAJOR_VER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_SOFTWARE_MINOR_VER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_TIME_ZONE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_AGENT_TIME_ZONE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_IMAGEID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_IMAGECONTENTID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_GEN0SOURCEIMAGEID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_CATALOGSOURCEID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_GENERATIONNUMBER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_DERIVEDSOURCEIMAGEID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_POLICY_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_JOB_FAMILY_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_JOB_HISTORY_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_JOB_INSTANCE_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_JOB_EXECUTION_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_MEDIA_SET_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_DEVICE_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_MEDIA_SET_RETENSION_HRS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_MEDIA_TYPE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_PREVIOUSIMAGECONTENTID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_SELECTION_LIST_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_SET_SEQUENCE_NUM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_IMAGE_LINK_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_MEDIA_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_ATTRIB=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_ATTRIB2=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_COMPRESSED_OBJ=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BSD_DEVICE_ATTRIBUTES=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_LABEL_KEY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_LABEL_PREFIX=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_LABEL_SUFFIX=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_LABEL_NEXTNUM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_LABEL_NUMDIGITS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_LABEL=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_MBOX_USER_PASSWORD=<not displayed>
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: JOBNAME=SQL
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_LOG_PATH=C:\TEMP\
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_REDIR_SG=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_REDIR_DB=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_REDIR_PATH=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BU_SQL_HOTCOPY_PATH=C:\TEMP
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_RESTORE_TO_PATH=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_SQL_LOG_MARK_NAME=
BEREMOTE: [12/28/09 14:54:26] [2528]     ModifiedOnly  is 0
BEREMOTE: [12/28/09 14:54:26] [2528]     SWCompMode    is 0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DOMINO_SCRATCH_DB2_DB_NAME=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_SERVER=FSE1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_SERVER_LIST=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_COMMIT_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_COMMIT_DB_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_IGNORE_LOCK=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_PRESERVE_IIS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_REST_OVER_EXISTING=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_VER_REST_OVER_EXISTING=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_RESTORE_SECURITY=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SPS_RESTORE_CURRENT_VER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DO_OFF_HOST_BACKUP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: OFF_HOST_BACKUP_OPER_TYPE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: OFF_HOST_METADATA_COLL_NAME=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PRESERVE_CTIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: FOLLOW_SYMDIRS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: INCLUDE_REMOTE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: NO_NFS_LOCKING=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: FOLLOW_MOUNTPOINTS=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: TRUE_IMAGE_BACKUP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: NBBSA_TOTAL_STREAMS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: BSA_SERVICE_HOST=FSE1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_BACKUP_TYPE=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_SHUTDOWN=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_RESTOREOPTS_DATETIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_RECOVER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_ROLLFWDOPTS_DATETIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_REDIRECTED_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_REDIRECTED_INSTANCE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_PUT_DB_ONLINE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_REDIRECT_DATABASE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_REDIRECT_CONTAINER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_RE_OVERRIDE_RECO_LOG_PATH=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DB2_QUIESCE_DB=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_BACKUP_TYPE=2
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_SHUTDOWN=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_STARTUP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_BK_AUTO_ARCHDELETE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_BK_ARCHLOGS_INCR=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RESTOREOPTS_DATETIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RESTOREOPTS_SCN=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RESTOREOPTS_OMIT_READONLY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RECOVER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RECOVEROPTS_DATETIME=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RECOVEROPTS_SCN=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RECOVEROPTS_DELETE_ALOGS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RESTORE_CONTROL_FILE_ONLY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RESTORE_VALIDATE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ORACLE_RE_RECOVER_IF_VALID=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ENABLE_GRANULAR_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: CPS_JOB_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: CPS_JOB_INCR=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DO_PDI_DATA_TRANSFER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_DATA_TRANSFER_PHASE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_GENERAL_ATTRIBUTES=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_IPC_OBJECT=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_LOCATION=F:
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_RSTR_STG_LOCATION=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_PASSWORD_ENCRYPT_ALG=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_DATA_COMP_ALG=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_SOFTWARE_MAJOR_VER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_SOFTWARE_MINOR_VER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_TIME_ZONE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_AGENT_TIME_ZONE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_IMAGEID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_IMAGECONTENTID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_GEN0SOURCEIMAGEID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_CATALOGSOURCEID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_GENERATIONNUMBER=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_DERIVEDSOURCEIMAGEID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_POLICY_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_JOB_FAMILY_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_JOB_HISTORY_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_JOB_INSTANCE_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_JOB_EXECUTION_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_MEDIA_SET_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_DEVICE_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_MEDIA_SET_RETENSION_HRS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_MEDIA_TYPE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_PREVIOUSIMAGECONTENTID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_SELECTION_LIST_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_SET_SEQUENCE_NUM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_IMAGE_LINK_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_MEDIA_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_ATTRIB1=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_ATTRIB2=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_VCB_COMPRESSED_OBJ=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_BACKUP_METHOD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_RESTORE_RESTORE_DIBSET=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_RESTORE_ACTIVATE_DIB_AFTER_VERIFY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_RESTORE_OPEN_DATABASE_WHEN_FINISHED=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_RESTORE_DONOT_VERIFY_DIB_AFTER_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_RESTORE_ROLL_FORWARD_LOG_DIRECTORY_PATH=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DSBK_LEAVE_BACKUP_FILE_ON_DISK=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: POLICY_GUID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: JOB_FAMILY_GUID={E696DD82-FEEB-48F3-B3E7-1D01EE5E7B89}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: JOB_HISTORY_GUID={627E4838-F0F6-4F4B-A01B-17DA721FD700}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: JOB_INSTANCE_GUID={54AEC5BC-E788-4EBF-91EB-0BBAC5BF86E5}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: JOB_EXECUTION_GUID={627E4838-F0F6-4F4B-A01B-17DA721FD700}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_SET_GUID={00000009-03E8-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: DEVICE_GUID={AEF0DE93-08D2-43F4-B73D-0D354F472B40}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_SET_RETENSION_HOURS=8765808
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: TARGET_MEDIA_TYPE=15
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_ANCESTRY_LOCATIONS=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: IMAGE_LINK_ID = {00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: RECREATE_AD_OBJECTS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_SET_COUNT=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_MAX_SET_COUNT=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_LABEL_KEY=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_LABEL_PREFIX=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_LABEL_SUFFIX=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_LABEL_NEXTNUM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_LABEL_NUMDIGITS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MEDIA_LABEL=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_POINT_IN_TIME_LOWWORD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: REST_ESE_POINT_IN_TIME_HIGHWORD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: B2D_RESERVED_DISKSPACE_MB=10240
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ARCHIVE_JOB_DELETE_PHASE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EVBackupMethod=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EV_SQL_SERVER=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EV_SITENAME=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EVForceDBRestore=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EV_SKIP_RESTORE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: EV_LOG_RECVR_OPTN=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: PDI_BKUP_TEMP_LOCATION=C:\TEMP
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_BACKUP_METHOD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_EXPORT_AS_MONOLITHIC_FILE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_EXPORT_AS_FLAT_DISK=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_VCB_TRANSPORT_MODE=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_USE_MEDIA_SERVER_AS_PROXY=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_VCB_PROXY_SERVER=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_EXPORT_PATH_ON_VCB_PROXY=C:\TEMP
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_RESTORE_RUNNING_VM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_POWER_ON_VM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_RUN_CONVERTER_JOB=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_USE_MEDIA_SERVER_FOR_STAGING=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REMOVE_EXISTING_VCBMOUNTER_SNAPSHOT=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_STAGING_SERVER=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_STAGING_PATH=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_VM_NAME=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_DATACENTER=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_FOLDER=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_HOST=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_DATASTORE=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_NETWORKS=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: ENV: VMWARE_AGENT_REDIRECTED_NUMBER_OF_NICS=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_FLAG=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_USE_ORG_DISK_DS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_SERVER_ACCT_ID={00000000-0000-0000-0000-000000000000}
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_REDIRECTED_SERVER=
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_BACKUP_METHOD=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_INCLUDE_VS_CONFIG=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_EXCLUDE_RUNNING_VMS=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_DO_GRT_BACKUP=1
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_DO_SIS_BACKUP=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_RESTORE_RUNNING_VM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: MSVS_AGENT_POWER_ON_OPTION=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: SNAPSHOT_IGNORE_REASONS=0x0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_CREATE_VERSION_7_VM=0
BEREMOTE: [12/28/09 14:54:26] [2528]     ENV: VMWARE_AGENT_CREATE_THIN_PROVISIONED_DISK=0
BEREMOTE: [12/28/09 14:54:26] [2528]     GetServerType for local machine
BEREMOTE: [12/28/09 14:54:26] [2528]     GetServerType for local machine
BEREMOTE: [12/28/09 14:54:26] [2528]     GetServerType for local machine
BEREMOTE: [12/28/09 14:54:26] [2528]     GetServerType for local machine
BEREMOTE: [12/28/09 14:54:26] [2528]     Finding MNET entries using PunchDownWithWNetCalls()
BEREMOTE: [12/28/09 14:54:26] [0000]     NPGetCaps::WNNC_START
BEREMOTE: [12/28/09 14:54:26] [2528]     Notes Agent:FindDrives
BEREMOTE: [12/28/09 14:54:26] [2528]     No Oracle SID's were discovered
BEREMOTE: [12/28/09 14:54:26] [2528]     GetServerType for local machine
BEREMOTE: [12/28/09 14:54:26] [2528]     Device Shadow?Copy?Components Dle platform 2  major version 5  minor version 2  build 3790
BEREMOTE: [12/28/09 14:54:26] [2528]     No utility partitions found on any of the disks
BEREMOTE: [12/28/09 14:54:26] [2528]     NRDS_RA_FindDrives entered
BEREMOTE: [12/28/09 14:54:26] [2528]     NRDS_RA_FindDrives completed immediately because we aren't browsing
BEREMOTE: [12/28/09 14:54:26] [2528]     Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:696
BEREMOTE: [12/28/09 14:54:26] [2528]     Informational: Cps library not available.  Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:700
BEREMOTE: [12/28/09 14:54:26] [2528]     Function called: DB2_FindDrives
BEREMOTE: [12/28/09 14:54:26] [2528]     Status 0xE0008488 returned calling FindDrives for file system 28 in DLE_UpdateList
BEREMOTE: [12/28/09 14:54:26] [2528]       AD:DeviceName "System?State" in SystemState::CreateDLEs:351
BEREMOTE: [12/28/09 14:54:26] [2528]       AD:Full Device Path "System?State" in SystemState::CreateDLEs:356
BEREMOTE: [12/28/09 14:54:26] [2528]       AD:ADRO Agent is authorized for System?State.
BEREMOTE: [12/28/09 14:54:26] [2528]       AD:Found 0 instances of Active Directory Applcation Mode in SystemState::GetADAMInstanceCount:1355
BEREMOTE: [12/28/09 14:54:26] [2528]     ADC_FindAgents entered
BEREMOTE: [12/28/09 14:54:26] [2528]     ADC_FindAgents completed immediately because we aren't browsing
BEREMOTE: [12/28/09 14:54:26] [2528]     Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_FindDrives - a default SQL Service is installed on FSE1.
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_FindDrives - the default SQL Service appears to be SQL 2000.
BEREMOTE: [12/28/09 14:54:26] [2528]     IsServiceClusterOk called on FSE1
BEREMOTE: [12/28/09 14:54:26] [2528]     Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
BEREMOTE: [12/28/09 14:54:26] [2528]     VCS cluster keys do not appear to be present in the registry
BEREMOTE: [12/28/09 14:54:26] [2528]     Failed to open VCS cluster ()
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_CreateDLE - creating FSE1.
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL Version 2005
BEREMOTE: [12/28/09 14:54:26] [2528]     Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
BEREMOTE: [12/28/09 14:54:26] [2528]     Found SOFTWARE\MICROSOFT\Microsoft SQL Server\MSSQL.1 in the registry.
BEREMOTE: [12/28/09 14:54:26] [2528]          Setting 2K5 extended feature bit.
BEREMOTE: [12/28/09 14:54:26] [2528]     AddESE_DLEs( )
BEREMOTE: [12/28/09 14:54:26] [2528]     AddESE_DLEs for sever name FSE1
BEREMOTE: [12/28/09 14:54:26] [2528]     HrESEBackupRestoreGetRegistered: FSE1, NULL = 0xc7ff07d7
BEREMOTE: [12/28/09 14:54:26] [2528]     ESE_GetBackupAnnotations returned 0xc7ff07d7
BEREMOTE: [12/28/09 14:54:26] [2528]     EV_FindDrives
BEREMOTE: [12/28/09 14:54:26] [2528]     evFileSystem::EV_FindDrives: Agent not authorized.
BEREMOTE: [12/28/09 14:54:26] [2528]     FS_BlowOutMachine: entered -->FSE1<--
BEREMOTE: [12/28/09 14:54:26] [2528]     FS_BlowOutMachine: device already in DLE list
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2: Attempting attach with username ''
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_Connect worked.
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL Agent: Version String { 9.00.1399.06 }
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL edition returned: Standard Edition
BEREMOTE: [12/28/09 14:54:26] [2528]     [no resource for 3893]
BEREMOTE: [12/28/09 14:54:26] [2528]     [no resource for 3894]
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL DBClose
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_CleanUpSnapInfoList called.
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2: Attempting attach with username ''
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_Connect worked.
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL Agent: Version String { 9.00.1399.06 }
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL edition returned: Standard Edition
BEREMOTE: [12/28/09 14:54:26] [2528]     [no resource for 3893]
BEREMOTE: [12/28/09 14:54:26] [2528]     line = "FSE1\*.*",v0,t0,l0,n0,f0
BEREMOTE: [12/28/09 14:54:26] [2528]     dir  =
BEREMOTE: [12/28/09 14:54:26] [2528]     file = *.*
BEREMOTE: [12/28/09 14:54:26] [2528]     oper = Include
BEREMOTE: [12/28/09 14:54:26] [2528]     subs = False
BEREMOTE: [12/28/09 14:54:26] [2528]     wild = True
BEREMOTE: [12/28/09 14:54:26] [2528]     attr_on_mask = 0
BEREMOTE: [12/28/09 14:54:26] [2528]     attr_off_mask = 0
BEREMOTE: [12/28/09 14:54:26] [2528]     AddFsExcludes:
BEREMOTE: [12/28/09 14:54:26] [2528]     BSD for FSE1
BEREMOTE: [12/28/09 14:54:26] [2528]       + \*.*
BEREMOTE: [12/28/09 14:54:26] [2528]     BSD for FSE1
BEREMOTE: [12/28/09 14:54:26] [2528]       + \*.*
BEREMOTE: [12/28/09 14:54:26] [2528]     [no resource for 3894]
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL DBClose
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_CleanUpSnapInfoList called.
BEREMOTE: [12/28/09 14:54:26] [2528]     Backup Job Start - Mon Dec 28 14:54:26 2009
BENGINE:  [12/28/09 14:54:26] [3656]     

    dataStartBackup: ndmpSendRequest returned: 0x0, 0
BEREMOTE: [12/28/09 14:54:26] [2528]     Added the media server FSE1 to the advertisement list.
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2: Attempting attach with username ''
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_Connect worked.
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL Agent: Version String { 9.00.1399.06 }
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL edition returned: Standard Edition
BEREMOTE: [12/28/09 14:54:26] [2528]     [no resource for 3893]
BEREMOTE: [12/28/09 14:54:26] [2528]     TF_OpenTape()
BEREMOTE: [12/28/09 14:54:26] [2528]     TF_GetDriveContext ...
BEREMOTE: [12/28/09 14:54:26] [2528]     TF_GetDriveContext returning 0x00000000, context = 5020050
BEREMOTE: [12/28/09 14:54:26] [2528]     Shared Buffers Connection type prepared...
BEREMOTE: [12/28/09 14:54:26] [2528]     Allocated 10 buffers, size 32768 bytes, total used: 328520
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_DoCommand refusing delegation request.
BEREMOTE: [12/28/09 14:54:26] [2528]     TF_OpenSet()
BEREMOTE: [12/28/09 14:54:26] [2528]     SetupFormatEnv( fmt=0 )
BEREMOTE: [12/28/09 14:54:26] [2528]     End of TF_OpenSet() ret_val = 0x00000000, num buffers = 10
BEREMOTE: [12/28/09 14:54:26] [2528]     Going to perform pre backup dbcc.
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2: Attempting attach with username ''
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_Connect worked.
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL Agent: Version String { 9.00.1399.06 }
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL edition returned: Standard Edition
BEREMOTE: [12/28/09 14:54:26] [2528]     [no resource for 3893]
BENGINE:  [12/28/09 14:54:26] [3656]     ** Starting SQL DBCC **
BEREMOTE: [12/28/09 14:54:26] [2528]     Returning BEDB
BEREMOTE: [12/28/09 14:54:26] [2528]     SQL2_StartCommand = DBCC CHECKDB([BEDB])
BESERVER: [12/28/09 14:54:29] [1080]     17 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
BEREMOTE: [12/28/09 14:54:30] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([BEDB])
BEREMOTE: [12/28/09 14:54:32] [2528]     Returning FSEGoldmine
BEREMOTE: [12/28/09 14:54:32] [2528]     SQL2_StartCommand = DBCC CHECKDB([FSEGoldmine])
BEREMOTE: [12/28/09 14:54:51] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([FSEGoldmine])
BEREMOTE: [12/28/09 14:54:54] [2528]     Returning FSEsmeadlink
BEREMOTE: [12/28/09 14:54:54] [2528]     SQL2_StartCommand = DBCC CHECKDB([FSEsmeadlink])
BEREMOTE: [12/28/09 14:54:57] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([FSEsmeadlink])
BEREMOTE: [12/28/09 14:54:59] [2528]     Returning FSETigerPaw
BEREMOTE: [12/28/09 14:54:59] [2528]     SQL2_StartCommand = DBCC CHECKDB([FSETigerPaw])
BEREMOTE: [12/28/09 14:55:10] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([FSETigerPaw])
BEREMOTE: [12/28/09 14:55:12] [2528]     Returning master
BEREMOTE: [12/28/09 14:55:12] [2528]     SQL2_StartCommand = DBCC CHECKDB([master])
BEREMOTE: [12/28/09 14:55:14] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([master])
BEREMOTE: [12/28/09 14:55:16] [2528]     Returning model
BEREMOTE: [12/28/09 14:55:16] [2528]     SQL2_StartCommand = DBCC CHECKDB([model])
BEREMOTE: [12/28/09 14:55:18] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([model])
BEREMOTE: [12/28/09 14:55:19] [2528]     Returning msdb
BEREMOTE: [12/28/09 14:55:19] [2528]     SQL2_StartCommand = DBCC CHECKDB([msdb])
BEREMOTE: [12/28/09 14:55:21] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([msdb])
BEREMOTE: [12/28/09 14:55:22] [2528]     Returning ReportServer
BEREMOTE: [12/28/09 14:55:22] [2528]     SQL2_StartCommand = DBCC CHECKDB([ReportServer])
BEREMOTE: [12/28/09 14:55:24] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([ReportServer])
BEREMOTE: [12/28/09 14:55:26] [2528]     Returning ReportServerTempDB
BEREMOTE: [12/28/09 14:55:26] [2528]     SQL2_StartCommand = DBCC CHECKDB([ReportServerTempDB])
BEREMOTE: [12/28/09 14:55:27] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([ReportServerTempDB])
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning BEDB
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning FSEGoldmine
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning FSEsmeadlink
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning FSETigerPaw
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning msdb
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning ReportServer
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning ReportServerTempDB
BEREMOTE: [12/28/09 14:55:29] [2528]     [no resource for 3894]
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL DBClose
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL2_CleanUpSnapInfoList called.
BENGINE:  [12/28/09 14:55:29] [3656]     ** Stopping SQL DBCC **
BEREMOTE: [12/28/09 14:55:29] [2528]     Windows Server 2003 (or higher) detected. No S2LP mapping required.
BESERVER: [12/28/09 14:55:29] [2464]     "Cluster" key does not appear to be present in the registry
BESERVER: [12/28/09 14:55:29] [2464]     Failed to open Microsoft cluster ()
BESERVER: [12/28/09 14:55:29] [2464]     VCS cluster keys do not appear to be present in the registry
BESERVER: [12/28/09 14:55:29] [2464]     Failed to open VCS cluster ()
BESERVER: [12/28/09 14:55:29] [2464]     12 AdammAdminBO::Get() - Parent = NULL , Entity = MEDIA
PVLSVR:   [12/28/09 14:55:29] [3312]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            EntityGuid = {4D255A8F-B8EE-4647-8A11-6A6023BD3AF9}

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [12/28/09 14:55:29] [3312]     PvlEntityDatabase::QueryEntity() : SUCCESS!
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning BEDB
BESERVER: [12/28/09 14:55:29] [2464]     12 AdammAdminBO::Get() - hr = 0x0
BEREMOTE: [12/28/09 14:55:29] [2528]     Using the Virtual Device mechanism for the backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Open Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Buffer Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check.
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check: Latest DLL registered.
BEREMOTE: [12/28/09 14:55:29] [2528]     Error calling CoCreateInstance: x8007007E
BEREMOTE: [12/28/09 14:55:29] [2528]     Failed the Virtual Device allocation for backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     Destroying VirtualDeviceSet
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational, no operation thread handle to close.
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational - cannot deallocate Virtual Device object.
BEREMOTE: [12/28/09 14:55:29] [2528]     LP_ENV::MsgError: error 0xe00084af processing object \BEDB
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning FSEGoldmine
BEREMOTE: [12/28/09 14:55:29] [2528]     Using the Virtual Device mechanism for the backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Open Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Buffer Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check.
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check: Latest DLL registered.
BEREMOTE: [12/28/09 14:55:29] [2528]     Error calling CoCreateInstance: x8007007E
BEREMOTE: [12/28/09 14:55:29] [2528]     Failed the Virtual Device allocation for backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     Destroying VirtualDeviceSet
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational, no operation thread handle to close.
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational - cannot deallocate Virtual Device object.
BEREMOTE: [12/28/09 14:55:29] [2528]     LP_ENV::MsgError: error 0xe00084af processing object \FSEGoldmine
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning FSEsmeadlink
BEREMOTE: [12/28/09 14:55:29] [2528]     Using the Virtual Device mechanism for the backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Open Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Buffer Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check.
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check: Latest DLL registered.
BEREMOTE: [12/28/09 14:55:29] [2528]     Error calling CoCreateInstance: x8007007E
BEREMOTE: [12/28/09 14:55:29] [2528]     Failed the Virtual Device allocation for backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     Destroying VirtualDeviceSet
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational, no operation thread handle to close.
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational - cannot deallocate Virtual Device object.
BEREMOTE: [12/28/09 14:55:29] [2528]     LP_ENV::MsgError: error 0xe00084af processing object \FSEsmeadlink
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning FSETigerPaw
BEREMOTE: [12/28/09 14:55:29] [2528]     Using the Virtual Device mechanism for the backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Open Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Buffer Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check.
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check: Latest DLL registered.
BEREMOTE: [12/28/09 14:55:29] [2528]     Error calling CoCreateInstance: x8007007E
BEREMOTE: [12/28/09 14:55:29] [2528]     Failed the Virtual Device allocation for backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     Destroying VirtualDeviceSet
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational, no operation thread handle to close.
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational - cannot deallocate Virtual Device object.
BEREMOTE: [12/28/09 14:55:29] [2528]     LP_ENV::MsgError: error 0xe00084af processing object \FSETigerPaw
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning master
BEREMOTE: [12/28/09 14:55:29] [2528]     Using the Virtual Device mechanism for the backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Open Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Buffer Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check.
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check: Latest DLL registered.
BEREMOTE: [12/28/09 14:55:29] [2528]     Error calling CoCreateInstance: x8007007E
BEREMOTE: [12/28/09 14:55:29] [2528]     Failed the Virtual Device allocation for backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     Destroying VirtualDeviceSet
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational, no operation thread handle to close.
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational - cannot deallocate Virtual Device object.
BEREMOTE: [12/28/09 14:55:29] [2528]     LP_ENV::MsgError: error 0xe00084af processing object \master
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning model
BEREMOTE: [12/28/09 14:55:29] [2528]     Using the Virtual Device mechanism for the backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Open Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Buffer Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check.
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check: Latest DLL registered.
BEREMOTE: [12/28/09 14:55:29] [2528]     Error calling CoCreateInstance: x8007007E
BEREMOTE: [12/28/09 14:55:29] [2528]     Failed the Virtual Device allocation for backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     Destroying VirtualDeviceSet
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational, no operation thread handle to close.
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational - cannot deallocate Virtual Device object.
BEREMOTE: [12/28/09 14:55:29] [2528]     LP_ENV::MsgError: error 0xe00084af processing object \model
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning msdb
BEREMOTE: [12/28/09 14:55:29] [2528]     Using the Virtual Device mechanism for the backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Open Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Buffer Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check.
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check: Latest DLL registered.
BEREMOTE: [12/28/09 14:55:29] [2528]     Error calling CoCreateInstance: x8007007E
BEREMOTE: [12/28/09 14:55:29] [2528]     Failed the Virtual Device allocation for backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     Destroying VirtualDeviceSet
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational, no operation thread handle to close.
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational - cannot deallocate Virtual Device object.
BEREMOTE: [12/28/09 14:55:29] [2528]     LP_ENV::MsgError: error 0xe00084af processing object \msdb
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning ReportServer
BEREMOTE: [12/28/09 14:55:29] [2528]     Using the Virtual Device mechanism for the backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Open Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Buffer Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check.
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check: Latest DLL registered.
BEREMOTE: [12/28/09 14:55:29] [2528]     Error calling CoCreateInstance: x8007007E
BEREMOTE: [12/28/09 14:55:29] [2528]     Failed the Virtual Device allocation for backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     Destroying VirtualDeviceSet
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational, no operation thread handle to close.
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational - cannot deallocate Virtual Device object.
BEREMOTE: [12/28/09 14:55:29] [2528]     LP_ENV::MsgError: error 0xe00084af processing object \ReportServer
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning ReportServerTempDB
BEREMOTE: [12/28/09 14:55:29] [2528]     Using the Virtual Device mechanism for the backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Open Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     VDI Buffer Timeout set to INFINITE
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check.
BEREMOTE: [12/28/09 14:55:29] [2528]     SQL Agent VDI Check: Latest DLL registered.
BEREMOTE: [12/28/09 14:55:29] [2528]     Error calling CoCreateInstance: x8007007E
BEREMOTE: [12/28/09 14:55:29] [2528]     Failed the Virtual Device allocation for backup operation.
BEREMOTE: [12/28/09 14:55:29] [2528]     Destroying VirtualDeviceSet
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational, no operation thread handle to close.
BEREMOTE: [12/28/09 14:55:29] [2528]     Informational - cannot deallocate Virtual Device object.
BEREMOTE: [12/28/09 14:55:29] [2528]     LP_ENV::MsgError: error 0xe00084af processing object \ReportServerTempDB
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning BEDB
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning FSEGoldmine
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning FSEsmeadlink
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning FSETigerPaw
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning msdb
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning ReportServer
BEREMOTE: [12/28/09 14:55:29] [2528]     Returning ReportServerTempDB
BEREMOTE: [12/28/09 14:55:29] [2528]     TF xfer time = 0 seconds.
BEREMOTE: [12/28/09 14:55:29] [2528]     WRITE:  tpreceive_fail_count = 0
BEREMOTE: [12/28/09 14:55:29] [2528]     WRITE:  waiting_on_buffers_count = 0
BEREMOTE: [12/28/09 14:55:29] [2528]     WRITE:  buffers_written_count = 0
BENGINE:  [12/28/09 14:55:29] [3656]     TF_NDMPStartWrite(): Started LocalMediaServerWriteThread 992
PVLSVR:   [12/28/09 14:55:30] [5452]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            EntityGuid = {4D255A8F-B8EE-4647-8A11-6A6023BD3AF9}

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [12/28/09 14:55:30] [5452]     PvlEntityDatabase::QueryEntity() : SUCCESS!
PVLSVR:   [12/28/09 14:55:30] [3312]     PvlEntityDatabase::UpdateEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            Media = {4D255A8F-B8EE-4647-8A11-6A6023BD3AF9}, "B2D000004"

            EntityFlags = 0x00830000
PVLSVR:   [12/28/09 14:55:30] [3312]     PvlEntityDatabase::UpdateEntity() : SUCCESS!
BENGINE:  [12/28/09 14:55:30] [0992]     WriteEndSet( 1 ) returning 0x00000000
BEREMOTE: [12/28/09 14:55:30] [2528]     TF_CloseSet()
BEREMOTE: [12/28/09 14:55:30] [2528]     FreeFormatEnv( cur_fmt=0 )
BEREMOTE: [12/28/09 14:55:30] [2528]     Going to perform post backup dbcc.
BEREMOTE: [12/28/09 14:55:30] [2528]     SQL2: Attempting attach with username ''
BEREMOTE: [12/28/09 14:55:30] [2528]     SQL2_Connect worked.
BEREMOTE: [12/28/09 14:55:30] [2528]     SQL Agent: Version String { 9.00.1399.06 }
BEREMOTE: [12/28/09 14:55:30] [2528]     SQL edition returned: Standard Edition
BEREMOTE: [12/28/09 14:55:30] [2528]     [no resource for 3893]
BENGINE:  [12/28/09 14:55:30] [3656]     ** Starting SQL DBCC **
BEREMOTE: [12/28/09 14:55:30] [2528]     Returning BEDB
BEREMOTE: [12/28/09 14:55:30] [2528]     SQL2_StartCommand = DBCC CHECKDB([BEDB])
BENGINE:  [12/28/09 14:55:31] [0992]     WriteEndSet( 1 ) returning 0x00000000
BENGINE:  [12/28/09 14:55:31] [0992]     WriteEndSet( 0 ) returning 0x00000000
PVLSVR:   [12/28/09 14:55:31] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            EntityGuid = {4D255A8F-B8EE-4647-8A11-6A6023BD3AF9}

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [12/28/09 14:55:31] [5544]     PvlEntityDatabase::QueryEntity() : SUCCESS!
PVLSVR:   [12/28/09 14:55:31] [5452]     PvlEntityDatabase::UpdateEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            Media = {4D255A8F-B8EE-4647-8A11-6A6023BD3AF9}, "B2D000004"

            EntityFlags = 0x00830000
PVLSVR:   [12/28/09 14:55:31] [5452]     PvlEntityDatabase::UpdateEntity() : SUCCESS!
BENGINE:  [12/28/09 14:55:31] [0992]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:55:31] [0992]       ret_val = 0
BENGINE:  [12/28/09 14:55:31] [0992]     Requested Set: ID = ffffffff Seq = -1 Set = -1
BENGINE:  [12/28/09 14:55:31] [0992]     PositionAtSet( :( TF Msg = 4
BENGINE:  [12/28/09 14:55:31] [0992]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:55:31] [0992]       ret_val = 0
BENGINE:  [12/28/09 14:55:31] [0992]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:55:31] [0992]     TAPEALERT: TapeAlert Device Flag  = 0X0
BENGINE:  [12/28/09 14:55:31] [0992]     TAPEALERT: TapeAlert Changer Flag = 0X0
BENGINE:  [12/28/09 14:55:31] [0992]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:55:31] [0992]     Entering TF_MountNewMedia ... (baseChannel = 02FFA240)
PVLSVR:   [12/28/09 14:55:31] [5544]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
BENGINE:  [12/28/09 14:55:31] [0992]     TF_MountNewMedia:  mediaId == NULL
PVLSVR:   [12/28/09 14:55:31] [5452]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_MOUNT_CONTINUATION )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
PVLSVR:   [12/28/09 14:55:31] [5452]     AdammSession::CheckTargetDeviceStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Job = {54AEC5BC-E788-4EBF-91EB-0BBAC5BF86E5}, "SQL"

            TargetDevice = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

                State = 0003, ReservationID = 0000, AvailableMovers = 0000
PVLSVR:   [12/28/09 14:55:31] [5452]     AdammSession::MountOverwriteMedia()
PVLSVR:   [12/28/09 14:55:31] [5452]     AdammSession::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0000

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Media = {4D255A8F-B8EE-4647-8A11-6A6023BD3AF9}, "B2D000004"

            Side = 0001
PVLSVR:   [12/28/09 14:55:31] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 4294967295

            Side = 4294967295
PVLSVR:   [12/28/09 14:55:31] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:55:32] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 4294967295

            Side = 4294967295
PVLSVR:   [12/28/09 14:55:32] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 268369920

            Side = 0001
PVLSVR:   [12/28/09 14:55:32] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 268369920

            Side = 0001
PVLSVR:   [12/28/09 14:55:33] [0000]     EXECUTE: { CALL QueryNextMediaLabel ( ?, ?, ?, ?, ?, ?, ? ) }
BESERVER: [12/28/09 14:55:32] [2464]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [12/28/09 14:55:32] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = DRIVE_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [12/28/09 14:55:33] [2464]     12 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [12/28/09 14:55:33] [2464]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [12/28/09 14:55:33] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [12/28/09 14:55:33] [2464]     12 AdammAdminBO::Execute() - hr = 0x0
PVLSVR:   [12/28/09 14:55:33] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0000

            Side = 0001
PVLSVR:   [12/28/09 14:55:33] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0000

            Side = 0001
PVLSVR:   [12/28/09 14:55:34] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
BENGINE:  [12/28/09 14:55:34] [0372]     Updating status for: 'SQL' (0x1 0x9)
BENGINE:  [12/28/09 14:55:34] [0372]     Status for: 'SQL' updated
PVLSVR:   [12/28/09 14:55:34] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0000

            Side = 0001
PVLSVR:   [12/28/09 14:55:34] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0000

            Side = 0001
PVLSVR:   [12/28/09 14:55:34] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0001

            Side = 0001
PVLSVR:   [12/28/09 14:55:34] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0001

            Side = 0001
PVLSVR:   [12/28/09 14:55:34] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
BESERVER: [12/28/09 14:55:35] [2676]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [12/28/09 14:55:35] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = DRIVE_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [12/28/09 14:55:35] [2676]     12 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [12/28/09 14:55:35] [2676]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [12/28/09 14:55:35] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [12/28/09 14:55:35] [2676]     12 AdammAdminBO::Execute() - hr = 0x0
PVLSVR:   [12/28/09 14:55:35] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0001

            Side = 0001
PVLSVR:   [12/28/09 14:55:35] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0001

            Side = 0001
PVLSVR:   [12/28/09 14:55:35] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0002

            Side = 0001
PVLSVR:   [12/28/09 14:55:35] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0002

            Side = 0001
PVLSVR:   [12/28/09 14:55:35] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
PVLSVR:   [12/28/09 14:55:35] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0002

            Side = 0001
PVLSVR:   [12/28/09 14:55:35] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0002

            Side = 0001
PVLSVR:   [12/28/09 14:55:36] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:55:36] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:55:36] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
PVLSVR:   [12/28/09 14:55:36] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:55:36] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:55:36] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0004

            Side = 0001
PVLSVR:   [12/28/09 14:55:36] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0004

            Side = 0001
PVLSVR:   [12/28/09 14:55:36] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
PVLSVR:   [12/28/09 14:55:36] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0004

            Side = 0001
PVLSVR:   [12/28/09 14:55:37] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0004

            Side = 0001
PVLSVR:   [12/28/09 14:55:37] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0005

            Side = 0001
PVLSVR:   [12/28/09 14:55:37] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0005

            Side = 0001
PVLSVR:   [12/28/09 14:55:37] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
PVLSVR:   [12/28/09 14:55:37] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0005

            Side = 0001
PVLSVR:   [12/28/09 14:55:37] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0005

            Side = 0001
BEREMOTE: [12/28/09 14:55:37] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([BEDB])
PVLSVR:   [12/28/09 14:55:37] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0006

            Side = 0001
PVLSVR:   [12/28/09 14:55:37] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0006

            Side = 0001
PVLSVR:   [12/28/09 14:55:37] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
PVLSVR:   [12/28/09 14:55:38] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0006

            Side = 0001
PVLSVR:   [12/28/09 14:55:38] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0006

            Side = 0001
PVLSVR:   [12/28/09 14:55:38] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0007

            Side = 0001
PVLSVR:   [12/28/09 14:55:38] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0007

            Side = 0001
PVLSVR:   [12/28/09 14:55:38] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
PVLSVR:   [12/28/09 14:55:38] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0007

            Side = 0001
PVLSVR:   [12/28/09 14:55:39] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0007

            Side = 0001
PVLSVR:   [12/28/09 14:55:39] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0008

            Side = 0001
PVLSVR:   [12/28/09 14:55:39] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0008

            Side = 0001
PVLSVR:   [12/28/09 14:55:39] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
PVLSVR:   [12/28/09 14:55:40] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0008

            Side = 0001
PVLSVR:   [12/28/09 14:55:40] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0008

            Side = 0001
PVLSVR:   [12/28/09 14:55:40] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0009

            Side = 0001
PVLSVR:   [12/28/09 14:55:40] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0009

            Side = 0001
PVLSVR:   [12/28/09 14:55:40] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
PVLSVR:   [12/28/09 14:55:41] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0009

            Side = 0001
PVLSVR:   [12/28/09 14:55:41] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0009

            Side = 0001
PVLSVR:   [12/28/09 14:55:41] [5452]     AdammSession::MountOverwriteMedia()
PVLSVR:   [12/28/09 14:55:42] [5452]     AdammSession::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            Slot = 0009

            Side = 0000
PVLSVR:   [12/28/09 14:55:42] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0009

            Side = 0001
PVLSVR:   [12/28/09 14:55:42] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0009

            Side = 0001
BEREMOTE: [12/28/09 14:55:42] [2528]     Returning FSEGoldmine
BESERVER: [12/28/09 14:55:42] [4132]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [12/28/09 14:55:42] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = DRIVE_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
BEREMOTE: [12/28/09 14:55:42] [2528]     SQL2_StartCommand = DBCC CHECKDB([FSEGoldmine])
BESERVER: [12/28/09 14:55:42] [4132]     12 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [12/28/09 14:55:42] [4132]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [12/28/09 14:55:42] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [12/28/09 14:55:42] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
BESERVER: [12/28/09 14:55:42] [4132]     12 AdammAdminBO::Execute() - hr = 0x0
PVLSVR:   [12/28/09 14:55:42] [3932]     23000 - [Microsoft][ODBC SQL Server Driver][SQL Server]The UPDATE statement conflicted with the FOREIGN KEY constraint "Media_MediaType_FKEY". The conflict occurred in database "BEDB", table "dbo.MediaType".
PVLSVR:   [12/28/09 14:55:42] [3932]     UPDATE Media SET MediaType = ?, MediaSubType = ? WHERE ( MediaGuid = ? ) ;
PVLSVR:   [12/28/09 14:55:42] [5452]     PvlDrive::MountMedia() - Establish connection

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"
PVLSVR:   [12/28/09 14:55:42] [5452]     AdammSession::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0000

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Media = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}, "B2D000010"

            Side = 0001

            SUCCESS!
PVLSVR:   [12/28/09 14:55:42] [5452]     AdammSession::IsOverwriteMediaMounted() -

        Need WORM: No

        Need Encryption: No
PVLSVR:   [12/28/09 14:55:42] [5452]     AdammSession::IsOverwriteMediaMounted() - ERROR = 0x00000450 (ERROR_NO_DATA_DETECTED)
PVLSVR:   [12/28/09 14:55:42] [5452]     PvlDrive::WriteMediaHeader()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            Slot = 0009

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            MediaLabel = "B2D000010"

            Media = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}

            MediaHeader =
PVLSVR:   [12/28/09 14:55:44] [5452]     AdammSession::IsOverwriteMediaMounted() -

        Need WORM: No

        Need Encryption: No
PVLSVR:   [12/28/09 14:55:44] [5452]     AdammSession::IsOverwriteMediaMounted() - SUCCESS!
BENGINE:  [12/28/09 14:55:44] [0992]     TF_MountNewMedia:  IsChannelStatus == true. result = 00000000
BENGINE:  [12/28/09 14:55:44] [0992]     TF_MountNewMedia exiting and succeeded!
BENGINE:  [12/28/09 14:55:44] [0992]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:55:44] [0992]     TAPEALERT: TapeAlert Device Flag  = 0X0
BENGINE:  [12/28/09 14:55:44] [0992]     TAPEALERT: TapeAlert Changer Flag = 0X0
BENGINE:  [12/28/09 14:55:44] [0992]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:55:44] [0992]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
PVLSVR:   [12/28/09 14:55:44] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            EntityName = ""

            EntityFlags = 0x00000000
BENGINE:  [12/28/09 14:55:44] [0992]     Updating session {da0edee0-4ca9-4a9b-aa60-2154d0484556} with drive FSE1 {aef0de93-08d2-43f4-b73d-0d354f472b40}.1
BENGINE:  [12/28/09 14:55:44] [0992]     Media Label: B2D000010
BENGINE:  [12/28/09 14:55:44] [0992]     Media Label: {88f398fd-c22d-4eae-a58e-58e730eab1a0}
BESERVER: [12/28/09 14:55:44] [2676]     12 AdammAdminBO::Get() - Parent = NULL , Entity = MEDIA
PVLSVR:   [12/28/09 14:55:44] [5452]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            EntityGuid = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [12/28/09 14:55:44] [5452]     PvlEntityDatabase::QueryEntity() : SUCCESS!
BESERVER: [12/28/09 14:55:44] [2676]     12 AdammAdminBO::Get() - hr = 0x0
BENGINE:  [12/28/09 14:55:44] [0992]     Overwrite Protected Until: 12/30/99 6:00:00 PM
BENGINE:  [12/28/09 14:55:44] [0992]     Appendable Until: 12/30/99 6:00:00 PM
PVLSVR:   [12/28/09 14:55:44] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            EntityName = ""

            EntityFlags = 0x00000000
BENGINE:  [12/28/09 14:55:44] [0992]     Updating session {da0edee0-4ca9-4a9b-aa60-2154d0484556} with drive FSE1 {aef0de93-08d2-43f4-b73d-0d354f472b40}.1
BENGINE:  [12/28/09 14:55:44] [0992]       UI Msg = 8008
BENGINE:  [12/28/09 14:55:44] [0992]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:55:44] [0992]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:55:44] [0992]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:55:44] [0992]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:55:44] [0992]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:55:44] [0992]       ret_val = 0
BENGINE:  [12/28/09 14:55:44] [0992]     Attempting to VCB storage media
BENGINE:  [12/28/09 14:55:44] [0992]       TpRead( :(
BENGINE:  [12/28/09 14:55:44] [0992]     Error = 1101 Req = 6144 Got = 1024
BENGINE:  [12/28/09 14:55:44] [0992]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:55:44] [0992]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:55:44] [0992]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:55:44] [0992]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:55:44] [0992]     FreeFormatEnv( cur_fmt=65535 )
BENGINE:  [12/28/09 14:55:44] [0992]     SetupFormatEnv( fmt=0 )
BENGINE:  [12/28/09 14:55:44] [0992]     Current media tape header was written by "VERITAS:PVL".
BENGINE:  [12/28/09 14:55:44] [0992]       TpRead( :(
BENGINE:  [12/28/09 14:55:44] [0992]     Error = 1104 Req = 6144 Got = 0
BENGINE:  [12/28/09 14:55:44] [0992]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:55:44] [0992]       ret_val = 0
BENGINE:  [12/28/09 14:55:44] [0992]     PositionAtSet( :( TF Msg = e
BENGINE:  [12/28/09 14:55:44] [0992]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:55:44] [0992]       ret_val = 0
BENGINE:  [12/28/09 14:55:44] [0992]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:55:44] [0992]       ret_val = 0
BENGINE:  [12/28/09 14:55:44] [0992]       UI Msg = 8003
BENGINE:  [12/28/09 14:55:44] [0992]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:55:44] [0992]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:55:44] [0992]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:55:44] [0992]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:55:44] [0992]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:55:44] [0992]       ret_val = 0
BENGINE:  [12/28/09 14:55:44] [0992]     FreeFormatEnv( cur_fmt=0 )
BENGINE:  [12/28/09 14:55:44] [0992]     F40_NDMPWriteContSet crossing lba = 2
BENGINE:  [12/28/09 14:55:44] [0992]     B2D Buffered Writes ===> Setting buffering to default.
BENGINE:  [12/28/09 14:55:44] [0992]     WriteEndSet( 1 ) returning 0x00000000
BENGINE:  [12/28/09 14:55:44] [0992]     Current Block is = 3
PVLSVR:   [12/28/09 14:55:44] [3312]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            EntityGuid = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [12/28/09 14:55:44] [3312]     PvlEntityDatabase::QueryEntity() : SUCCESS!
PVLSVR:   [12/28/09 14:55:44] [5544]     PvlEntityDatabase::UpdateEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            Media = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}, "B2D000010"

            EntityFlags = 0x00830000
PVLSVR:   [12/28/09 14:55:45] [5544]     PvlEntityDatabase::UpdateEntity() : SUCCESS!
BENGINE:  [12/28/09 14:55:49] [0372]     Updating status for: 'SQL' (0x1 0x0)
BENGINE:  [12/28/09 14:55:49] [0372]     Status for: 'SQL' updated
BEREMOTE: [12/28/09 14:56:01] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([FSEGoldmine])
BEREMOTE: [12/28/09 14:56:04] [2528]     Returning FSEsmeadlink
BEREMOTE: [12/28/09 14:56:04] [2528]     SQL2_StartCommand = DBCC CHECKDB([FSEsmeadlink])
BEREMOTE: [12/28/09 14:56:07] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([FSEsmeadlink])
BEREMOTE: [12/28/09 14:56:09] [2528]     Returning FSETigerPaw
BEREMOTE: [12/28/09 14:56:09] [2528]     SQL2_StartCommand = DBCC CHECKDB([FSETigerPaw])
BEREMOTE: [12/28/09 14:56:21] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([FSETigerPaw])
BEREMOTE: [12/28/09 14:56:23] [2528]     Returning master
BEREMOTE: [12/28/09 14:56:23] [2528]     SQL2_StartCommand = DBCC CHECKDB([master])
BEREMOTE: [12/28/09 14:56:25] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([master])
BEREMOTE: [12/28/09 14:56:26] [2528]     Returning model
BEREMOTE: [12/28/09 14:56:26] [2528]     SQL2_StartCommand = DBCC CHECKDB([model])
BEREMOTE: [12/28/09 14:56:28] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([model])
BEREMOTE: [12/28/09 14:56:30] [2528]     Returning msdb
BEREMOTE: [12/28/09 14:56:30] [2528]     SQL2_StartCommand = DBCC CHECKDB([msdb])
BEREMOTE: [12/28/09 14:56:32] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([msdb])
BEREMOTE: [12/28/09 14:56:33] [2528]     Returning ReportServer
BEREMOTE: [12/28/09 14:56:33] [2528]     SQL2_StartCommand = DBCC CHECKDB([ReportServer])
BEREMOTE: [12/28/09 14:56:35] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([ReportServer])
BEREMOTE: [12/28/09 14:56:37] [2528]     Returning ReportServerTempDB
BEREMOTE: [12/28/09 14:56:37] [2528]     SQL2_StartCommand = DBCC CHECKDB([ReportServerTempDB])
BEREMOTE: [12/28/09 14:56:38] [2528]     SQL2_StartCommand = DBCC CHECKCATALOG([ReportServerTempDB])
BEREMOTE: [12/28/09 14:56:40] [2528]     Returning BEDB
BEREMOTE: [12/28/09 14:56:40] [2528]     Returning FSEGoldmine
BEREMOTE: [12/28/09 14:56:40] [2528]     Returning FSEsmeadlink
BEREMOTE: [12/28/09 14:56:40] [2528]     Returning FSETigerPaw
BEREMOTE: [12/28/09 14:56:40] [2528]     Returning msdb
BEREMOTE: [12/28/09 14:56:40] [2528]     Returning ReportServer
BEREMOTE: [12/28/09 14:56:40] [2528]     Returning ReportServerTempDB
BEREMOTE: [12/28/09 14:56:40] [2528]     [no resource for 3894]
BEREMOTE: [12/28/09 14:56:40] [2528]     SQL DBClose
BEREMOTE: [12/28/09 14:56:40] [2528]     SQL2_CleanUpSnapInfoList called.
BEREMOTE: [12/28/09 14:56:40] [2528]     [no resource for 3894]
BENGINE:  [12/28/09 14:56:40] [3656]     ** Stopping SQL DBCC **
BEREMOTE: [12/28/09 14:56:40] [2528]     SQL DBClose
BEREMOTE: [12/28/09 14:56:40] [2528]     SQL2_CleanUpSnapInfoList called.
BEREMOTE: [12/28/09 14:56:40] [2528]     TF_FreeDriveContext( 5020050 )
BEREMOTE: [12/28/09 14:56:40] [2528]     TF_FreeTapeBuffers: from 10 to 0 buffers
BEREMOTE: [12/28/09 14:56:40] [2528]     Backup Job Stop(0)  - Mon Dec 28 14:56:40 2009
BENGINE:  [12/28/09 14:56:40] [3656]      data halted: SUCCESSFUL
BENGINE:  [12/28/09 14:56:40] [3656]     BaseBSDProcessor::PollDataServer: Shutting down.
BENGINE:  [12/28/09 14:56:40] [3656]     TF_NDMPGetResult(): MediaServer thread done, returning TFLE 0x00000000
BENGINE:  [12/28/09 14:56:40] [3656]     TF_NDMPProcessOTCEOM crossing lba = 2
BENGINE:  [12/28/09 14:56:40] [3656]     TF_NDMPProcessOTCEOM processing OTC EOM cont vcb lba = 0
BENGINE:  [12/28/09 14:56:40] [3656]     BackupMessageHandler::CloseCatalog called
BENGINE:  [12/28/09 14:56:40] [3656]     Not: 'm_bCatalogDrivenBackup && CatBuildVector[engine_id] && GetCarryFwdCatalogInfoForRemainingObjs( )'
BENGINE:  [12/28/09 14:56:40] [3656]     called CatBuildVector[engine_id]->GetErrorCondition() successfully
BENGINE:  [12/28/09 14:56:40] [3656]     BackupMessageHandler::CDB_EndCurrentCatalogOperation(  ) -- entered
BENGINE:  [12/28/09 14:56:40] [3656]     BackupMessageHandler::CDB_EndCurrentCatalogOperation(  ) is calling PerBSDDataVector[engine_id]->EndCatOperation( )
BENGINE:  [12/28/09 14:56:40] [3656]     EndCatOperation succeeded
BENGINE:  [12/28/09 14:56:40] [3656]     BackupMessageHandler::CDB_EndCurrentCatalogOperation(  ) -- returning
BENGINE:  [12/28/09 14:56:40] [3656]     calling CatBuildVector[engine_id]->FinishBackup( ) for non-cat drive backup
BENGINE:  [12/28/09 14:56:41] [3656]     WriteEndSet( 1 ) returning 0x00000000
BENGINE:  [12/28/09 14:56:41] [3656]     WriteEndSet( 1 ) returning 0x00000000
BENGINE:  [12/28/09 14:56:41] [3656]     WriteEndSet( 0 ) returning 0x00000000
PVLSVR:   [12/28/09 14:56:41] [5452]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            EntityGuid = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [12/28/09 14:56:41] [5452]     PvlEntityDatabase::QueryEntity() : SUCCESS!
PVLSVR:   [12/28/09 14:56:41] [3312]     PvlEntityDatabase::UpdateEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            Media = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}, "B2D000010"

            EntityFlags = 0x00830000
PVLSVR:   [12/28/09 14:56:41] [3312]     PvlEntityDatabase::UpdateEntity() : SUCCESS!
BENGINE:  [12/28/09 14:56:41] [3656]     TF_FreeTapeBuffers: from 0 to 0 buffers
BENGINE:  [12/28/09 14:56:42] [3656]     TF_CloseSet
BENGINE:  [12/28/09 14:56:42] [3656]     Enter NDMPSnapHostBackupEngine::TrackSnappedBSD
BENGINE:  [12/28/09 14:56:42] [3656]     Exit NDMPSnapHostBackupEngine::TrackSnappedBSD
BENGINE:  [12/28/09 14:56:42] [3656]     Exit NDMPSnapHostBackupEngine::ProcessBSDs
BENGINE:  [12/28/09 14:56:42] [3656]     NDMPAgentConnector::EndConnection(): Data Server = FSE1
BEREMOTE: [12/28/09 14:56:42] [2528]     @@@@@@@MyCloseSocket called with sockfd = 2208(0x8a0)    retval = 0
PVLSVR:   [12/28/09 14:56:42] [5544]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
PVLSVR:   [12/28/09 14:56:42] [5452]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
BENGINE:  [12/28/09 14:56:42] [3656]     TF_PutChannel( ) 02FFA240
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: TapeAlert Device Flag  = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: TapeAlert Changer Flag = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
PVLSVR:   [12/28/09 14:56:42] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            EntityName = ""

            EntityFlags = 0x00000000
BENGINE:  [12/28/09 14:56:42] [3656]     Updating session {da0edee0-4ca9-4a9b-aa60-2154d0484556} with drive FSE1 {aef0de93-08d2-43f4-b73d-0d354f472b40}.1
BENGINE:  [12/28/09 14:56:42] [3656]     TF_OpenTape()
BENGINE:  [12/28/09 14:56:42] [3656]     TF_GetChannel( ) reusing channel 011FFCF8
BENGINE:  [12/28/09 14:56:42] [3656]     Allocated 10 buffers, size 32768 bytes, total used: 328480
BENGINE:  [12/28/09 14:56:42] [3656]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:56:42] [3656]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:56:42] [3656]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:56:42] [3656]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:56:42] [3656]     TF_OpenSet( )
BENGINE:  [12/28/09 14:56:42] [3656]     Requested Set: ID = 3b9c6a70 Seq = 1 Set = 2
BENGINE:  [12/28/09 14:56:42] [3656]     Current VCB: ID = 3b9c6a70  Seq = 2  Set = 2
BENGINE:  [12/28/09 14:56:42] [3656]     PositionAtSet( :( TF Msg = 9
BENGINE:  [12/28/09 14:56:42] [3656]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:56:42] [3656]       ret_val = 0
BENGINE:  [12/28/09 14:56:42] [3656]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:56:42] [3656]       ret_val = 0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: TapeAlert Device Flag  = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: TapeAlert Changer Flag = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     Entering TF_MountNewMedia ... (baseChannel = 011FFCF8)
PVLSVR:   [12/28/09 14:56:42] [3312]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
PVLSVR:   [12/28/09 14:56:42] [5544]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_MOUNT_SPECIFIC )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
PVLSVR:   [12/28/09 14:56:42] [5544]     AdammSession::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0000

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Media = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}, "B2D000010"

            Side = 0001
PVLSVR:   [12/28/09 14:56:42] [5544]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 4294967295

            Side = 4294967295
PVLSVR:   [12/28/09 14:56:42] [5544]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0009

            Side = 0001
PVLSVR:   [12/28/09 14:56:42] [5544]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_DEVICE_GUID )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            TargetDevice = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1" (Backup To Disk)
PVLSVR:   [12/28/09 14:56:42] [5544]     AdammSession::CheckTargetDeviceStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Job = {54AEC5BC-E788-4EBF-91EB-0BBAC5BF86E5}, "SQL"

            TargetDevice = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

                State = 0003, ReservationID = 0000, AvailableMovers = 0001
PVLSVR:   [12/28/09 14:56:42] [5544]     AdammSession::MountSpecificMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Media = {4D255A8F-B8EE-4647-8A11-6A6023BD3AF9}, "B2D000004"

            Location = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            LocationIndex = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:56:42] [5544]     AdammSession::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            Slot = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:56:42] [5544]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:56:42] [5544]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:56:42] [5544]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
PVLSVR:   [12/28/09 14:56:42] [5544]     PvlDrive::MountMedia() - Establish connection

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"
PVLSVR:   [12/28/09 14:56:42] [5544]     AdammSession::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0000

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Media = {4D255A8F-B8EE-4647-8A11-6A6023BD3AF9}, "B2D000004"

            Side = 0001

            SUCCESS!
BENGINE:  [12/28/09 14:56:42] [3656]     TF_MountNewMedia: PVL_SPECIFIC_MOUNT. result = 00000000
BENGINE:  [12/28/09 14:56:42] [3656]     TF_MountNewMedia exiting and succeeded!
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: TapeAlert Device Flag  = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: TapeAlert Changer Flag = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
PVLSVR:   [12/28/09 14:56:42] [3312]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            EntityName = ""

            EntityFlags = 0x00000000
BENGINE:  [12/28/09 14:56:42] [3656]     Updating session {da0edee0-4ca9-4a9b-aa60-2154d0484556} with drive FSE1 {aef0de93-08d2-43f4-b73d-0d354f472b40}.1
BENGINE:  [12/28/09 14:56:42] [3656]     Media Label: B2D000004
BENGINE:  [12/28/09 14:56:42] [3656]     Media Label: {4d255a8f-b8ee-4647-8a11-6a6023bd3af9}
BESERVER: [12/28/09 14:56:42] [5300]     "Cluster" key does not appear to be present in the registry
BESERVER: [12/28/09 14:56:42] [5300]     Failed to open Microsoft cluster ()
BESERVER: [12/28/09 14:56:42] [5300]     VCS cluster keys do not appear to be present in the registry
BESERVER: [12/28/09 14:56:42] [5300]     Failed to open VCS cluster ()
BESERVER: [12/28/09 14:56:42] [5300]     12 AdammAdminBO::Get() - Parent = NULL , Entity = MEDIA
PVLSVR:   [12/28/09 14:56:42] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            EntityGuid = {4D255A8F-B8EE-4647-8A11-6A6023BD3AF9}

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [12/28/09 14:56:42] [5544]     PvlEntityDatabase::QueryEntity() : SUCCESS!
BESERVER: [12/28/09 14:56:42] [5300]     12 AdammAdminBO::Get() - hr = 0x0
BENGINE:  [12/28/09 14:56:42] [3656]     Overwrite Protected Until: 12/30/99 6:00:00 PM
BENGINE:  [12/28/09 14:56:42] [3656]     Appendable Until: 12/30/99 6:00:00 PM
BENGINE:  [12/28/09 14:56:42] [3656]       UI Msg = 8008
BENGINE:  [12/28/09 14:56:42] [3656]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:56:42] [3656]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:56:42] [3656]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:56:42] [3656]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:56:42] [3656]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:56:42] [3656]       ret_val = 0
BENGINE:  [12/28/09 14:56:42] [3656]     Attempting to VCB storage media
BENGINE:  [12/28/09 14:56:42] [3656]       TpRead( :(
BENGINE:  [12/28/09 14:56:42] [3656]     Error = 1101 Req = 32768 Got = 1024
BENGINE:  [12/28/09 14:56:42] [3656]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:56:42] [3656]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:56:42] [3656]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:56:42] [3656]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:56:42] [3656]     Current media tape header was written by "Symantec Backup Exec 12.5.2213".
BENGINE:  [12/28/09 14:56:42] [3656]       TpRead( :(
BENGINE:  [12/28/09 14:56:42] [3656]     Error = 1101 Req = 32768 Got = 2048
BENGINE:  [12/28/09 14:56:42] [3656]     ReadThisSet( cur_fmt=0 )
BENGINE:  [12/28/09 14:56:42] [3656]     Set 1 was written by version 12.5.
BENGINE:  [12/28/09 14:56:42] [3656]     ReadThisSet() return=0x00000000
BENGINE:  [12/28/09 14:56:42] [3656]     Current VCB: ID = 3b9c6a70  Seq = 1  Set = 1
BENGINE:  [12/28/09 14:56:42] [3656]     End of TF_OpenSet: Ret_val = 0x00000000 Buffs = 10 HiWater = 7
BENGINE:  [12/28/09 14:56:42] [3656]     GotoBlock: VCB_PBA = 16, VCB_LBA = 0, LBA = 0,
BENGINE:  [12/28/09 14:56:42] [3656]                PBA = 16, offset = 0
BENGINE:  [12/28/09 14:56:42] [3656]     Device Error = 1101
BENGINE:  [12/28/09 14:56:42] [3656]     Len Req = 32768 Len Got = 2048
BENGINE:  [12/28/09 14:56:42] [3656]     Set 2 was written by version 12.5.
BENGINE:  [12/28/09 14:56:42] [3656]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:56:42] [3656]       ret_val = 0
BENGINE:  [12/28/09 14:56:42] [3656]     Requested Set: ID = 3b9c6a70 Seq = 2 Set = 2
BENGINE:  [12/28/09 14:56:42] [3656]     PositionAtSet( :( TF Msg = 4
BENGINE:  [12/28/09 14:56:42] [3656]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:56:42] [3656]       ret_val = 0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: TapeAlert Device Flag  = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: TapeAlert Changer Flag = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:56:42] [3656]     Entering TF_MountNewMedia ... (baseChannel = 011FFCF8)
PVLSVR:   [12/28/09 14:56:42] [5544]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
PVLSVR:   [12/28/09 14:56:42] [5452]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_MOUNT_SPECIFIC )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
PVLSVR:   [12/28/09 14:56:42] [5452]     AdammSession::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0000

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Media = {4D255A8F-B8EE-4647-8A11-6A6023BD3AF9}, "B2D000004"

            Side = 0001
PVLSVR:   [12/28/09 14:56:42] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 4294967295

            Side = 4294967295
PVLSVR:   [12/28/09 14:56:42] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0003

            Side = 0001
PVLSVR:   [12/28/09 14:56:42] [5452]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_DEVICE_GUID )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            TargetDevice = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1" (Backup To Disk)
PVLSVR:   [12/28/09 14:56:42] [5452]     AdammSession::CheckTargetDeviceStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Job = {54AEC5BC-E788-4EBF-91EB-0BBAC5BF86E5}, "SQL"

            TargetDevice = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

                State = 0003, ReservationID = 0000, AvailableMovers = 0001
PVLSVR:   [12/28/09 14:56:42] [5452]     AdammSession::MountSpecificMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Media = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}, "B2D000010"

            Location = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            LocationIndex = 0009

            Side = 0001
PVLSVR:   [12/28/09 14:56:43] [5452]     AdammSession::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            Slot = 0009

            Side = 0001
PVLSVR:   [12/28/09 14:56:43] [5452]     PvlDrive::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0009

            Side = 0001
PVLSVR:   [12/28/09 14:56:43] [5452]     PvlChanger::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0009

            Side = 0001
PVLSVR:   [12/28/09 14:56:43] [5452]     PvlDrive::GetMediaStatus()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
PVLSVR:   [12/28/09 14:56:43] [5452]     PvlDrive::MountMedia() - Establish connection

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"
PVLSVR:   [12/28/09 14:56:43] [5452]     AdammSession::MountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0000

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Media = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}, "B2D000010"

            Side = 0001

            SUCCESS!
BENGINE:  [12/28/09 14:56:43] [3656]     TF_MountNewMedia: PVL_SPECIFIC_MOUNT. result = 00000000
BENGINE:  [12/28/09 14:56:43] [3656]     TF_MountNewMedia exiting and succeeded!
BENGINE:  [12/28/09 14:56:43] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:56:43] [3656]     TAPEALERT: TapeAlert Device Flag  = 0X0
BENGINE:  [12/28/09 14:56:43] [3656]     TAPEALERT: TapeAlert Changer Flag = 0X0
BENGINE:  [12/28/09 14:56:43] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [12/28/09 14:56:43] [3656]     TAPEALERT: Get TapeAlert Flags Return Code = 0X0
PVLSVR:   [12/28/09 14:56:43] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            EntityName = ""

            EntityFlags = 0x00000000
BENGINE:  [12/28/09 14:56:43] [3656]     Updating session {da0edee0-4ca9-4a9b-aa60-2154d0484556} with drive FSE1 {aef0de93-08d2-43f4-b73d-0d354f472b40}.1
BENGINE:  [12/28/09 14:56:43] [3656]     Media Label: B2D000010
BENGINE:  [12/28/09 14:56:43] [3656]     Media Label: {88f398fd-c22d-4eae-a58e-58e730eab1a0}
BESERVER: [12/28/09 14:56:43] [2464]     12 AdammAdminBO::Get() - Parent = NULL , Entity = MEDIA
PVLSVR:   [12/28/09 14:56:43] [5452]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            EntityGuid = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [12/28/09 14:56:43] [5452]     PvlEntityDatabase::QueryEntity() : SUCCESS!
BESERVER: [12/28/09 14:56:43] [2464]     12 AdammAdminBO::Get() - hr = 0x0
BENGINE:  [12/28/09 14:56:43] [3656]     Overwrite Protected Until: 12/30/99 6:00:00 PM
BENGINE:  [12/28/09 14:56:43] [3656]     Appendable Until: 12/30/99 6:00:00 PM
BENGINE:  [12/28/09 14:56:43] [3656]       UI Msg = 8008
BENGINE:  [12/28/09 14:56:43] [3656]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:56:43] [3656]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:56:43] [3656]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:56:43] [3656]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:56:43] [3656]     RewindDrive mover ret = 0 (0x0)
BENGINE:  [12/28/09 14:56:43] [3656]       ret_val = 0
BENGINE:  [12/28/09 14:56:43] [3656]     Attempting to VCB storage media
BENGINE:  [12/28/09 14:56:43] [3656]       TpRead( :(
BENGINE:  [12/28/09 14:56:43] [3656]     Error = 1101 Req = 32768 Got = 1024
BENGINE:  [12/28/09 14:56:43] [3656]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:56:43] [3656]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:56:43] [3656]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:56:43] [3656]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:56:43] [3656]     Current media tape header was written by "Symantec Backup Exec 12.5.2213".
BENGINE:  [12/28/09 14:56:43] [3656]       TpRead( :(
BENGINE:  [12/28/09 14:56:43] [3656]     Error = 1101 Req = 32768 Got = 2048
BENGINE:  [12/28/09 14:56:43] [3656]     ReadThisSet( cur_fmt=0 )
BENGINE:  [12/28/09 14:56:43] [3656]     Set 2 was written by version 12.5.
BENGINE:  [12/28/09 14:56:43] [3656]     ReadThisSet() return=0x00000000
BENGINE:  [12/28/09 14:56:43] [3656]     Current VCB: ID = 3b9c6a70  Seq = 2  Set = 2
BENGINE:  [12/28/09 14:56:43] [3656]     PositionAtSet( :( TF Msg = 8
BENGINE:  [12/28/09 14:56:43] [3656]       UI Msg = 8002
BENGINE:  [12/28/09 14:56:43] [3656]     HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [12/28/09 14:56:43] [3656]     HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [12/28/09 14:56:43] [3656]     GET_DRV_INF: bsize = 1024
BENGINE:  [12/28/09 14:56:43] [3656]     GET_DRV_INF: preferredBlockSize = 1024
BENGINE:  [12/28/09 14:56:43] [3656]     TF xfer time = 0 seconds.
BENGINE:  [12/28/09 14:56:43] [3656]     TF_CloseSet
PVLSVR:   [12/28/09 14:56:43] [5544]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
PVLSVR:   [12/28/09 14:56:43] [5452]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
BENGINE:  [12/28/09 14:56:43] [3656]     TF_PutChannel( ) 011FFCF8
PVLSVR:   [12/28/09 14:56:43] [5544]     PvlEntityDatabase::UpdateEntity()

            ParentEntityType = NULL_ENTITY_TYPE

            ParentEntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityType = MEDIA_ENTITY_TYPE

            Media = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}, ""

            EntityFlags = 0x008C0000
PVLSVR:   [12/28/09 14:56:43] [5544]     PvlEntityDatabase::UpdateEntity() : SUCCESS!
BENGINE:  [12/28/09 14:56:43] [3656]     TF_FreeDriveContext( 2FCBF30 )
BENGINE:  [12/28/09 14:56:43] [3656]     TF_FreeTapeBuffers: from 10 to 0 buffers
BENGINE:  [12/28/09 14:56:43] [3656]     FreeFormatEnv( cur_fmt=0 )
PVLSVR:   [12/28/09 14:56:43] [5452]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_DISMOUNT )

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Flags = 0x00000030
PVLSVR:   [12/28/09 14:56:43] [5452]     AdammSession::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0000

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Media = {88F398FD-C22D-4EAE-A58E-58E730EAB1A0}, "B2D000010"

            Side = 0001
PVLSVR:   [12/28/09 14:56:43] [5452]     PvlDrive::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 4294967295

            Side = 4294967295
PVLSVR:   [12/28/09 14:56:43] [5452]     PvlDrive::DismountMedia() - Release connection

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"
PVLSVR:   [12/28/09 14:56:43] [5452]     PvlChanger::DismountMedia()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Library = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Drive = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Slot = 0009

            Side = 0001
PVLSVR:   [12/28/09 14:56:43] [5452]     PvlDriveB2D_Removable::DismountFileSystemVolume() = SUCCESS!
PVLSVR:   [12/28/09 14:56:43] [5452]     PvlDevice::SendAlert()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}

            Device = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}, "FSE1"

            Media = ""
PVLSVR:   [12/28/09 14:56:44] [0000]     [5452] 12/28/09 14:56:43 "Cluster" key does not appear to be present in the registry
PVLSVR:   [12/28/09 14:56:44] [0000]     [5452] 12/28/09 14:56:43 Failed to open Microsoft cluster ()
PVLSVR:   [12/28/09 14:56:44] [0000]     [5452] 12/28/09 14:56:43 VCS cluster keys do not appear to be present in the registry
PVLSVR:   [12/28/09 14:56:44] [0000]     [5452] 12/28/09 14:56:43 Failed to open VCS cluster ()
BESERVER: [12/28/09 14:56:43] [2676]     18 Alert Media Remove, Notify: No, EventLog: Yes, Trap: No
BESERVER: [12/28/09 14:56:44] [4132]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [12/28/09 14:56:44] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = DRIVE_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [12/28/09 14:56:44] [4132]     12 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [12/28/09 14:56:44] [4132]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [12/28/09 14:56:44] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [12/28/09 14:56:44] [4132]     12 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [12/28/09 14:57:16] [5860]     20 AutoClearAlerts: end NumClearAlertFrRS=1 NumClearAlert=1
BENGINE:  [12/28/09 14:57:17] [3876]     DeviceManager: dismount event fired
BENGINE:  [12/28/09 14:57:17] [3876]     DeviceManager: processing pending requests
BENGINE:  [12/28/09 14:57:17] [3876]     DeviceManager: going to sleep for 900000 msecs
PVLSVR:   [12/28/09 14:57:17] [5544]     AdammSession::Release()

            Session = {DA0EDEE0-4CA9-4A9B-AA60-2154D0484556}
BENGINE:  [12/28/09 14:57:17] [3656]     Removing 'SQL' from status update list
BENGINE:  [12/28/09 14:57:17] [3656]     Updating status for: 'SQL' (0x18 0x0)
BENGINE:  [12/28/09 14:57:17] [3656]     Status for: 'SQL' updated
BENGINE:  [12/28/09 14:57:17] [3656]     BackupJob::MergeBEVSRJobLogsIfNecessary: No VSR log file found, no merging necessary
BENGINE:  [12/28/09 14:57:17] [3656]     Ending job 'SQL' with succuess status
BESERVER: [12/28/09 14:57:17] [2676]     17 JobManager::HandleEndJob() called
BESERVER: [12/28/09 14:57:17] [4060]     -1 ActiveState::doEndEvent( :( 'SQL'
BENGINE:  [12/28/09 14:57:17] [3656]     Job thread terminating
BESERVER: [12/28/09 14:57:17] [4060]     17 JobManager::DoJobCompletionTasks(SQL): GetFinalJobStatus()=19
BESERVER: [12/28/09 14:57:17] [5300]     01 Server Configuration: Client removed: 10
BESERVER: [12/28/09 14:57:17] [5300]     -1 Client 'FSE1' Disconnected:0x5ef8b60
BESERVER: [12/28/09 14:57:17] [5300]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [12/28/09 14:57:17] [5452]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = DRIVE_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [12/28/09 14:57:17] [5300]     12 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [12/28/09 14:57:17] [5300]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [12/28/09 14:57:17] [5544]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {38EB665F-31A3-490D-9496-C7AB2BE8F07B}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [12/28/09 14:57:17] [5300]     12 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [12/28/09 14:57:17] [5300]     12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = BACKUP_TO_DISK , Entity = MEDIA
PVLSVR:   [12/28/09 14:57:17] [3312]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = BACKUP_TO_DISK_ENTITY_TYPE

            ParentEntityGuid = {AEF0DE93-08D2-43F4-B73D-0D354F472B40}

            EntityType = MEDIA_ENTITY_TYPE

            EntityGuid = {00000000-0000-0000-0000-000000000000}

            EntityName = ""

            EntityFlags = 0x00008400
PVLSVR:   [12/28/09 14:57:17] [3312]     PvlEntityDatabase::QueryEntity() : SUCCESS!
BESERVER: [12/28/09 14:57:17] [5300]     12 AdammAdminBO::Execute() - hr = 0x0
BKUPEXEC: [12/28/09 14:57:17] [0000]     UIVirtualObjectView(VirtualMediaView) Queried Count: 0 items.
BESERVER: [12/28/09 14:57:17] [4060]     18 Alert Job Completed with Exceptions, Notify: No, EventLog: Yes, Trap: No
BKUPEXEC: [12/28/09 14:57:17] [0000]     UIVirtualObjectView(JobHistoryView) Queried 2 items: 0 to 1
BESERVER: [12/28/09 14:57:17] [4060]     -1 ActiveState::doEndEvent( :( CJobManager::DoJobCompletionTasks() returned 0x0
BESERVER: [12/28/09 14:57:19] [1080]     17 JobManager: Sending History Update VSN, count:1.
BKUPEXEC: [12/28/09 14:57:19] [0000]     UIVirtualObjectView(JobHistoryView) Queried 2 items: 0 to 1
BESERVER: [12/28/09 14:57:19] [1080]     17 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR


Dev_T
Level 6
Did you checked the version of beremote.exe on both the servers?

In the mean while I will look into how to attach a file...

SmithP
Level 3
SQL resides on the same machine as the main install of backup exec. its just one instance of SQL Server. there is no remote instance of  backup exec in use.

SmithP
Level 3
any news yet im still having this issue with no resolution yet

SmithP
Level 3
Thanks Dev T this actually did fix it. the syntax in that article is incorrect though it does not have the " around the path location" thanks. 

Dev_T
Level 6
Hello Smith,


Note: The default path of the Sqlvdi.dll file is C:\Program Files\Microsoft SQL Server\80\COM, but the file may be in a different location or more than one file may exist.

Please let me know the exact location of the SQLVDI.DLL so that I can ask Symantec folks to change the same.

thanks.