cancel
Showing results for 
Search instead for 
Did you mean: 

End of media reached on Deduplication media

bjorn_b
Level 6
Partner Accredited Certified

Hi

I'm experiencing the following error in a BE2010 R3 environment running dedup on a physical server

Job ended: Wednesday, July 20, 2011 at 10:28:19 PM
Completed status: Failed
Final error: 0xe00084ea - End of media was reached.
Final error category: Backup Media Errors

For additional information regarding this error refer to link V-79-57344-34026

When I try to backup this server to a normal B2D folder, everything works fine.

The dedup folder properties are set as follows:

 

I have made a log output from the job as well (see bottom of this message)

I have checked on another backup that uses the same media, and that works perfect.

I had a look in the adamm log file, and the onfly thing I found there (of interrest) was a couple of these messages

ERROR = 0xE0008213 (E_CHG_DESTINATION_ELEMENT_FULL) after E_CHG_SOURCE_ELEMENT_EMPTY

Anyone having an idea where to look?

 

backup debug log to follow:

BESERVER: [07/21/11 11:38:22] [6948]     16 JobManager::UpdateJobInstanceData() new task state=22
BESERVER: [07/21/11 11:38:24] [0664]     01 No archive option installed. EV Embedded status defaults to true and not supported version.
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = MACHINE_ENTITY_TYPE

            EntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityName = "

            EntityFlags = 0x00008000
PVLSVR:   [07/21/11 11:38:24] [6976]     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
PVLSVR:   [07/21/11 11:38:24] [6976]     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
PVLSVR:   [07/21/11 11:38:24] [6976]     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
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00008000
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00008000
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_POOL_DRIVE_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00008000
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = LIBRARY_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00008000
BESERVER: [07/21/11 11:38:24] [0664]     "Cluster" key does not appear to be present in the registry
BESERVER: [07/21/11 11:38:24] [0664]     Failed to open Microsoft cluster ()
BESERVER: [07/21/11 11:38:24] [0664]     VCS cluster keys do not appear to be present in the registry
BESERVER: [07/21/11 11:38:24] [0664]     Failed to open VCS cluster ()
BESERVER: [07/21/11 11:38:24] [0664]     05 AdammAdminBO::Get() - Parent = NULL , Entity = OST_SERVER_ENTITY
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = OST_SERVER_ENTITY_TYPE

            EntityGuid = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}

            EntityName = ""

            EntityFlags = 0x00000900
BESERVER: [07/21/11 11:38:24] [0664]     05 AdammAdminBO::Get() - hr = 0x0
BESERVER: [07/21/11 11:38:24] [0664]     05 AdammAdminBO::Get() - Parent = MACHINE , Entity = DEVICE
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

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

            EntityType = DEVICE_ENTITY_TYPE

            EntityGuid = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:24] [0664]     05 AdammAdminBO::Get() - hr = 0x0
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = PDDE_CONFIGURATION_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:24] [0664]     05 AdammAdminBO::Get() - Parent = MACHINE , Entity = DEVICE
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

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

            EntityType = DEVICE_ENTITY_TYPE

            EntityGuid = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:24] [0664]     05 AdammAdminBO::Get() - hr = 0x0
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = PDDE_CONFIGURATION_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:24] [4876]     -1 ActiveState::doDispatch( :( 'client.<fqdn>-Dedup-Dag'
BESERVER: [07/21/11 11:38:24] [4876]     -1 LocalSvr, runTask():{b5815ac2-393b-4c49-9c6c-b7a1fb960315}
BESERVER: [07/21/11 11:38:24] [4876]     -1 BengineWrapper runtask() start
BESERVER: [07/21/11 11:38:24] [4876]     -1 BengineWrapper JobEngine.Open() OK
BESERVER: [07/21/11 11:38:24] [6164]     -1 Client requested key (1311241272).
BESERVER: [07/21/11 11:38:24] [6164]     01 Server Configuration: Client added: 10
BESERVER: [07/21/11 11:38:24] [6164]     -1 Client 'BACKUPSRV' connected('','DOMAIN\administrator'): 0x197d8810
BESERVER: [07/21/11 11:38:24] [0664]     16 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
BENGINE:  [07/21/11 11:38:24] [6968]     [server]             - JobEngine::LaunchJob
BENGINE:  [07/21/11 11:38:24] [6968]     [server]             - RunJobWithGuidAndServer( {B5815AC2-393B-4C49-9C6C-B7A1FB960315}, BACKUPSRV ) = 0
BESERVER: [07/21/11 11:38:24] [4876]     -1 BengineWrapper JobEngine.RunJobWithGuidAndServer() rc=0
BESERVER: [07/21/11 11:38:24] [4876]     -1 JobManager: BengineWrapper RunJob() done
BESERVER: [07/21/11 11:38:24] [4876]     12 LocalSvr, RunTask: EngineHandedJob SUCCESS, jobid:{b5815ac2-393b-4c49-9c6c-b7a1fb960315}.
BENGINE:  [07/21/11 11:38:24] [6636]     [server]             - Thread for job client.<fqdn>-Dedup-Dag ({B5815AC2-393B-4C49-9C6C-B7A1FB960315}) starting
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork enabled 0
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork useAny 0
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork protocol 0
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork subnet ---><---
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork MAC ---><---
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork IPv4 Enabled 0
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork IPv4 subnetAddress 0.0.0.0
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork IPv4 subnetMask 0.0.0.0
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork IPv4 autoObtain 0
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork IPv4 physical
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork selectedProtocol 0
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork InterfaceIndexProtocol 0
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork InterfaceIndex 0
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork subnet <zero>
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork PrefixLength 0
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork ipAddr <zero>
BENGINE:  [07/21/11 11:38:24] [6636]     [ndmp\ndmpclient]    - viaNetwork FallBackOptions 0xF  Protocol Tunnel NIC Subnet
BESERVER: [07/21/11 11:38:24] [6164]     -1 Client requested key (1311241272).
BESERVER: [07/21/11 11:38:24] [6164]     01 Server Configuration: Client added: 11
BESERVER: [07/21/11 11:38:24] [6164]     -1 Client 'BACKUPSRV' connected('','DOMAIN\administrator'): 0x4524660
BESERVER: [07/21/11 11:38:24] [6164]     01 Server Configuration: Client removed: 10
BESERVER: [07/21/11 11:38:24] [6164]     -1 Client 'BACKUPSRV' Disconnected:0x4524660
BENGINE:  [07/21/11 11:38:24] [6636]     "Cluster" key does not appear to be present in the registry
BENGINE:  [07/21/11 11:38:24] [5176]     [server]             - Updating status for: 'client.<fqdn>-Dedup-Dag' (0x0 0x0)
BENGINE:  [07/21/11 11:38:24] [5176]     [server]             - Status for: 'client.<fqdn>-Dedup-Dag' updated
BENGINE:  [07/21/11 11:38:24] [6636]     Failed to open Microsoft cluster ()
BENGINE:  [07/21/11 11:38:24] [6636]     VCS cluster keys do not appear to be present in the registry
BENGINE:  [07/21/11 11:38:24] [6636]     Failed to open VCS cluster ()
BENGINE:  [07/21/11 11:38:24] [6636]     [server]             - Checking for Evaluation expiration.
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: ConvertDeviceName osId = 0Xe
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: IN - oldDeviceName = \\client.<fqdn>\C:
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: OUT - newName = \\client.<fqdn>\C:
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - SetupCryptInfoInBSD: Backup encryption options: bHWEncryption=0,bSWEncryption=0,bSWEncryptionIfNoHW=0
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: ConvertDeviceName osId = 0X2b
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: IN - oldDeviceName = client.<fqdn>
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: OUT - newName = client.<fqdn>
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - SetupCryptInfoInBSD: Backup encryption options: bHWEncryption=0,bSWEncryption=0,bSWEncryptionIfNoHW=0
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: ConvertDeviceName osId = 0X2f
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: IN - oldDeviceName = \\client.<fqdn>\Shadow?Copy?Components
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: OUT - newName = \\client.<fqdn>\Shadow?Copy?Components
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - SetupCryptInfoInBSD: Backup encryption options: bHWEncryption=0,bSWEncryption=0,bSWEncryptionIfNoHW=0
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: ConvertDeviceName osId = 0X3b
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: IN - oldDeviceName = \\client.<fqdn>\System?State
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: OUT - newName = \\client.<fqdn>\System?State
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - SetupCryptInfoInBSD: Backup encryption options: bHWEncryption=0,bSWEncryption=0,bSWEncryptionIfNoHW=0
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: ConvertDeviceName osId = 0Xe
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: IN - oldDeviceName = \\*\*
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: OUT - newName = \\*\*
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: ConvertDeviceName osId = 0Xe
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: IN - oldDeviceName = \\*\*
BENGINE:  [07/21/11 11:38:24] [6636]     [engapi]             - ENGSCRPT: OUT - newName = \\*\*
BENGINE:  [07/21/11 11:38:24] [6636]     [server]             - Failed to Load AllowExcludes key, We will update DR file evenif there are userExcludes. Error: 5
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = DRIVE_POOL_ENTITY_TYPE

            ParentEntityGuid = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}

            EntityType = NULL_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = DEVICE_ENTITY_TYPE

            EntityGuid = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}

            EntityName = ""

            EntityFlags = 0x00000000
BENGINE:  [07/21/11 11:38:24] [6636]     [server]             - MountMultiple: Created MountThread thread 4104
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             - DeviceManager: incoming event fired
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             - DeviceManager: Executing RequestDeviceCall from thread 4104.
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             - DeviceManager: processing pending requests
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             - DeviceManager: Processing device request for thread 4104.
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             - DeviceManager: query cache miss
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = DRIVE_POOL_ENTITY_TYPE

            ParentEntityGuid = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}

            EntityType = NULL_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             - Available and held drives from the pool
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             -     Deduplication Storage:2 {3dfc82e5-48a6-467e-a1a2-b2dd05fa96c8}
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             -     Deduplication Storage:3 {c5f9cc66-3e7f-4f02-a48c-6051352845a0}
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             -     Deduplication Storage:5 {280b9040-dc78-4a82-8f60-6a3ab7fd05b1}
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             - Drives not in use by the Engine
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             -     Deduplication Storage:2 {3dfc82e5-48a6-467e-a1a2-b2dd05fa96c8}
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             -     Deduplication Storage:3 {c5f9cc66-3e7f-4f02-a48c-6051352845a0}
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             -     Deduplication Storage:5 {280b9040-dc78-4a82-8f60-6a3ab7fd05b1}
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             - Drives available (not in use and not held)
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             -     Deduplication Storage:2 {3dfc82e5-48a6-467e-a1a2-b2dd05fa96c8}
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             -     Deduplication Storage:3 {c5f9cc66-3e7f-4f02-a48c-6051352845a0}
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             -     Deduplication Storage:5 {280b9040-dc78-4a82-8f60-6a3ab7fd05b1}
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_DEVICE_GUID )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            TargetDevice = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}, "Deduplication Storage" (Library)

            TargetDevice = {EC3435F2-23B0-409B-9345-73470647627F}, "Deduplication Storage:4" (Drive)

            TargetDevice = {2CD64206-32FB-4F33-9A6B-0893593D11CB}, "Deduplication Storage:1" (Drive)

            TargetDevice = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2" (Drive)

            TargetDevice = {C5F9CC66-3E7F-4F02-A48C-6051352845A0}, "Deduplication Storage:3" (Drive)

            TargetDevice = {280B9040-DC78-4A82-8F60-6A3AB7FD05B1}, "Deduplication Storage:5" (Drive)
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_MEDIA_GUID )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            TargetMedia = {C2D0E799-00A2-43D4-866D-4BC4BCC5F084}, "Deduplication" (Media Set)
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_EXCLUDE_MEDIA_GUIDS )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             - DeviceManager: Handing out session {65aa6da4-95c6-4e7a-98ed-ece300fbd922} based on available drive:
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             -     Deduplication Storage:2 {3dfc82e5-48a6-467e-a1a2-b2dd05fa96c8}
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             - DeviceManager: returned result to caller 0x00000000
BENGINE:  [07/21/11 11:38:24] [5068]     [server]             - DeviceManager: going to sleep for 900000 msecs
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = DRIVE_POOL_ENTITY_TYPE

            ParentEntityGuid = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}

            EntityType = NULL_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_JOB_INFO )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Job = {B5815AC2-393B-4C49-9C6C-B7A1FB960315}, "client.<fqdn>-Dedup-Dag"
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_MORE_JOB_INFO )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Job = {B5815AC2-393B-4C49-9C6C-B7A1FB960315}, "client.<fqdn>-Dedup-Dag"

            SessionFlags = 0x00000002

            JobFamilyID = {14A60994-AC15-41CB-BF6B-6EF701EA9684}
BENGINE:  [07/21/11 11:38:24] [4104]     [server]             - BackupJob::MountThread : Device path hint : client.
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_DEVICE_HOST )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Device Host = "client"
BENGINE:  [07/21/11 11:38:24] [4104]     [server]             - BackupJob: thread id 0x00001008 acquired device Deduplication Storage:2.
BENGINE:  [07/21/11 11:38:24] [4104]     [server]             - BackupJob: thread id 0x00001008 trying to mount appending volume.
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_MOUNT_APPEND )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_INFO )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_DEVICE_GUID )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            TargetDevice = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}, "Deduplication Storage" (Library)

            TargetDevice = {EC3435F2-23B0-409B-9345-73470647627F}, "Deduplication Storage:4" (Drive)

            TargetDevice = {2CD64206-32FB-4F33-9A6B-0893593D11CB}, "Deduplication Storage:1" (Drive)

            TargetDevice = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2" (Drive)

            TargetDevice = {C5F9CC66-3E7F-4F02-A48C-6051352845A0}, "Deduplication Storage:3" (Drive)

            TargetDevice = {280B9040-DC78-4A82-8F60-6A3AB7FD05B1}, "Deduplication Storage:5" (Drive)
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_MEDIA_GUID )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            TargetMedia = {C2D0E799-00A2-43D4-866D-4BC4BCC5F084}, "Deduplication" (Media Set)
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_EXCLUDE_MEDIA_GUIDS )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::CheckTargetDeviceStatus()

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Job = {B5815AC2-393B-4C49-9C6C-B7A1FB960315}, "client.<fqdn>-Dedup-Dag"

            TargetDevice = {EC3435F2-23B0-409B-9345-73470647627F}, "Deduplication Storage:4"

                State = 0001, ReservationID = 0000, AvailableMovers = 0001

            TargetDevice = {2CD64206-32FB-4F33-9A6B-0893593D11CB}, "Deduplication Storage:1"

                State = 0001, ReservationID = 0000, AvailableMovers = 0001

            TargetDevice = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"

                State = 0003, ReservationID = 0000, AvailableMovers = 0001

            TargetDevice = {C5F9CC66-3E7F-4F02-A48C-6051352845A0}, "Deduplication Storage:3"

                State = 0003, ReservationID = 0000, AvailableMovers = 0001

            TargetDevice = {280B9040-DC78-4A82-8F60-6A3AB7FD05B1}, "Deduplication Storage:5"

                State = 0003, ReservationID = 0000, AvailableMovers = 0001
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::MountAppendMedia()
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_MOUNT_APPEND )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            ERROR = 0xE000810D (E_PVL_MEDIA_NOT_FOUND)
BENGINE:  [07/21/11 11:38:24] [4104]     [server]             - BackupJob: thread id 0x00001008 unable to mount appending volume, attempting scratch mount.
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_MOUNT_OVERWRITE )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_INFO )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_DEVICE_GUID )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            TargetDevice = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}, "Deduplication Storage" (Library)

            TargetDevice = {EC3435F2-23B0-409B-9345-73470647627F}, "Deduplication Storage:4" (Drive)

            TargetDevice = {2CD64206-32FB-4F33-9A6B-0893593D11CB}, "Deduplication Storage:1" (Drive)

            TargetDevice = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2" (Drive)

            TargetDevice = {C5F9CC66-3E7F-4F02-A48C-6051352845A0}, "Deduplication Storage:3" (Drive)

            TargetDevice = {280B9040-DC78-4A82-8F60-6A3AB7FD05B1}, "Deduplication Storage:5" (Drive)
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_MEDIA_GUID )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            TargetMedia = {C2D0E799-00A2-43D4-866D-4BC4BCC5F084}, "Deduplication" (Media Set)
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_EXCLUDE_MEDIA_GUIDS )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::CheckTargetDeviceStatus()

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Job = {B5815AC2-393B-4C49-9C6C-B7A1FB960315}, "client.<fqdn>-Dedup-Dag"

            TargetDevice = {EC3435F2-23B0-409B-9345-73470647627F}, "Deduplication Storage:4"

                State = 0001, ReservationID = 0000, AvailableMovers = 0001

            TargetDevice = {2CD64206-32FB-4F33-9A6B-0893593D11CB}, "Deduplication Storage:1"

                State = 0001, ReservationID = 0000, AvailableMovers = 0001

            TargetDevice = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"

                State = 0003, ReservationID = 0000, AvailableMovers = 0001

            TargetDevice = {C5F9CC66-3E7F-4F02-A48C-6051352845A0}, "Deduplication Storage:3"

                State = 0003, ReservationID = 0000, AvailableMovers = 0001

            TargetDevice = {280B9040-DC78-4A82-8F60-6A3AB7FD05B1}, "Deduplication Storage:5"

                State = 0003, ReservationID = 0000, AvailableMovers = 0001
PVLSVR:   [07/21/11 11:38:24] [6976]     AdammSession::MountOverwriteMedia() - 0005 drives
PVLSVR:   [07/21/11 11:38:24] [6976]     PvlSession::MountOverwriteMedia() - 0208 media view overwritable media
PVLSVR:   [07/21/11 11:38:25] [6976]     PvlSession::MountOverwriteMedia() - 0207 initial priority overwritable media
PVLSVR:   [07/21/11 11:38:25] [6976]     PvlSession::MountOverwriteMedia() - 0207 priority overwriteable media after blank/unknown
PVLSVR:   [07/21/11 11:38:25] [6976]     PvlSession::MountOverwriteMedia() - 0207 priority overwritable media after standalone
PVLSVR:   [07/21/11 11:38:25] [6976]     PvlSession::MountOverwriteMedia() - qualified drive Deduplication Storage:4 slot 0067
PVLSVR:   [07/21/11 11:38:25] [6976]     PvlSession::MountOverwriteMedia() - reserve error ERROR = 0xE000810C (E_PVL_DRIVE_NOT_AVAILABLE)
PVLSVR:   [07/21/11 11:38:25] [6976]     PvlSession::MountOverwriteMedia() - qualified drive Deduplication Storage:1 slot 0067
PVLSVR:   [07/21/11 11:38:25] [6976]     PvlSession::MountOverwriteMedia() - reserve error ERROR = 0xE000810C (E_PVL_DRIVE_NOT_AVAILABLE)
PVLSVR:   [07/21/11 11:38:25] [6976]     PvlSession::MountOverwriteMedia() - qualified drive Deduplication Storage:2 slot 0067
BESERVER: [07/21/11 11:38:25] [6892]     01 No archive option installed. EV Embedded status defaults to true and not supported version.
BESERVER: [07/21/11 11:38:25] [6892]     01 ServerConfigBO:GetFeatureText, The Unknown Option's ID is 97
BESERVER: [07/21/11 11:38:25] [6892]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [07/21/11 11:38:25] [6848]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:25] [6892]     05 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [07/21/11 11:38:25] [6892]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [07/21/11 11:38:25] [2636]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:25] [6892]     05 AdammAdminBO::Execute() - hr = 0x0
PVLSVR:   [07/21/11 11:38:25] [6848]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
PVLSVR:   [07/21/11 11:38:25] [6848]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = LIBRARY_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:25] [6892]     01 No archive option installed. EV Embedded status defaults to true and not supported version.
BESERVER: [07/21/11 11:38:25] [6892]     01 ServerConfigBO:GetFeatureText, The Unknown Option's ID is 97
BESERVER: [07/21/11 11:38:25] [6892]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [07/21/11 11:38:25] [6848]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:25] [6892]     05 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [07/21/11 11:38:25] [6892]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [07/21/11 11:38:25] [2636]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:25] [6892]     05 AdammAdminBO::Execute() - hr = 0x0
PVLSVR:   [07/21/11 11:38:25] [2636]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
PVLSVR:   [07/21/11 11:38:25] [2636]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = LIBRARY_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
PVLSVR:   [07/21/11 11:38:25] [6976]     AdammSession::MountMedia()

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Drive = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}

            Slot = 0067

            Side = 0000
PVLSVR:   [07/21/11 11:38:25] [6976]     PvlDrive::MountMedia()

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Drive = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"

            Slot = 0067

            Side = 0001
PVLSVR:   [07/21/11 11:38:26] [6976]     PvlChanger::MountMedia()

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Library = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}, "Deduplication Storage"

            Drive = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"

            Slot = 0067

            Side = 0001
BESERVER: [07/21/11 11:38:29] [0664]     16 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
BENGINE:  [07/21/11 11:38:29] [5176]     [server]             - Updating status for: 'client.<fqdn>-Dedup-Dag' (0x0 0x8)
BENGINE:  [07/21/11 11:38:29] [5176]     [server]             - Status for: 'client.<fqdn>-Dedup-Dag' updated
PVLSVR:   [07/21/11 11:38:31] [2636]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = SLOT_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
PVLSVR:   [07/21/11 11:38:36] [6976]     PvlDrive::GetMediaStatus()

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Drive = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"

            Elapsed Seconds = 0000, Sense Code = 0x00000000

            SUCCESS!
PVLSVR:   [07/21/11 11:38:37] [6976]     PvlDrive::MountMedia() - Establish connection

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Drive = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"
PVLSVR:   [07/21/11 11:38:37] [6976]     AdammSession::MountMedia()

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Library = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}, "Deduplication Storage"

            Slot = 0067

            Drive = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"

            Media = {924FC407-A0C9-42C6-83CC-B5BD3184C58E}, "OST00000068-4BE872208A519179"

            Side = 0001

            SUCCESS!
PVLSVR:   [07/21/11 11:38:37] [6976]     AdammSession::IsOverwriteMediaMounted() -

        Need WORM: Yes

        Need Encryption: No
PVLSVR:   [07/21/11 11:38:37] [6976]     AdammSession::IsOverwriteMediaMounted() - ERROR = 0x00000450 (ERROR_NO_DATA_DETECTED)
PVLSVR:   [07/21/11 11:38:37] [6976]     PvlDrive::WriteMediaHeader()

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Library = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}

            Slot = 0067

            Drive = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"

            MediaLabel = "OST00000068-4BE872208A519179"

            Media = {924FC407-A0C9-42C6-83CC-B5BD3184C58E}

            MediaHeader =
BESERVER: [07/21/11 11:38:38] [6500]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_MEDIA_SUMMARY.
PVLSVR:   [07/21/11 11:38:38] [2636]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = 0031

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

            EntityName = "

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:38] [6500]     05 AdammAdminBO::Execute() - hr = 0x0
PVLSVR:   [07/21/11 11:38:38] [6976]     AdammSession::IsOverwriteMediaMounted() -

        Need WORM: Yes

        Need Encryption: No
BESERVER: [07/21/11 11:38:39] [6500]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_MEDIA_SUMMARY.
PVLSVR:   [07/21/11 11:38:39] [2636]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = 0031

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

            EntityName = "

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:39] [6500]     05 AdammAdminBO::Execute() - hr = 0x0
PVLSVR:   [07/21/11 11:38:41] [6976]     AdammSession::IsOverwriteMediaMounted() - SUCCESS!
PVLSVR:   [07/21/11 11:38:41] [6976]     PvlSession::MountOverwriteMedia() - blank media

            MediaLabel       = OST00000068-4BE872208A519179

            m_nPriority      = 0xFACAB547
PVLSVR:   [07/21/11 11:38:41] [6976]     PvlSession::MountOverwriteMedia() - SUCCESS! - 0017 seconds
BENGINE:  [07/21/11 11:38:41] [4104]     [server]             - Updating session {65aa6da4-95c6-4e7a-98ed-ece300fbd922} with drive Deduplication Storage:2 {3dfc82e5-48a6-467e-a1a2-b2dd05fa96c8}
BENGINE:  [07/21/11 11:38:41] [4104]     [server]             - BackupJob: thread id 0x00001008 medium successfully mounted.
PVLSVR:   [07/21/11 11:38:41] [6976]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}
BENGINE:  [07/21/11 11:38:41] [6636]     [server]             - Media Label: OST00000068-4BE872208A519179
BENGINE:  [07/21/11 11:38:41] [6636]     [server]             - Media Label: {924fc407-a0c9-42c6-83cc-b5bd3184c58e}
BENGINE:  [07/21/11 11:38:41] [6636]     [server]             - Overwrite Protected Until: 7/24/2011 11:38:38 AM
BENGINE:  [07/21/11 11:38:41] [6636]     [server]             - Appendable Until: 12/31/9999 1:00:00 AM
BENGINE:  [07/21/11 11:38:41] [6636]     [tapealrt]           - TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [07/21/11 11:38:41] [6636]     [tapealrt]           - TAPEALERT: TapeAlert Device Flag  = 0X0
BENGINE:  [07/21/11 11:38:41] [6636]     [tapealrt]           - TAPEALERT: TapeAlert Changer Flag = 0X0
BENGINE:  [07/21/11 11:38:41] [6636]     [tapealrt]           - TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [07/21/11 11:38:41] [6636]     [tapealrt]           - TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [07/21/11 11:38:41] [6636]     [server]             - Job Family ID: {14A60994-AC15-41CB-BF6B-6EF701EA9684}
BENGINE:  [07/21/11 11:38:41] [6636]     [server]             - Deduplication Storage:2 Block size:  65536
BENGINE:  [07/21/11 11:38:41] [6636]     [server]             - Deduplication Storage:2 Buffer size: 65536
BENGINE:  [07/21/11 11:38:41] [6636]     [server]             - Deduplication Storage:2 Num buffers:    10
BENGINE:  [07/21/11 11:38:41] [6636]     [server]             - Deduplication Storage:2 High water:      0
PVLSVR:   [07/21/11 11:38:41] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = OST_SERVER_ENTITY_TYPE

            EntityGuid = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}

            EntityName = ""

            EntityFlags = 0x00000900
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - Enter CheckHostBSDsForSnaps
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - Exit CheckHostBSDsForSnaps: true
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - NDMPAgentConnector:SetupConnection(): Data Server = client.<fqdn>
BENGINE:  [07/21/11 11:38:41] [6636]     [ndmp\ndmpcomm]      - Could not resolve the "bews-ndmp" or the "ndmp" service, error code: 10109, using port 10000
BENGINE:  [07/21/11 11:38:41] [6636]     [ndmp\ndmpcomm]      - ndmpConnectEx: Querying the neighbour advertisement cache to discover information on 'client.<fqdn>' ...
BENETNS:  [07/21/11 11:38:41] [4756]     NRDS API - client connected.
BENETNS:  [07/21/11 11:38:41] [4756]     NRDS API - client disconnected.
BENGINE:  [07/21/11 11:38:41] [6636]     [ndmp\ndmpcomm]      - ndmpConnectEx : Control Connection information: A connection was established between end-points 172.20.10.101:62497 and 172.20.10.100:10000.
BENGINE:  [07/21/11 11:38:41] [6636]     [ndmp\ndmpclient]    - NDMP version 3 connection CONNECTED
BESERVER: [07/21/11 11:38:41] [6892]     -1 Client requested key (1311241289).
BESERVER: [07/21/11 11:38:41] [6892]     01 Server Configuration: Client added: 11
BESERVER: [07/21/11 11:38:41] [6892]     -1 Client 'BACKUPSRV' connected('','DOMAIN\administrator'): 0xd4dc480
BESERVER: [07/21/11 11:38:41] [6892]     01 Server Configuration: Client removed: 10
BESERVER: [07/21/11 11:38:41] [6892]     -1 Client 'BACKUPSRV' Disconnected:0xd4dc480
BESERVER: [07/21/11 11:38:41] [6184]     -1 Client requested key (1311241289).
BESERVER: [07/21/11 11:38:41] [6184]     01 Server Configuration: Client added: 11
BESERVER: [07/21/11 11:38:41] [6184]     -1 Client 'BACKUPSRV' connected('','DOMAIN\administrator'): 0x197d9cf0
BESERVER: [07/21/11 11:38:41] [6184]     01 Server Configuration: Client removed: 10
BESERVER: [07/21/11 11:38:41] [6184]     -1 Client 'BACKUPSRV' Disconnected:0x197d9cf0
BESERVER: [07/21/11 11:38:41] [6184]     -1 Client requested key (1311241289).
BESERVER: [07/21/11 11:38:41] [6184]     01 Server Configuration: Client added: 11
BESERVER: [07/21/11 11:38:41] [6184]     -1 Client 'BACKUPSRV' connected('','DOMAIN\administrator'): 0x4524480
BESERVER: [07/21/11 11:38:41] [6184]     01 Server Configuration: Client removed: 10
BESERVER: [07/21/11 11:38:41] [6184]     -1 Client 'BACKUPSRV' Disconnected:0x4524480
BENGINE:  [07/21/11 11:38:41] [6636]     - SSL connection using version TLSv1
BENGINE:  [07/21/11 11:38:41] [6636]     - SSL connection using cipher AES256-SHA
BENGINE:  [07/21/11 11:38:41] [6636]     [ndmp\ndmpclient]    - secureNDMPConnection: SECURITY ENABLED!!
BENGINE:  [07/21/11 11:38:41] [0000]     BECryptoInit: BECrypto non-FIPS mode successfully enabled.
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - IsLocalAgent:beclass::BEConvertServerNamePlus returned error: 87
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - IsLocalAgent:beclass::BEConvertServerNamePlus returned error: 87
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - Enter NDMPSnapHostBackupEngine::ProcessBSDs
BENGINE:  [07/21/11 11:38:41] [6636]     [besc]               - BESC: Parsing OS version info - [Major Version=5 Minor Version=2 Build Number=3790 ServicePack Major=1 ServicePack Minor=0 SuiteMask=272 ProductType=3 ProcessorType=Intel x86]
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - Single logical volume snapshot is enabled for this job.
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - AOFO is enabled for this job.
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - Shadow Copy is enabled for this job.
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - Enter NDMPSnapHostBackupEngine::CreateBSDProcessor
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - PDI processor not needed, performing traditional backup
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - Failed to Load AllowExcludes key, We will update DR file evenif there are userExcludes. Error: 5
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - Enter NDMPSnapHostBackupEngine::SnapAllVolumes
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - Exit NDMPSnapHostBackupEngine::SnapAllVolumes
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - Enter NDMPSnapHostBackupEngine::TrackSnappedBSD
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - Exit NDMPSnapHostBackupEngine::TrackSnappedBSD
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - NDMPSnapHostBackupEngine::ProcessBSDs Top of the loop
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - snapResult = 0x0, result = 0x0
BENGINE:  [07/21/11 11:38:41] [6636]     [loops]              - Enter NDMPSnapHostBackupEngine::SnapSingleVolume
BENGINE:  [07/21/11 11:38:41] [6636]     [besc]               - ndmpcSnapshotPrepare: adding selection string for device_name: \\client.<fqdn>\C:
BENGINE:  [07/21/11 11:38:41] [6636]     [besc]               - ndmpcSnapshotPrepare2: selection string: "\\client.<fqdn>\C:\*.*",s,v0,t0,l0,n0,f0
BENGINE:  [07/21/11 11:38:41] [6636]     [besc]               - ndmpcSnapshotPrepare2: selection string: "\\client.<fqdn>\C:\*.tmp",s,x,v0,t0,l0,n0,f0
BENGINE:  [07/21/11 11:38:41] [6636]     [besc]               - ndmpcSnapshotPrepare2: selection string: "\\client.<fqdn>\C:\pagefile.sys",s,x,v0,t0,l0,n0,f0
BENGINE:  [07/21/11 11:38:44] [6636]     [besc]               - ndmpcSnapshotPrepare2: Completed with status: 0
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - Exit NDMPSnapHostBackupEngine::SnapSingleVolume
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - TF_OpenTape()
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - TF_GetChannel( ) reusing channel 0876A7A0
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - TF_GetDriveContext ...

         sessionGuid = {65aa6da4-95c6-4e7a-98ed-ece300fbd922}

         initAsync = 1
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - TF_MoverAsyncInit(): Started ProcessRequest thread 6436
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - GET_DRV_INF: bsize = 65536
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - GET_DRV_INF: preferredBlockSize = 65536
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - TF_GetDriveContext returning 0x00000000, context = 1E39AD10
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - Allocated 2 buffers, size 65536 bytes, total used: 131328
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - GET_DRV_INF: bsize = 65536
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - GET_DRV_INF: preferredBlockSize = 65536
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - DeviceIsNT4Server: agent info: [Major Version=5 Minor Version=2 Build Number=3790 ServicePack Major=1 ServicePack Minor=0 SuiteMask=272 ProductType=3 ProcessorType=Intel x86].
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - DeviceIsIA64Server: agent info: [Major Version=5 Minor Version=2 Build Number=3790 ServicePack Major=1 ServicePack Minor=0 SuiteMask=272 ProductType=3 ProcessorType=Intel x86].
BENGINE:  [07/21/11 11:38:44] [6636]     Failed to open Microsoft cluster (client.<fqdn>)
BENGINE:  [07/21/11 11:38:44] [6636]     Failed to open VCS cluster (client.<fqdn>)
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - TF_OpenSet( )
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - FreeFormatEnv( cur_fmt=65535 )
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - RewindDrive mover ret = 0 (0x0)
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              -   ret_val = 0
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - Requested Set: ID = ffffffff Seq = -1 Set = -1
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - Attempting to VCB storage media
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              -   TpRead( :(
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - Error = 1104 Req = 65536 Got = 0
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - FreeFormatEnv( cur_fmt=65535 )
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - RewindDrive mover ret = 0 (0x0)
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              -   ret_val = 0
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - PositionAtSet( :( TF Msg = e
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - RewindDrive mover ret = 0 (0x0)
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              -   ret_val = 0
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - OST ===> Closing image.
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - RewindDrive mover ret = 0 (0x0)
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              -   ret_val = 0
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              -   UI Msg = 8003
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - HARDWARE COMPRESSION ===> Compression is NOT configurable.
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - HARDWARE ENCRYPTION ===> Encryption is NOT supported.
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - GET_DRV_INF: bsize = 65536
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - GET_DRV_INF: preferredBlockSize = 65536
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - RewindDrive mover ret = 0 (0x0)
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              -   ret_val = 0
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - FreeFormatEnv( cur_fmt=65535 )
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - SetupFormatEnv( fmt=0 )
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - End of TF_OpenSet: Ret_val = 0x00000000 Buffs = 2 HiWater = 0
PVLSVR:   [07/21/11 11:38:44] [2636]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = OST_SERVER_ENTITY_TYPE

            EntityGuid = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}

            EntityName = ""

            EntityFlags = 0x00000900
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - TF_CloseSet
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - Enter NDMPSnapHostBackupEngine::TrackSnappedBSD
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - Exit NDMPSnapHostBackupEngine::TrackSnappedBSD
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - NDMPSnapHostBackupEngine::ProcessBSDs Top of the loop
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - snapResult = 0x0, result = 0xe00084ea
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - NDMPSnapHostBackupEngine::ProcessBSDs Top of the loop
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - snapResult = 0x0, result = 0xe00084ea
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - NDMPSnapHostBackupEngine::ProcessBSDs Top of the loop
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - snapResult = 0x0, result = 0xe00084ea
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - Exit NDMPSnapHostBackupEngine::ProcessBSDs
BENGINE:  [07/21/11 11:38:44] [6636]     - SSL Shutdown clean
BENGINE:  [07/21/11 11:38:44] [6636]     [loops]              - NDMPAgentConnector::EndConnection(): Data Server = client.<fqdn>
BENGINE:  [07/21/11 11:38:44] [6636]     [tpfmt]              - OST ===> Closing image.
BENGINE:  [07/21/11 11:38:44] [5176]     [server]             - Updating status for: 'client.<fqdn>-Dedup-Dag' (0x0 0x0)
BENGINE:  [07/21/11 11:38:44] [5176]     [server]             - Status for: 'client.<fqdn>-Dedup-Dag' updated
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - OST ===> Stats: PDDO Stats for (BACKUPSRV): scanned: 75 KB, stream rate: 0.00 MB/sec, CR sent: 0 KB, dedup: 100.0%, cache hits: 0 (0.0%)
PVLSVR:   [07/21/11 11:38:46] [2636]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - OST ===> Closing image.
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - OST ===> Closing image.
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - RewindDrive mover ret = 0 (0x0)
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              -   ret_val = 0
PVLSVR:   [07/21/11 11:38:46] [2636]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - TF_PutChannel( ) 0876A7A0
BENGINE:  [07/21/11 11:38:46] [6636]     [tapealrt]           - TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [07/21/11 11:38:46] [6636]     [tapealrt]           - TAPEALERT: TapeAlert Device Flag  = 0X0
BENGINE:  [07/21/11 11:38:46] [6636]     [tapealrt]           - TAPEALERT: TapeAlert Changer Flag = 0X0
BENGINE:  [07/21/11 11:38:46] [6636]     [tapealrt]           - TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [07/21/11 11:38:46] [6636]     [tapealrt]           - TAPEALERT: Get TapeAlert Flags Return Code = 0X0
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - TF_OpenTape()
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - TF_GetChannel( ) reusing channel 15F3E610
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - TF_GetDriveContext ...

         sessionGuid = {00000000-0000-0000-0000-000000000000}

         initAsync = 1
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - TF_GetDriveContext returning 0xE0008442, context = 0
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - TF_PutChannel( ) 15F3E610
PVLSVR:   [07/21/11 11:38:46] [2636]     PvlEntityDatabase::UpdateEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = MEDIA_ENTITY_TYPE

            Media = {924FC407-A0C9-42C6-83CC-B5BD3184C58E}, ""

            EntityFlags = 0x008C0000
PVLSVR:   [07/21/11 11:38:46] [2636]     PvlEntityDatabase::UpdateEntity() : SUCCESS!
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - TF_FreeDriveContext( 1E39AD10 )
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - TF_FreeTapeBuffers: from 2 to 0 buffers
BENGINE:  [07/21/11 11:38:46] [6636]     [tpfmt]              - FreeFormatEnv( cur_fmt=0 )
PVLSVR:   [07/21/11 11:38:46] [2636]     AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_DISMOUNT )

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Flags = 0x00000020
PVLSVR:   [07/21/11 11:38:46] [2636]     AdammSession::DismountMedia()

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Library = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}, "Deduplication Storage"

            Slot = 0067

            Drive = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"

            Media = {924FC407-A0C9-42C6-83CC-B5BD3184C58E}, "OST00000068-4BE872208A519179"

            Side = 0001
PVLSVR:   [07/21/11 11:38:46] [2636]     PvlDrive::DismountMedia()

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Drive = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"

            Slot = 4294967295

            Side = 4294967295
PVLSVR:   [07/21/11 11:38:47] [2636]     PvlDrive::DismountMedia() - Release connection

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Drive = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"
BESERVER: [07/21/11 11:38:47] [6500]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_MEDIA_SUMMARY.
PVLSVR:   [07/21/11 11:38:47] [6976]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = 0031

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

            EntityName = "

            EntityFlags = 0x00000000
PVLSVR:   [07/21/11 11:38:47] [2636]     PvlDrive::DismountMedia() - changer reservation successful.

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Drive = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"

            Slot = 0067

            SUCCESS!
BESERVER: [07/21/11 11:38:47] [6500]     05 AdammAdminBO::Execute() - hr = 0x0
PVLSVR:   [07/21/11 11:38:47] [2636]     PvlChanger::DismountMedia()

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}

            Library = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}, "Deduplication Storage"

            Drive = {3DFC82E5-48A6-467E-A1A2-B2DD05FA96C8}, "Deduplication Storage:2"

            Slot = 0067

            Side = 0001
PVLSVR:   [07/21/11 11:38:53] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = SLOT_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
BENGINE:  [07/21/11 11:38:54] [5068]     [server]             - DeviceManager: dismount event fired
BENGINE:  [07/21/11 11:38:54] [5068]     [server]             - DeviceManager: processing pending requests
BENGINE:  [07/21/11 11:38:54] [5068]     [server]             - DeviceManager: going to sleep for 900000 msecs
PVLSVR:   [07/21/11 11:38:54] [2636]     AdammSession::Release()

            Session = {65AA6DA4-95C6-4E7A-98ED-ECE300FBD922}
BENGINE:  [07/21/11 11:38:54] [6636]     [server]             - Removing 'client.<fqdn>-Dedup-Dag' from status update list
BENGINE:  [07/21/11 11:38:54] [6636]     [server]             - Updating status for: 'client.<fqdn>-Dedup-Dag' (0x18 0x0)
BENGINE:  [07/21/11 11:38:54] [6636]     [server]             - Status for: 'client.<fqdn>-Dedup-Dag' updated
BENGINE:  [07/21/11 11:38:54] [6636]     [server]             - BackupJob::MergeBEVSRJobLogsIfNecessary: No VSR log file found, no merging necessary
BENGINE:  [07/21/11 11:38:54] [6636]     [server]             - Ending job 'client.<fqdn>-Dedup-Dag' with error status (-536836886)
BESERVER: [07/21/11 11:38:54] [6164]     16 JobManager::HandleEndJob() called
BESERVER: [07/21/11 11:38:54] [4704]     -1 ActiveState::doEndEvent( :( 'client.<fqdn>-Dedup-Dag'
BESERVER: [07/21/11 11:38:54] [4704]     16 JobManager::DoJobCompletionTasks(client.<fqdn>-Dedup-Dag): GetFinalJobStatus()=6
BESERVER: [07/21/11 11:38:54] [4704]     16 JobManager::DoJobCompletionTasks() Handling normal JOB_STATE_ERROR
BENGINE:  [07/21/11 11:38:54] [6636]     [server]             - Job thread terminating
BESERVER: [07/21/11 11:38:54] [4704]     16 JobManager::DoJobCompletionTasks() Finished building JOB_STATE_ERROR message
BESERVER: [07/21/11 11:38:54] [6164]     01 Server Configuration: Client removed: 9
BESERVER: [07/21/11 11:38:54] [6164]     -1 Client 'BACKUPSRV' Disconnected:0x197d8810
BESERVER: [07/21/11 11:38:54] [4704]     17 Alert Job Failed, Notify: No, EventLog: Yes, Trap: No
BESERVER: [07/21/11 11:38:54] [6164]     15 GetSummary: SJ=41 SEJ=7 CJ=0 FJ=13 UM=0 BB=-1435697714 MJ=0 RecoveredJ=0 ResumedJ=0 FeatureRecommend=0
BESERVER: [07/21/11 11:38:54] [4812]     16 CJobManagerBO::Query old QUERY
BESERVER: [07/21/11 11:38:54] [4704]     16 JobManager:GenerateSetCopyScriptFromHistory: Could not find script with a set#
BESERVER: [07/21/11 11:38:54] [4704]     16 JobManager:GenerateSetCopyScriptFromHistory: Could not find script with a set#
BESERVER: [07/21/11 11:38:54] [4704]     16 JobManager:GenerateSetCopyScriptFromHistory: Could not find script with a set#
BESERVER: [07/21/11 11:38:54] [4704]     16 JobManager:GenerateSetCopyScriptFromHistory: Could not find script with a set#
BESERVER: [07/21/11 11:38:54] [4704]     -1 ActiveState::doEndEvent( :( CJobManager::DoJobCompletionTasks() returned 0x0
BESERVER: [07/21/11 11:38:54] [4812]     16 CJobManagerBO::Query old QUERY
BESERVER: [07/21/11 11:38:54] [0664]     16 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
BESERVER: [07/21/11 11:38:54] [6164]     01 No archive option installed. EV Embedded status defaults to true and not supported version.
BESERVER: [07/21/11 11:38:54] [6164]     01 ServerConfigBO:GetFeatureText, The Unknown Option's ID is 97
BESERVER: [07/21/11 11:38:54] [6164]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [07/21/11 11:38:54] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:54] [6164]     05 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [07/21/11 11:38:54] [6164]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [07/21/11 11:38:54] [2636]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:54] [6164]     05 AdammAdminBO::Execute() - hr = 0x0
PVLSVR:   [07/21/11 11:38:54] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
PVLSVR:   [07/21/11 11:38:54] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = LIBRARY_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:54] [6164]     01 No archive option installed. EV Embedded status defaults to true and not supported version.
BESERVER: [07/21/11 11:38:54] [6164]     01 ServerConfigBO:GetFeatureText, The Unknown Option's ID is 97
BESERVER: [07/21/11 11:38:54] [6164]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [07/21/11 11:38:54] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:54] [6164]     05 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [07/21/11 11:38:54] [6164]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [07/21/11 11:38:54] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:54] [6164]     05 AdammAdminBO::Execute() - hr = 0x0
PVLSVR:   [07/21/11 11:38:54] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
PVLSVR:   [07/21/11 11:38:54] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = LIBRARY_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:54] [6164]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_MEDIA_SUMMARY.
PVLSVR:   [07/21/11 11:38:54] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = 0031

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

            EntityName = "

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:54] [6164]     05 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [07/21/11 11:38:54] [6164]     -1 Registered virtual array rowset(108): Client:BACKUPSRV, Type:MD_OBJTYPE_JOBHISTORYVIEW
BESERVER: [07/21/11 11:38:59] [0664]     01 No archive option installed. EV Embedded status defaults to true and not supported version.
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = MACHINE_ENTITY_TYPE

            EntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityName = "

            EntityFlags = 0x00008000
PVLSVR:   [07/21/11 11:38:59] [6428]     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
PVLSVR:   [07/21/11 11:38:59] [2636]     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
PVLSVR:   [07/21/11 11:38:59] [6428]     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
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00008000
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00008000
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_POOL_DRIVE_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00008000
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = LIBRARY_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00008000
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Get() - Parent = NULL , Entity = OST_SERVER_ENTITY
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = NULL_ENTITY_TYPE

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

            EntityType = OST_SERVER_ENTITY_TYPE

            EntityGuid = {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}

            EntityName = ""

            EntityFlags = 0x00000900
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Get() - hr = 0x0
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Get() - Parent = MACHINE , Entity = DEVICE
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

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

            EntityType = DEVICE_ENTITY_TYPE

            EntityGuid = {CB835753-69DA-4BDC-B0BF-0BB331565B92}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Get() - hr = 0x0
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = DEVICE_POOL_ENTITY_TYPE

            ParentEntityGuid = {CB835753-69DA-4BDC-B0BF-0BB331565B92}

            EntityType = DEVICE_POOL_DEVICE_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:59] [0664]     01 No archive option installed. EV Embedded status defaults to true and not supported version.
BESERVER: [07/21/11 11:38:59] [0664]     01 ServerConfigBO:GetFeatureText, The Unknown Option's ID is 97
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Execute() - hr = 0x0
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = LIBRARY_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Get() - Parent = MACHINE , Entity = DEVICE
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

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

            EntityType = DEVICE_ENTITY_TYPE

            EntityGuid = {CB835753-69DA-4BDC-B0BF-0BB331565B92}

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Get() - hr = 0x0
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = DEVICE_POOL_ENTITY_TYPE

            ParentEntityGuid = {CB835753-69DA-4BDC-B0BF-0BB331565B92}

            EntityType = DEVICE_POOL_DEVICE_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:59] [0664]     01 No archive option installed. EV Embedded status defaults to true and not supported version.
BESERVER: [07/21/11 11:38:59] [0664]     01 ServerConfigBO:GetFeatureText, The Unknown Option's ID is 97
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Execute() - hr = 0x0
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = BACKUP_TO_DISK_ENTITY_TYPE

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

            EntityName = ""

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:59] [0664]     05 AdammAdminBO::Execute() - hr = 0x0
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = DRIVE_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
PVLSVR:   [07/21/11 11:38:59] [6428]     PvlEntityDatabase::QueryEntity()

            ParentEntityType = MACHINE_ENTITY_TYPE

            ParentEntityGuid = {D4191497-20C3-46CA-BDB2-CD9C809C2D78}

            EntityType = LIBRARY_ENTITY_TYPE

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

            EntityName = "

            EntityFlags = 0x00000000
BESERVER: [07/21/11 11:38:59] [4724]     -1 ActiveState::doDispatch( :( 'client.<fqdn>-Dedup-Dag Duplicate'
BESERVER: [07/21/11 11:38:59] [0664]     16 JobManager: Sending History Update VSN, count:1.
BESERVER: [07/21/11 11:38:59] [4724]     -1 LocalSvr, runTask():{1391e3bb-5b5b-454f-b123-3bf66afe80d1}
BESERVER: [07/21/11 11:38:59] [4724]     -1 BengineWrapper runtask() start
BESERVER: [07/21/11 11:38:59] [4724]     -1 BengineWrapper JobEngine.Open() OK
BESERVER: [07/21/11 11:38:59] [6164]     -1 Client requested key (1311241307).
BESERVER: [07/21/11 11:38:59] [6164]     01 Server Configuration: Client added: 10
BESERVER: [07/21/11 11:38:59] [6164]     -1 Client 'BACKUPSRV' connected('','DOMAIN\administrator'): 0xcd72670
BESERVER: [07/21/11 11:38:59] [0664]     16 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
BESERVER: [07/21/11 11:38:59] [6164]     15 GetSummary: SJ=41 SEJ=7 CJ=0 FJ=13 UM=0 BB=-1435697714 MJ=0 RecoveredJ=0 ResumedJ=0 FeatureRecommend=0
BENGINE:  [07/21/11 11:38:59] [6728]     [server]             - JobEngine::LaunchJob
BENGINE:  [07/21/11 11:38:59] [6728]     [server]             - RunJobWithGuidAndServer( {1391E3BB-5B5B-454F-B123-3BF66AFE80D1}, BACKUPSRV ) = 0
BESERVER: [07/21/11 11:38:59] [4724]     -1 BengineWrapper JobEngine.RunJobWithGuidAndServer() rc=0
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Thread for job client.<fqdn>-Dedup-Dag Duplicate ({1391E3BB-5B5B-454F-B123-3BF66AFE80D1}) starting
BESERVER: [07/21/11 11:38:59] [4724]     -1 JobManager: BengineWrapper RunJob() done
BESERVER: [07/21/11 11:38:59] [4724]     12 LocalSvr, RunTask: EngineHandedJob SUCCESS, jobid:{1391e3bb-5b5b-454f-b123-3bf66afe80d1}.
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - ******  SetCopy Job Settings  ******
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -  Oper Type: 300
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -   Job Name:
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -     Method: Normal Copy
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -      Source Device Pool: {81574B9B-80EC-4B75-AAE8-61C6A2A9A5BC}
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Destination Device Pool: {CB835753-69DA-4BDC-B0BF-0BB331565B92}
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Destination Media  Set : {9F8D702B-2F96-42F8-9882-FB14C4A6E74A}
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Destination Device Name:
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Destination Media  Name:
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Backup Set  Description:
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Append/Overwrite: Append
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Append/Terminate: Overwrite
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -     Catalog Type: Partial Catalogs
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -  Write Checksums: Checksums
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -     Verify After: Run AutoVerify
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -      Verify Type: Verify Checksums
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -      Eject Media: Do Not Eject
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -  Retension Media: Do Not Retension
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Hardware Comprsn: Hardware Compress
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Software Comprsn: No Compression
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - SW Comp if no HW: No Compression
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - DirectCopy To Tape: Enabled
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -       PreCommand:
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -      PostCommand:
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -  Password Length: 0
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Password Enc Alg: 0
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -   Print Log File: Do Not Print
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             -   PDI temp path: C:\TEMP
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - ******  End of SetCopy Job Settings  ******
BENGINE:  [07/21/11 11:38:59] [5176]     [server]             - Updating status for: 'client.<fqdn>-Dedup-Dag Duplicate' (0x0 0x0)
BENGINE:  [07/21/11 11:38:59] [5176]     [server]             - Status for: 'client.<fqdn>-Dedup-Dag Duplicate' updated
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Checking for Evaluation expiration.
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Removing 'client.<fqdn>-Dedup-Dag Duplicate' from status update list
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Updating status for: 'client.<fqdn>-Dedup-Dag Duplicate' (0x18 0x0)
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Status for: 'client.<fqdn>-Dedup-Dag Duplicate' updated
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Merging of BE / VSR Job Logs not necessary for this Type of Job
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Ending job 'client.<fqdn>-Dedup-Dag Duplicate' with error status (-536837678)
BESERVER: [07/21/11 11:38:59] [6892]     16 JobManager::HandleEndJob() called
BESERVER: [07/21/11 11:38:59] [4876]     -1 ActiveState::doEndEvent( :( 'client.<fqdn>-Dedup-Dag Duplicate'
BESERVER: [07/21/11 11:38:59] [4876]     16 JobManager::DoJobCompletionTasks(client.<fqdn>-Dedup-Dag Duplicate): GetFinalJobStatus()=6
BENGINE:  [07/21/11 11:38:59] [2620]     [server]             - Job thread terminating
BESERVER: [07/21/11 11:38:59] [4876]     16 JobManager::DoJobCompletionTasks() Handling normal JOB_STATE_ERROR
BESERVER: [07/21/11 11:38:59] [6892]     01 Server Configuration: Client removed: 9
BESERVER: [07/21/11 11:38:59] [6892]     -1 Client 'BACKUPSRV' Disconnected:0xcd72670
BESERVER: [07/21/11 11:38:59] [4876]     16 JobManager::DoJobCompletionTasks() Finished building JOB_STATE_ERROR message
BESERVER: [07/21/11 11:38:59] [4876]     17 Alert Job Failed, Notify: No, EventLog: Yes, Trap: No
BESERVER: [07/21/11 11:38:59] [4876]     -1 ActiveState::doEndEvent( :( CJobManager::DoJobCompletionTasks() returned 0x0
BESERVER: [07/21/11 11:38:59] [6500]     15 GetSummary: SJ=41 SEJ=7 CJ=0 FJ=14 UM=0 BB=-1435697714 MJ=0 RecoveredJ=0 ResumedJ=0 FeatureRecommend=0
BESERVER: [07/21/11 11:39:04] [6500]     -1 Released virtual array rowset(108).
BESERVER: [07/21/11 11:39:04] [6500]     -1 Registered virtual array rowset(109): Client:BACKUPSRV, Type:MD_OBJTYPE_JOBHISTORYVIEW
BESERVER: [07/21/11 11:39:04] [0664]     16 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR

 

4 REPLIES 4

Riyaj_S
Moderator
Moderator
Employee Accredited Certified

Few questions ,

1) Is backup job set to use Media Server side deduplication or Client side deduplication. ?

2) Are you backing up server over the WAN link ?

3) Run dsstat and provide dedup statistics : http://www.symantec.com/docs/TECH154127

4) Is it happening only when backing up specific data like Database, Files, Share ?

5) Is it happening only on one server or multiple servers (all) ?

boucherjeanfra
Not applicable

 

1) Is backup job set to use Media Server side deduplication or Client side deduplication. ?

Client side.

2) Are you backing up server over the WAN link ?

No.

3) Run dsstat and provide dedup statistics : http://www.symantec.com/docs/TECH154127

I'm trying to access the page but it won't load.

4) Is it happening only when backing up specific data like Database, Files, Share ?

Files

5) Is it happening only on one server or multiple servers (all) ?

All my file servers.

Simon_B_
Level 6
Partner Accredited

Retry accessing the link, it will load eventually. If not:

  • Open a command prompt
  • Switch to the BE installation directory 
  • Run crcontrol --dsstat
  • Post the output

Furthermore make sure you have installed the latest available hotfixes as there were some HF improving Dedup functionality for R3 iirc.

itdcysa
Level 3

Here is the result :

************ Data Store statistics ************

Data storage       Size   Used  Avail Use%
                   6.0T   2.3T   3.7T  38%
Number of containers             : 15529
Average container size           : 267910229 bytes (255.50MB)
Space allocated for containers   : 4160377946568 bytes (3.78TB)
Space used within containers     : 4160298751298 bytes (3.78TB)
Space available within containers: 79195270 bytes (75.53MB)
Space needs compaction           : 1699257381464 bytes (1.55TB)
Records marked for compaction    : 15424315
Active records                   : 19863719
Total records                    : 35288034
 
Use "--dsstat 1" to get more accurate statistics