Re: Backup Exec Remote Agent for Windows Servers s...

harjinder_singh · ‎10-12-2006

Hi,

I am facing this huge problem with Symantec Backup Exec 10d for Windows Servers that remote agent is keep on cradfshing at different stages of the backup.

following are the log files from SGMON

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

Capturing to C:\Program Files\VERITAS\Backup Exec\NT\logs\SGMon.log
beserver: 10/12/06 15:08:37 -1 Client requested key.
beserver: 10/12/06 15:08:37 -1 Client 'BACKUPSRV' connected('','LOGICOM\administrator'): 0x1106ee0
beserver: 10/12/06 15:08:37 -1 Client 'BACKUPSRV' Disconnected:0x1106ee0
beserver: 10/12/06 15:08:43 -1 Client requested key.
beserver: 10/12/06 15:08:43 -1 Client 'BACKUPSRV' connected('','LOGICOM\administrator'): 0x1106ee0
beserver: 10/12/06 15:08:43 -1 Client requested key.
beserver: 10/12/06 15:08:43 -1 Client 'BACKUPSRV' connected('','LOGICOM\administrator'): 0x10fb070
beserver: 10/12/06 15:08:43 12 AdammAdminBO::Execute() - ADAMM_ADMIN_QUERY_ENTITY_BY_NAME.
beserver: 10/12/06 15:08:43 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 10/12/06 15:08:43 12 AdammAdminBO::Query() - Parent = NULL , Entity = PVL
beserver: 10/12/06 15:08:43 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = NULL , Entity = MEDIA_TYPE
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = NULL , Entity = MACHINE
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = NULL , Entity = DEVICE
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = NULL , Entity = DEVICE_POOL_DEVICE
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = NULL , Entity = PARTITION
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = NULL , Entity = SLOT
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = BACKUP_TO_DISK
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = NULL , Entity = DEVICE_POOL
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = DRIVE
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = CHANGER
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = NULL , Entity = MEDIA_SET
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = NULL , Entity = VAULT
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = NULL , Entity = VAULT_MEDIA_RULE
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - Parent = NULL , Entity = MEDIA_SET_VAULT_MEDIA_RULE
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = DRIVE
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = MACHINE , Entity = BACKUP_TO_DISK
beserver: 10/12/06 15:08:44 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 10/12/06 15:08:45 16 GetSummary: SJ=5 SEJ=0 CJ=0 FJ=2 UM=153 BB=647452458
beserver: 10/12/06 15:08:45 -1 Registered virtual array rowset(5): Client:BACKUPSRV, Type:MD_OBJTYPE_JOBHISTORYVIEW
beserver: 10/12/06 15:08:45 17 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
beserver: 10/12/06 15:08:46 -1 SQLLog(8):AgeSession m_threadMap: SessionThreadID:4c0, CurrentThreadID:cc8
beserver: 10/12/06 15:08:54 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = BACKUP_TO_DISK , Entity = MEDIA
beserver: 10/12/06 15:08:54 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 10/12/06 15:08:54 12 AdammAdminBO::Query() - Parent = BACKUP_TO_DISK , Entity = MEDIA
beserver: 10/12/06 15:08:54 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:08:58 17 CJobManagerBO::Query old QUERY
beserver: 10/12/06 15:08:59 12 AdammAdminBO::Query() - Parent = NULL , Entity = DEVICE
beserver: 10/12/06 15:08:59 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:09:00 -1 Job Manager: LoadJob() request completed
beserver: 10/12/06 15:09:00 17 JobManager::UpdateJobInstanceData() new task state=22
beserver: 10/12/06 15:09:00 20 Auto Clear Alerts Query
beserver: 10/12/06 15:09:00 -1 Job Manager: LoadJob() request completed
beserver: 10/12/06 15:09:00 17 JobManager::UpdateJobInstanceData() new task state=22
beserver: 10/12/06 15:09:00 -1 Job Manager: LoadJob() request completed
beserver: 10/12/06 15:09:00 17 JobManager::UpdateJobInstanceData() new task state=22
beserver: 10/12/06 15:09:00 -1 Job Manager: LoadJob() request completed
beserver: 10/12/06 15:09:00 17 JobManager::UpdateJobInstanceData() new task state=22
beserver: 10/12/06 15:09:00 12 AdammAdminBO::Delete() - Entity = BACKUP_TO_DISK
beserver: 10/12/06 15:09:00 17 CJobManagerBO::Query QUERY_JOB_TARGETMEDIASET_FILTER
beserver: 10/12/06 15:09:00 12 AdammAdminBO::Get() - Parent = NULL , Entity = BACKUP_TO_DISK
beserver: 10/12/06 15:09:01 12 AdammAdminBO::Get() - hr = 0x0
beserver: 10/12/06 15:09:01 -1 Client requested key.
beserver: 10/12/06 15:09:01 -1 Client 'BACKUPSRV' connected('','LOGICOM\administrator'): 0x1106ef0
beserver: 10/12/06 15:09:01 17 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
beserver: 10/12/06 15:09:01 12 AdammAdminBO:Delete() - hr = 0x0
beserver: 10/12/06 15:09:01 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = BACKUP_TO_DISK , Entity = MEDIA
beserver: 10/12/06 15:09:01 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 10/12/06 15:09:01 12 AdammAdminBO::Query() - Parent = BACKUP_TO_DISK , Entity = MEDIA
beserver: 10/12/06 15:09:01 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:09:06 17 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
beserver: 10/12/06 15:09:21 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = BACKUP_TO_DISK
beserver: 10/12/06 15:09:21 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:09:21 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = BACKUP_TO_DISK , Entity = MEDIA
beserver: 10/12/06 15:09:21 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 10/12/06 15:09:21 12 AdammAdminBO::Query() - Parent = BACKUP_TO_DISK , Entity = MEDIA
beserver: 10/12/06 15:09:21 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:09:28 12 AdammAdminBO::Insert() - Parent = NULL , Entity = BACKUP_TO_DISK
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Insert() - hr = 0x0
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = BACKUP_TO_DISK , Entity = MEDIA
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = BACKUP_TO_DISK , Entity = MEDIA
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = BACKUP_TO_DISK , Entity = MEDIA
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = BACKUP_TO_DISK , Entity = MEDIA
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = BACKUP_TO_DISK , Entity = MEDIA
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Execute() - ADAMM_ADMIN_RECORD_COUNT - Parent = BACKUP_TO_DISK , Entity = MEDIA
beserver: 10/12/06 15:09:29 12 AdammAdminBO::Execute() - hr = 0x0
beserver: 10/12/06 15:09:32 -1 Client 'BACKUPSRV' Disconnected:0x10fb070
beserver: 10/12/06 15:09:32 -1 Client requested key.
beserver: 10/12/06 15:09:32 -1 Client 'BACKUPSRV' connected('','LOGICOM\administrator'): 0x10fb070
beremote: 10/12/06 15:09:32 DS_LogonSelectionService: LOGICOM\administrator
beserver: 10/12/06 15:09:32 -1 Client requested key.
beserver: 10/12/06 15:09:32 -1 Client 'BACKUPSRV' connected('','NT AUTHORITY\SYSTEM'): 0x1108a20
beremote: 10/12/06 15:09:32 DsWorkerThread starting as LOGICOM\administrator
beremote: 10/12/06 15:09:32
SMSAPIShim: Using BESMDR.DLL.
beremote: 10/12/06 15:09:33 Informational: Restrict Anonymous Support is enabled
beremote: 10/12/06 15:09:33 Informational: Restrict Anonymous Support is enabled
beremote: 10/12/06 15:09:33 Informational: Restrict Anonymous Support is enabled
beremote: 10/12/06 15:09:33 Informational: Restrict Anonymous Support is enabled
beremote: 10/12/06 15:09:33 Informational: Restrict Anonymous Support is enabled
beremote: 10/12/06 15:09:33 SQL2_FindDrives - the default SQL Service is not running on BACKUPSRV.
beremote: 10/12/06 15:09:33 SQL2_FindDrives - checking named instance BKUPEXEC.
beremote: 10/12/06 15:09:33 Found SOFTWARE\MICROSOFT\Microsoft SQL Server\BKUPEXEC in the registry.
beremote: 10/12/06 15:09:33 isClusterOK returning 1
beremote: 10/12/06 15:09:33 SQL2_CreateDLE - creating BACKUPSRV\BKUPEXEC.
beremote: 10/12/06 15:09:33 Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
beremote: 10/12/06 15:09:33 AddESE_DLEs( )
beremote: 10/12/06 15:09:33 first load attempt of esebcli2.dll failed: The specified module could not be found.
beremote: 10/12/06 15:09:33 second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
beremote: 10/12/06 15:09:33 third load attempt failed from path = '': The specified module could not be found.
beremote: 10/12/06 15:09:33 Looking for esebcli2.dll in sysetm path
beremote: 10/12/06 15:09:33 never found EseBcli2.dll
beremote: 10/12/06 15:09:33 esebcli2.dll not loaded
beremote: 10/12/06 15:09:33 No utility partitions found on any of the disks
beremote: 10/12/06 15:09:33 Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:705
beremote: 10/12/06 15:09:33 Informational: Cps library not available. Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:709
beremote: 10/12/06 15:09:33 ENTER DPM::FindDrives
beremote: 10/12/06 15:09:33 ENTER DPM::IsServicePresent
beremote: 10/12/06 15:09:33 DPM: Failed OpenService
beremote: 10/12/06 15:09:33 DPM: Service is present:
beremote: 10/12/06 15:09:33 EXIT DPM::IsServicePresent
beremote: 10/12/06 15:09:33 DPM: DPM Service not present
beremote: 10/12/06 15:09:33 EXIT DPM::FindDrives return=
beserver: 10/12/06 15:09:33 -1 Client 'BACKUPSRV' Disconnected:0x1108a20
beserver: 10/12/06 15:09:33 -1 Client requested key.
beserver: 10/12/06 15:09:33 -1 Client 'BACKUPSRV' connected('','NT AUTHORITY\SYSTEM'): 0x1108a20
beserver: 10/12/06 15:09:33 -1 Client 'BACKUPSRV' Disconnected:0x1108a20
beremote: 10/12/06 15:09:33 FS_ResolveDevName
beremote: 10/12/06 15:09:33 FS_ResolveDevName
beremote: 10/12/06 15:09:33 FS_ResolveDevName
beremote: 10/12/06 15:09:33 FS_ResolveDevName
beremote: 10/12/06 15:09:35 FS_ResolveDevName
beserver: 10/12/06 15:09:35 -1 Client requested key.
beserver: 10/12/06 15:09:35 -1 Client 'BACKUPSRV' connected('','NT AUTHORITY\SYSTEM'): 0x1106f00
beremote: 10/12/06 15:09:35 machine name = LOGNAV02
beremote: 10/12/06 15:09:35 ndmpConnect : Control Connection information : connection established between IP 192.168.0.242, port 1107 and IP 192.168.0.110, port 10000
beremote: 10/12/06 15:09:35 NDMP version 3 connection CONNECTED
beserver: 10/12/06 15:09:36 -1 Client 'BACKUPSRV' Disconnected:0x1106f00
beremote: 10/12/06 15:09:38 FS_ResolveDevName
beremote: 10/12/06 15:09:38 machine name = LOGNAV02
beremote: 10/12/06 15:09:40 FS_ResolveDevName
beremote: 10/12/06 15:09:40 machine name = LOGNAV02
beremote: 10/12/06 15:09:48 FS_ResolveDevName
beremote: 10/12/06 15:09:48 machine name = LOGNAV02
beremote: 10/12/06 15:09:54 FS_ResolveDevName
beremote: 10/12/06 15:09:54 machine name = LOGNAV02
beremote: 10/12/06 15:10:00 FS_ResolveDevName
beremote: 10/12/06 15:10:00 machine name = LOGNAV02
beserver: 10/12/06 15:10:00 20 Auto Clear Alerts Query
beremote: 10/12/06 15:10:34 DS_CloseSelectionService
beremote: 10/12/06 15:10:34 DsWorkerThread terminating with exit code 0
beserver: 10/12/06 15:10:34 -1 Job Manager: LoadJob() request completed
beserver: 10/12/06 15:10:38 12 AdammAdminBO::Query() - Parent = NULL , Entity = MACHINE
beserver: 10/12/06 15:10:39 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:10:39 12 AdammAdminBO::Query() - Parent = NULL , Entity = DEVICE_POOL
beserver: 10/12/06 15:10:39 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:10:39 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = DRIVE
beserver: 10/12/06 15:10:39 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:10:39 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = BACKUP_TO_DISK
beserver: 10/12/06 15:10:39 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:10:39 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = DRIVE_POOL_DRIVE
beserver: 10/12/06 15:10:39 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:10:39 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = CHANGER
beserver: 10/12/06 15:10:39 12 AdammAdminBO::Query() - hr = 0x0
beserver: 10/12/06 15:10:39 -1 ActiveState::doDispatch( :( 'Backup 00040'
beserver: 10/12/06 15:10:39 -1 LocalSvr, runTask():{24280d0b-c60d-4ec1-963f-179a25986bb5}
beserver: 10/12/06 15:10:39 -1 BengineWrapper runtask() start
beserver: 10/12/06 15:10:39 17 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
beserver: 10/12/06 15:10:39 -1 BengineWrapper JobEngine.Open() OK
beserver: 10/12/06 15:10:39 -1 Client requested key.
beserver: 10/12/06 15:10:39 -1 Client 'BACKUPSRV' connected('','LOGICOM\administrator'): 0x10bb740
bengine: 10/12/06 15:10:39 JobEngine::LaunchJob
bengine: 10/12/06 15:10:39 RunJobWithGuidAndServer( {24280D0B-C60D-4EC1-963F-179A25986BB5}, BACKUPSRV ) = 0
bengine: 10/12/06 15:10:39 Thread for job Backup 00040 ({24280D0B-C60D-4EC1-963F-179A25986BB5}) starting
beserver: 10/12/06 15:10:39 -1 BengineWrapper JobEngine.RunJobWithGuidAndServer() rc=0
beserver: 10/12/06 15:10:39 -1 JobManager: BengineWrapper RunJob() done
beserver: 10/12/06 15:10:39 11 LocalSvr, RunTask: EngineHandedJob SUCCESS, jobid:{24280d0b-c60d-4ec1-963f-179a25986bb5}.
beserver: 10/12/06 15:10:39 -1 Client requested key.
beserver: 10/12/06 15:10:39 -1 Client 'BACKUPSRV' connected('','LOGICOM\administrator'): 0x10a48a8
beserver: 10/12/06 15:10:39 -1 Client 'BACKUPSRV' Disconnected:0x10a48a8
bengine: 10/12/06 15:10:39 Checking for Evaluation expiration.
bengine: 10/12/06 15:10:39 ENGSCRPT: ConvertDeviceName osId = 0Xe
bengine: 10/12/06 15:10:39 ENGSCRPT: IN - oldDeviceName = \\LOGNAV02\C:
bengine: 10/12/06 15:10:39 ENGSCRPT: OUT - newName = \\LOGNAV02\C:
bengine: 10/12/06 15:10:39 ENGSCRPT: ConvertDeviceName osId = 0Xe
bengine: 10/12/06 15:10:39 ENGSCRPT: IN - oldDeviceName = \\LOGNAV02\C:
bengine: 10/12/06 15:10:39 ENGSCRPT: OUT - newName = \\LOGNAV02\C:
bengine: 10/12/06 15:10:39 ENGSCRPT: ConvertDeviceName osId = 0Xe
bengine: 10/12/06 15:10:39 ENGSCRPT: IN - oldDeviceName = \\LOGNAV02\C:
bengine: 10/12/06 15:10:39 ENGSCRPT: OUT - newName = \\LOGNAV02\C:
bengine: 10/12/06 15:10:39 ENGSCRPT: ConvertDeviceName osId = 0Xe
bengine: 10/12/06 15:10:39 ENGSCRPT: IN - oldDeviceName = \\LOGNAV02\C:
bengine: 10/12/06 15:10:40 ENGSCRPT: OUT - newName = \\LOGNAV02\C:
bengine: 10/12/06 15:10:40 ENGSCRPT: ConvertDeviceName osId = 0X2f
bengine: 10/12/06 15:10:40 ENGSCRPT: IN - oldDeviceName = \\LOGNAV02\Shadow?Copy?Components
bengine: 10/12/06 15:10:40 ENGSCRPT: OUT - newName = \\LOGNAV02\Shadow?Copy?Components
bengine: 10/12/06 15:10:40 ENGSCRPT: ConvertDeviceName osId = 0X2f
bengine: 10/12/06 15:10:40 ENGSCRPT: IN - oldDeviceName = \\LOGNAV02\Shadow?Copy?Components
bengine: 10/12/06 15:10:40 ENGSCRPT: OUT - newName = \\LOGNAV02\Shadow?Copy?Components
bengine: 10/12/06 15:10:40 ENGSCRPT: No script found
bengine: 10/12/06 15:10:40 DeviceManager: incoming event fired
bengine: 10/12/06 15:10:40 DeviceManager: processing pending requests
bengine: 10/12/06 15:10:40 DeviceManager: query cache miss
bengine: 10/12/06 15:10:40 Available and held drives from the pool
bengine: 10/12/06 15:10:40 LOGNAV02 {add6263a-c7c5-433b-8f4f-83b3ae1a3298}.0
bengine: 10/12/06 15:10:40 Drives not in use by the Engine
bengine: 10/12/06 15:10:40 LOGNAV02 {add6263a-c7c5-433b-8f4f-83b3ae1a3298}.0
bengine: 10/12/06 15:10:40 Drives available (not in use and not held)
bengine: 10/12/06 15:10:40 LOGNAV02 {add6263a-c7c5-433b-8f4f-83b3ae1a3298}.0
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 00010003, ... )
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 00010004, ... )
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:40 Handing out session {99b9e13a-008d-4b9e-aa29-19dd9df246d7} based on available drive:
bengine: 10/12/06 15:10:40 LOGNAV02 {add6263a-c7c5-433b-8f4f-83b3ae1a3298}.0
bengine: 10/12/06 15:10:40 DeviceManager: going to sleep for 900000 msecs
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 00010001, ... )
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:40 BackupJob: acquired device LOGNAV02
bengine: 10/12/06 15:10:40 BackupJob: trying to mount appending volume
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 00020101, ... )
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned E000810D
bengine: 10/12/06 15:10:40 BackupJob: unable to mount appending volume, attempting scratch mount
bengine: 10/12/06 15:10:40 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 00020102, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 Updating session {99b9e13a-008d-4b9e-aa29-19dd9df246d7} with drive LOGNAV02 {add6263a-c7c5-433b-8f4f-83b3ae1a3298}.1
bengine: 10/12/06 15:10:43 Block size: 1024
bengine: 10/12/06 15:10:43 Buffer size: 32768
bengine: 10/12/06 15:10:43 Num buffers: 10
bengine: 10/12/06 15:10:43 High water: 7
bengine: 10/12/06 15:10:43 BackupJob: medium successfully mounted
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 Media Label: B2D000168
bengine: 10/12/06 15:10:43 Media Label: {95ef2b20-2f36-469c-b66b-3eff0cc64303}
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 Overwrite Protected Until: 12/31/9999 2:00:00 AM
bengine: 10/12/06 15:10:43 Appendable Until: 12/31/9999 2:00:00 AM
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0002FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 TAPEALERT: TapeAlert Device Flag = 0X0
bengine: 10/12/06 15:10:43 TAPEALERT: TapeAlert Changer Flag = 0X0
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0002FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0002FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:43 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:43 Failed to Load Software\VERITAS\Backup Exec\Engine\IDR key, We will update DR file evenif there are userExcludes. Error: 2
bengine: 10/12/06 15:10:43 Failed to Load Software\VERITAS\Backup Exec\Engine\IDR key, We will update DR file evenif there are userExcludes. Error: 2
bengine: 10/12/06 15:10:44 Informational: Subnet Address 192.168.0.0 specified
bengine: 10/12/06 15:10:44 Informational: Subnet Mask 255.255.255.0 input
bengine: 10/12/06 15:10:44 Informational: Local network address 192.168.0.242 returned
bengine: 10/12/06 15:10:44 Informational: Local network address 192.168.0.242 obtained in the subnet specified
bengine: 10/12/06 15:10:44 ndmpConnect : Control Connection information : connection established between IP 192.168.0.242, port 1109 and IP 192.168.0.110, port 10000
bengine: 10/12/06 15:10:44 NDMP version 3 connection CONNECTED
beserver: 10/12/06 15:10:44 17 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
bengine: 10/12/06 15:10:45 Single logical volume snapshot is enabled for this job.
bengine: 10/12/06 15:10:45 BESC: Parsing OS version info -
bengine: 10/12/06 15:10:45 ndmpcSnapshotPrepare: adding selection string for device_name: \\LOGNAV02\C:
bengine: 10/12/06 15:10:45 ndmpcSnapshotPrepare2: selection string: "\\LOGNAV02\C:\*.*",s,v0,t0,l0,n0,f0
bengine: 10/12/06 15:10:45 ndmpcSnapshotPrepare2: selection string: "\\LOGNAV02\C:\WINDOWS\system32\wbem\*.*",s,x,v0,t0,l0,n0,f0
bengine: 10/12/06 15:10:45 ndmpcSnapshotPrepare2: selection string: "\\LOGNAV02\C:\WINDOWS\Windows Update.log",x,v0,t0,l0,n0,f0
bengine: 10/12/06 15:10:45 ndmpcSnapshotPrepare2: selection string: "\\LOGNAV02\C:\WINDOWS\WindowsUpdate.log",x,v0,t0,l0,n0,f0
beserver: 10/12/06 15:10:47 -1 SQLLog(9):AgeSession m_threadMap: SessionThreadID:c54, CurrentThreadID:e8
beserver: 10/12/06 15:10:47 -1 SQLLog(10):AgeSession m_threadMap: SessionThreadID:cc8, CurrentThreadID:e8
beserver: 10/12/06 15:10:47 -1 SQLLog(11):AgeSession m_threadMap: SessionThreadID:e7c, CurrentThreadID:e8
beserver: 10/12/06 15:10:50 17 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
bengine: 10/12/06 15:10:54 ndmpcSnapshotPrepare2: Completed with status: 0
bengine: 10/12/06 15:10:54 TF_OpenTape()
bengine: 10/12/06 15:10:54 TF_GetChannel( ) allocated channel 01A211C8
bengine: 10/12/06 15:10:54 TF_GetDriveContext ...
sessionGuid = {99b9e13a-008d-4b9e-aa29-19dd9df246d7}
initAsync = 1
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:54 HARDWARE COMPRESSION ===> Compression is NOT configurable.
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:54 GET_DRV_INF: bsize = 1024
bengine: 10/12/06 15:10:54 TF_GetDriveContext returning 0, context = 1A48FD8
bengine: 10/12/06 15:10:54 Allocated 2 buffers, size 32768 bytes, total used: 65720
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:54 HARDWARE COMPRESSION ===> Compression is NOT configurable.
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:54 GET_DRV_INF: bsize = 1024
bengine: 10/12/06 15:10:54 Media Server to initiate connection for data transfer
bengine: 10/12/06 15:10:54 TF_OpenSet( )
bengine: 10/12/06 15:10:54 FreeFormatEnv( cur_fmt=65535 )
bengine: 10/12/06 15:10:54 RewindDrive mover ret = 0 (0x0)
bengine: 10/12/06 15:10:54 ret_val = 0
bengine: 10/12/06 15:10:54 Requested Set: ID = ffffffff Seq = -1 Set = -1
bengine: 10/12/06 15:10:54 Attempting to VCB storage media
bengine: 10/12/06 15:10:54 TpRead( :(
bengine: 10/12/06 15:10:54 Error = 1101 Req = 6144 Got = 1024
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:54 HARDWARE COMPRESSION ===> Compression is NOT configurable.
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:54 GET_DRV_INF: bsize = 1024
bengine: 10/12/06 15:10:54 FreeFormatEnv( cur_fmt=65535 )
bengine: 10/12/06 15:10:54 SetupFormatEnv( fmt=0 )
bengine: 10/12/06 15:10:54 TpRead( :(
bengine: 10/12/06 15:10:54 Error = 1104 Req = 6144 Got = 0
bengine: 10/12/06 15:10:54 FreeFormatEnv( cur_fmt=0 )
bengine: 10/12/06 15:10:54 RewindDrive mover ret = 0 (0x0)
bengine: 10/12/06 15:10:54 ret_val = 0
bengine: 10/12/06 15:10:54 PositionAtSet( :( TF Msg = e
bengine: 10/12/06 15:10:54 RewindDrive mover ret = 0 (0x0)
bengine: 10/12/06 15:10:54 ret_val = 0
bengine: 10/12/06 15:10:54 RewindDrive mover ret = 0 (0x0)
bengine: 10/12/06 15:10:54 ret_val = 0
bengine: 10/12/06 15:10:54 UI Msg = 8003
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:54 HARDWARE COMPRESSION ===> Compression is NOT configurable.
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): Calling m_pAdammSession_Real->Execute( 0001FF00, ... )
bengine: 10/12/06 15:10:54 AdammSession_Proxy::Execute(): m_pAdammSession_Real->Execute() returned 00000000
bengine: 10/12/06 15:10:54 GET_DRV_INF: bsize = 1024
bengine: 10/12/06 15:10:54 RewindDrive mover ret = 0 (0x0)
bengine: 10/12/06 15:10:54 ret_val = 0
bengine: 10/12/06 15:10:55 FreeFormatEnv( cur_fmt=65535 )
bengine: 10/12/06 15:10:55 SetupFormatEnv( fmt=0 )
bengine: 10/12/06 15:10:55 End of TF_OpenSet: Ret_val = 0 Buffs = 2 HiWater = 7
bengine: 10/12/06 15:10:55 B2D Buffered Writes ===> Setting buffering to default.
bengine: 10/12/06 15:10:55 WriteEndSet( 1 ) returning 0
bengine: 10/12/06 15:10:55 Current Block is = 3
bengine: 10/12/06 15:10:56 Informational: Subnet Address 192.168.0.0 specified
bengine: 10/12/06 15:10:56 Informational: Subnet Mask 255.255.255.0 input
bengine: 10/12/06 15:10:56 Informational: Local network address 192.168.0.242 returned
bengine: 10/12/06 15:10:56 Informational: Local network address 192.168.0.242 obtained in the subnet specified
bengine: 10/12/06 15:10:56 TF_InitMediaServerReverseConnection : Data Connection information : connection established between IP 192.168.0.242, port 1117 and IP 192.168.0.110, port 1270
bengine: 10/12/06 15:10:57
dataStartBackup: ndmpSendRequest returned: 0x0, 0
beserver: 10/12/06 15:11:02 20 Auto Clear Alerts Query
beserver: 10/12/06 15:11:11 12 AdammAdminBO::Get() - Parent = NULL , Entity = MEDIA
beserver: 10/12/06 15:11:11 12 AdammAdminBO::Get() - hr = 0x0
bengine: 10/12/06 15:11:12 TF_NDMPStartWrite(): Started new thread 3320
beserver: 10/12/06 15:12:03 20 Auto Clear Alerts Query
beserver: 10/12/06 15:12:47 -1 SQLLog(12):AgeSession m_threadMap: SessionThreadID:e8, CurrentThreadID:7ac
beserver: 10/12/06 15:12:47 -1 SQLLog(13):AgeSession m_threadMap: SessionThreadID:ad0, CurrentThreadID:7ac
beserver: 10/12/06 15:12:47 -1 SQLLog(14):AgeSession m_threadMap: SessionThreadID:c28, CurrentThreadID:7ac
beserver: 10/12/06 15:12:47 -1 SQLLog(15):AgeSession m_threadMap: SessionThreadID:dbc, CurrentThreadID:7ac
beserver: 10/12/06 15:12:47 -1 SQLLog(16):AgeSession m_threadMap: SessionThreadID:e20, CurrentThreadID:7ac
beserver: 10/12/06 15:12:47 -1 SQLLog(17):AgeSession m_threadMap: SessionThreadID:e24, CurrentThreadID:7ac
beserver: 10/12/06 15:13:04 20 Auto Clear Alerts Query
bengine: 10/12/06 15:13:45 ERROR: ndmpcSendRequest->connection error
bengine: 10/12/06 15:13:45 ERROR: ndmpSendRequest failed:
bengine: 10/12/06 15:13:45 NDMPEngine::PollDataServer(). dataGetDataState failed with NDMP_CONNECT_ERR !!
beserver: 10/12/06 15:14:06 20 Auto Clear Alerts Query
beserver: 10/12/06 15:14:48 -1 SQLLog(18):AgeSession m_threadMap: SessionThreadID:7ac, CurrentThreadID:a78
beserver: 10/12/06 15:15:07 20 Auto Clear Alerts Query
----------------------------------------------

file from remote agent after debug mode :

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

10/12/06 15:06:29 Opening debug log C:\Program Files\VERITAS\Backup Exec\RANT\logs\LOGNAV02-beremote00.log
10/12/06 15:06:29 CleanupOrphanedSnapshots(). Lauching cleanup thread..
10/12/06 15:06:29 CleanupOrphanedSnapshots(). Cleanup thread lauched. Exiting.
10/12/06 15:06:29 VssSnapshotVolume::CleanupOrphanedSnapshots(). No orphaned snaphots found
10/12/06 15:06:29 FS_InitFileSys
10/12/06 15:06:29 loaded bedsnt5.dll
10/12/06 15:06:29 loaded bedssql2.dll
10/12/06 15:06:29 loaded bedsxchg.dll
10/12/06 15:06:29 loaded bedsxese.dll
10/12/06 15:06:29 loaded bedsmbox.dll
10/12/06 15:06:29 bedspush.dll could not be loaded: The specified module could not be found.
10/12/06 15:06:29 loaded bedsnote.dll
10/12/06 15:06:29 loaded bedsmdoc.dll
10/12/06 15:06:29 loaded bedssps2.dll
10/12/06 15:06:29 loaded bedsupfs.dll
10/12/06 15:06:29 loaded bedsshadow.dll
10/12/06 15:06:29 loaded bedsoffhost.dll
10/12/06 15:06:29 ENTER DpmSettings::DpmSettings
10/12/06 15:06:29 EXIT DpmSettings::DpmSettings return=
10/12/06 15:06:29 loaded bedsdpm.dll
10/12/06 15:06:29 loaded bedscps.dll
10/12/06 15:06:29 bedsvx.dll could not be loaded: The specified module could not be found.
10/12/06 15:06:29 bedsorcl.dll could not be loaded: The specified module could not be found.
10/12/06 15:06:29 bedsagnt.dll could not be loaded: The specified module could not be found.
10/12/06 15:06:29 loaded bedssms.dll
10/12/06 15:06:29 loaded bedssmsp.dll
10/12/06 15:06:29 loaded bedsra.dll
10/12/06 15:06:29 Initializing FSs
10/12/06 15:06:29 This is NOT an Exchange server.
10/12/06 15:06:29 FS 12 failed to initialize: -536805818
10/12/06 15:06:29 unloading bedsmbox.dll
10/12/06 15:06:29 Notes Agent: NOTES_InitFileSys
10/12/06 15:06:29 Notes Agent: Lotus Notes not installed.
РyРyTEMROOT%\SYSTEM32\kbdazel.dll 10/12/06 15:06:29 Informational: BeDiskFind library 'BEDiskFind.dll' initialized in SHADOW::InitBeDiskFindHelperApis
10/12/06 15:06:29 Informational: Initializing the BeDisk library 'BeDisk.dll' in SHADOW::InitBeDiskHelperApis
10/12/06 15:06:29 Informational: BeDisk library 'BeDisk.dll' initialized in SHADOW::InitBeDiskHelperApis
10/12/06 15:06:29 first load attempt of esebcli2.dll failed: The specified module could not be found.
10/12/06 15:06:29 second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
10/12/06 15:06:29 third load attempt failed from path = '': The specified module could not be found.
10/12/06 15:06:29 Looking for esebcli2.dll in sysetm path
10/12/06 15:06:29 never found EseBcli2.dll
10/12/06 15:06:29 esebcli2.dll not loaded
10/12/06 15:06:29 Status Uknown (0x00000002) opening Cps registry key 'SOFTWARE\VERITAS\Backup Exec CPS' in CPS::InitCpsHelperApis:399
10/12/06 15:06:29 Informational: Initializing the Cps library 'C:\Program Files\VERITAS\Continuous Protection Server\Services\CPSVersion.dll' in CPS::InitCpsHelperApis:430
10/12/06 15:06:29 Status Uknown (0x0000007E) loading Cps library 'C:\Program Files\VERITAS\Continuous Protection Server\Services\CPSVersion.dll' in CPS::InitCpsHelperApis:437
10/12/06 15:06:29 Status Uknown (0x0000007E) initializing Cps library in CPS::InitFsys:103
10/12/06 15:06:29 ENTER DPM::InitFsys
10/12/06 15:06:29 ENTER DpmSettings::LoadSettings
10/12/06 15:06:29 DPM: Software\VERITAS\Backup Exec\Engine\Agents\DPM not found.
10/12/06 15:06:29 ENTER DpmSettings::Print
10/12/06 15:06:29
10/12/06 15:06:29 Software\VERITAS\Backup Exec\Engine\Agents\DPM
10/12/06 15:06:29 OnServer='\Volumes\Replica\'
10/12/06 15:06:29 VolumeKey='\Volumes\Replica\'
10/12/06 15:06:29 Replica='Replica'
10/12/06 15:06:29 ReplicaDir='ReplicaDir'
10/12/06 15:06:29 Dash='-'
10/12/06 15:06:29 WriterServiceName='DpmWriter'
10/12/06 15:06:29 ServiceName='MSDPM'
10/12/06 15:06:29 SqlInstance='$DPM$'
10/12/06 15:06:29 SecondsToWaitForDpm='90'
10/12/06 15:06:29 WriterStartType=DPM_WRITER_START_TYPE_INITFS
10/12/06 15:06:29 DpmCatalogMethod=CATALOG_TYPE_DEVICE_NAME
10/12/06 15:06:29 PsBackupType=PS_BACKUP_TYPE_COPY
10/12/06 15:06:29 EXIT DpmSettings::Print return=
10/12/06 15:06:29 EXIT DpmSettings::LoadSettings return=
10/12/06 15:06:29 ENTER DPM::IsServicePresent
10/12/06 15:06:29 DPM: Failed OpenService
10/12/06 15:06:29 DPM: Service is present:
10/12/06 15:06:29 EXIT DPM::IsServicePresent
10/12/06 15:06:29 DPM: Data Protection Manager not installed.
10/12/06 15:06:29 EXIT DPM::InitFsys return=
10/12/06 15:06:29 Listening on port 10000
10/12/06 15:06:29 Agent browser advertisement cycle complete. Advertisement interval is 60 minutes.
10/12/06 15:06:30 Running... 'Q' to stop
10/12/06 15:10:18 ndmpRun: Control Connection Accepted : connection established between IP 192.168.0.110, port 10000 and IP 192.168.0.242, port 1107
10/12/06 15:10:18 Successfully impersonated LOGICOM\administrator
10/12/06 15:10:18 WhoAmI( ) reports: LOGICOM\administrator
10/12/06 15:10:18 DS_OpenSelectionService
10/12/06 15:10:18
SMSAPIShim: Couldn't load BESMDR.DLL. No SMS support is loaded.
10/12/06 15:10:18 SQL2_FindDrives - a default SQL Service is installed on LOGNAV02.
10/12/06 15:10:18 Opened CurrentVersion registry key.
10/12/06 15:10:18 Retrieved CurrentVersion data.
10/12/06 15:10:18 SQL2_FindDrives - the default SQL Service appears to be SQL 2000.
10/12/06 15:10:18 Found SOFTWARE\MICROSOFT\MSSQLServer in the registry.
10/12/06 15:10:18 isClusterOK returning 0
10/12/06 15:10:18 SQL2_FindDrives - Sorry, not cluster OK.
10/12/06 15:10:19 Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
10/12/06 15:10:19 AddESE_DLEs( )
10/12/06 15:10:19 first load attempt of esebcli2.dll failed: The specified module could not be found.
10/12/06 15:10:19 second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
10/12/06 15:10:19 third load attempt failed from path = '': The specified module could not be found.
10/12/06 15:10:19 Looking for esebcli2.dll in sysetm path
10/12/06 15:10:19 never found EseBcli2.dll
10/12/06 15:10:19 esebcli2.dll not loaded
10/12/06 15:10:19 DeviceIOControl() Failed with error: 21
10/12/06 15:10:19 No utility partitions found on any of the disks
10/12/06 15:10:19 Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:705
10/12/06 15:10:19 Informational: Cps library not available. Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:709
10/12/06 15:10:19 ENTER DPM::FindDrives
10/12/06 15:10:19 ENTER DPM::IsServicePresent
10/12/06 15:10:19 DPM: Failed OpenService
10/12/06 15:10:19 DPM: Service is present:
10/12/06 15:10:19 EXIT DPM::IsServicePresent
10/12/06 15:10:19 DPM: DPM Service not present
10/12/06 15:10:19 EXIT DPM::FindDrives return=
10/12/06 15:10:19 FS_ResolveDevName
10/12/06 15:10:19 FS_CreateTempDLE
10/12/06 15:10:19 0 = 1
10/12/06 15:10:19 1 = 1
10/12/06 15:10:19 2 = 1
10/12/06 15:10:19 3 = 1
10/12/06 15:10:19 4 = 1
10/12/06 15:10:19 5 = 1
10/12/06 15:10:19 6 = 1
10/12/06 15:10:19 7 = 0
10/12/06 15:10:19 Error 0 on NetShareEnum of \\LOGNAV02, level 2
10/12/06 15:10:19 \\LOGNAV02 is clustered
10/12/06 15:10:19 \\LOGNAV02 is a cluster node
10/12/06 15:10:19 NTFS_SurrogateCalling: LOGNAV02
10/12/06 15:10:19 Disk Q: N: not owned
10/12/06 15:10:19 All clustered drives:
10/12/06 15:10:19 Q:
10/12/06 15:10:19 N:
10/12/06 15:10:19 Enumerating local drives
10/12/06 15:10:19 Creating DLEs:
10/12/06 15:10:19 \\LOGNAV02\C:
10/12/06 15:10:19 \\LOGNAV02\D:
10/12/06 15:10:19 \\LOGNAV02\E:
10/12/06 15:10:19 SQL2_SurrogateCalling - the default SQL Service is running on LOGNAV02.
10/12/06 15:10:19 Opened CurrentVersion registry key.
10/12/06 15:10:19 Retrieved CurrentVersion data.
10/12/06 15:10:19 Found SOFTWARE\MICROSOFT\MSSQLServer in the registry.
10/12/06 15:10:19 isClusterOK returning 0
10/12/06 15:10:19 SQL2_SurrogateCalling - Sorry, not cluster OK.
10/12/06 15:10:19 Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
10/12/06 15:10:19 AddESE_DLEs( )
10/12/06 15:10:19 first load attempt of esebcli2.dll failed: The specified module could not be found.
10/12/06 15:10:19 second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
10/12/06 15:10:19 third load attempt failed from path = '': The specified module could not be found.
10/12/06 15:10:19 Looking for esebcli2.dll in sysetm path
10/12/06 15:10:19 never found EseBcli2.dll
10/12/06 15:10:19 esebcli2.dll not loaded
10/12/06 15:10:19 DeviceIOControl() Failed with error: 21
10/12/06 15:10:19 No utility partitions found on any of the disks
10/12/06 15:10:19 Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:705
10/12/06 15:10:19 Informational: Cps library not available. Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:709
10/12/06 15:10:19 ENTER DPM::SurrogateCalling
10/12/06 15:10:19 ENTER DPM::IsServicePresent
10/12/06 15:10:19 DPM: Failed OpenService
10/12/06 15:10:19 DPM: Service is present:
10/12/06 15:10:19 EXIT DPM::IsServicePresent
10/12/06 15:10:19 DPM: DPM Service not present
10/12/06 15:10:19 EXIT DPM::SurrogateCalling return=
10/12/06 15:10:19 Attach to \\LOGNAV02
10/12/06 15:10:19 Detach from \\LOGNAV02
10/12/06 15:10:20 FS_ResolveDevName
10/12/06 15:10:20 Entering SetupLocalShareInfo
10/12/06 15:10:20 Informational: Not enumerating DFS
10/12/06 15:10:20 Attach to \\LOGNAV02\C:
10/12/06 15:10:20 Detach from \\LOGNAV02\C:
10/12/06 15:10:23 FS_ResolveDevName
10/12/06 15:10:23 Calling IVssBackupComponents::GatherWriterMetadata...
10/12/06 15:10:25 ...completed IVssBackupComponents::GatherWriterMetadata
10/12/06 15:10:25 brUtil::brUtil( img ) Constructor
10/12/06 15:10:25 Attach to \\LOGNAV02\Shadow?Copy?Components
10/12/06 15:10:25 Detach from \\LOGNAV02\Shadow?Copy?Components
10/12/06 15:10:25 brUtil::brUtil Destructor
10/12/06 15:10:30 FS_ResolveDevName
10/12/06 15:10:30 Entering SetupLocalShareInfo
10/12/06 15:10:30 Informational: Not enumerating DFS
10/12/06 15:10:30 Attach to \\LOGNAV02\C:
10/12/06 15:10:30 Detach from \\LOGNAV02\C:
10/12/06 15:10:35 FS_ResolveDevName
10/12/06 15:10:35 Entering SetupLocalShareInfo
10/12/06 15:10:35 Informational: Not enumerating DFS
10/12/06 15:10:35 Attach to \\LOGNAV02\C:
10/12/06 15:10:35 Detach from \\LOGNAV02\C:
10/12/06 15:10:41 FS_ResolveDevName
10/12/06 15:10:41 Entering SetupLocalShareInfo
10/12/06 15:10:41 Informational: Not enumerating DFS
10/12/06 15:10:41 Attach to \\LOGNAV02\C:
10/12/06 15:10:41 Detach from \\LOGNAV02\C:
10/12/06 15:11:12 DS_CloseSelectionService
10/12/06 15:11:22 ndmpRun: Control Connection Accepted : connection established between IP 192.168.0.110, port 10000 and IP 192.168.0.242, port 1109
10/12/06 15:11:22 Successfully impersonated LOGICOM\administrator
10/12/06 15:11:22 WhoAmI( ) reports: LOGICOM\administrator
10/12/06 15:11:22
SMSAPIShim: Couldn't load BESMDR.DLL. No SMS support is loaded.
10/12/06 15:11:23 SQL2_FindDrives - a default SQL Service is installed on LOGNAV02.
10/12/06 15:11:23 Opened CurrentVersion registry key.
10/12/06 15:11:23 Retrieved CurrentVersion data.
10/12/06 15:11:23 SQL2_FindDrives - the default SQL Service appears to be SQL 2000.
10/12/06 15:11:23 Found SOFTWARE\MICROSOFT\MSSQLServer in the registry.
10/12/06 15:11:23 isClusterOK returning 0
10/12/06 15:11:23 SQL2_FindDrives - Sorry, not cluster OK.
10/12/06 15:11:23 Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
10/12/06 15:11:23 AddESE_DLEs( )
10/12/06 15:11:23 first load attempt of esebcli2.dll failed: The specified module could not be found.
10/12/06 15:11:23 second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
10/12/06 15:11:23 third load attempt failed from path = '': The specified module could not be found.
10/12/06 15:11:23 Looking for esebcli2.dll in sysetm path
10/12/06 15:11:23 never found EseBcli2.dll
10/12/06 15:11:23 esebcli2.dll not loaded
10/12/06 15:11:23 DeviceIOControl() Failed with error: 21
10/12/06 15:11:23 No utility partitions found on any of the disks
10/12/06 15:11:23 Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:705
10/12/06 15:11:23 Informational: Cps library not available. Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:709
10/12/06 15:11:23 ENTER DPM::FindDrives
10/12/06 15:11:23 ENTER DPM::IsServicePresent
10/12/06 15:11:23 DPM: Failed OpenService
10/12/06 15:11:23 DPM: Service is present:
10/12/06 15:11:23 EXIT DPM::IsServicePresent
10/12/06 15:11:23 DPM: DPM Service not present
10/12/06 15:11:23 EXIT DPM::FindDrives return=
10/12/06 15:11:23 ndmpdSnapshotPrepare2: Calling DLE_FindByName for device: \\LOGNAV02\C:
10/12/06 15:11:23 ndmpdSnapshotPrepare2: DLE_FindByName returned 0xE00084AF for \\LOGNAV02\C:. Calling SplitUncPath
10/12/06 15:11:23 ndmpdSnapshotPrepare2: SplitUncPath success with Server: \\LOGNAV02 Share: C:
10/12/06 15:11:23 ndmpdSnapshotPrepare2: DLE_FindByName returned 0xE00084AF for \\LOGNAV02.
10/12/06 15:11:23 FS_CreateTempDLE
10/12/06 15:11:23 0 = 1
10/12/06 15:11:23 1 = 1
10/12/06 15:11:23 2 = 1
10/12/06 15:11:23 3 = 1
10/12/06 15:11:23 4 = 1
10/12/06 15:11:23 5 = 1
10/12/06 15:11:23 6 = 1
10/12/06 15:11:23 7 = 0
10/12/06 15:11:23 Error 0 on NetShareEnum of \\LOGNAV02, level 2
10/12/06 15:11:23 \\LOGNAV02 is clustered
10/12/06 15:11:23 \\LOGNAV02 is a cluster node
10/12/06 15:11:23 NTFS_SurrogateCalling: LOGNAV02
10/12/06 15:11:23 Disk Q: N: not owned
10/12/06 15:11:23 All clustered drives:
10/12/06 15:11:23 Q:
10/12/06 15:11:23 N:
10/12/06 15:11:23 Enumerating local drives
10/12/06 15:11:23 Creating DLEs:
10/12/06 15:11:23 \\LOGNAV02\C:
10/12/06 15:11:23 \\LOGNAV02\D:
10/12/06 15:11:23 \\LOGNAV02\E:
10/12/06 15:11:23 SQL2_SurrogateCalling - the default SQL Service is running on LOGNAV02.
10/12/06 15:11:23 Opened CurrentVersion registry key.
10/12/06 15:11:23 Retrieved CurrentVersion data.
10/12/06 15:11:23 Found SOFTWARE\MICROSOFT\MSSQLServer in the registry.
10/12/06 15:11:23 isClusterOK returning 0
10/12/06 15:11:23 SQL2_SurrogateCalling - Sorry, not cluster OK.
10/12/06 15:11:23 Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
10/12/06 15:11:23 AddESE_DLEs( )
10/12/06 15:11:23 first load attempt of esebcli2.dll failed: The specified module could not be found.
10/12/06 15:11:23 second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
10/12/06 15:11:23 third load attempt failed from path = '': The specified module could not be found.
10/12/06 15:11:23 Looking for esebcli2.dll in sysetm path
10/12/06 15:11:23 never found EseBcli2.dll
10/12/06 15:11:23 esebcli2.dll not loaded
10/12/06 15:11:23 DeviceIOControl() Failed with error: 21
10/12/06 15:11:23 No utility partitions found on any of the disks
10/12/06 15:11:23 Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:705
10/12/06 15:11:23 Informational: Cps library not available. Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:709
10/12/06 15:11:23 ENTER DPM::SurrogateCalling
10/12/06 15:11:23 ENTER DPM::IsServicePresent
10/12/06 15:11:23 DPM: Failed OpenService
10/12/06 15:11:23 DPM: Service is present:
10/12/06 15:11:23 EXIT DPM::IsServicePresent
10/12/06 15:11:23 DPM: DPM Service not present
10/12/06 15:11:23 EXIT DPM::SurrogateCalling return=
10/12/06 15:11:23 Attach to \\LOGNAV02
10/12/06 15:11:23 Detach from \\LOGNAV02
10/12/06 15:11:23 ndmpdSnapshotPrepare2: Calling DLE_FindByName again for device: \\LOGNAV02\C:
10/12/06 15:11:23 dir =
10/12/06 15:11:23 file = *.*
10/12/06 15:11:23 oper = Include
10/12/06 15:11:23 subs = True
10/12/06 15:11:23 wild = True
10/12/06 15:11:23 dir = WINDOWS\system32\wbem
10/12/06 15:11:23 file = *.*
10/12/06 15:11:23 oper = Exclude
10/12/06 15:11:23 subs = True
10/12/06 15:11:23 wild = True
10/12/06 15:11:23 dir = WINDOWS
10/12/06 15:11:23 file = Windows Update.log
10/12/06 15:11:23 oper = Exclude
10/12/06 15:11:23 subs = False
10/12/06 15:11:23 wild = False
10/12/06 15:11:23 dir = WINDOWS
10/12/06 15:11:23 file = WindowsUpdate.log
10/12/06 15:11:23 oper = Exclude
10/12/06 15:11:23 subs = False
10/12/06 15:11:23 wild = False
10/12/06 15:11:23 Attempting VSP Provider
10/12/06 15:11:23 Snapshot factory, using VSP as the snapshot provider.
10/12/06 15:11:23 Initialized VSP Snapshot Provider
10/12/06 15:11:23 Entering SetupLocalShareInfo
10/12/06 15:11:23 Informational: Not enumerating DFS
10/12/06 15:11:23 Attach to \\LOGNAV02\C:
10/12/06 15:11:23 SnapshotBackupEngine::scan_file_system() : Volume List size (before prune): 1
10/12/06 15:11:23 SnapshotBackupEngine::scan_file_system(): Volume List size (after prune): 1
10/12/06 15:11:23 Adding volume: C:
10/12/06 15:11:23 VspSnapshotVolume::AddVolumeToSnapSet( C: )
10/12/06 15:11:23 SnapshotBackupEngine::snap_file_systems. Start...
10/12/06 15:11:23 VspSnapshotVolume::PrepareToSnapVolumeSet( ), calling broker
10/12/06 15:11:23 CacheFile Broker - List of volumes on system:
10/12/06 15:11:23 Drive VolGUID DriveType FileSys
10/12/06 15:11:23 --------------------------------------------------------------------------------
10/12/06 15:11:23 C:\ \\?\Volume{a0ca09e7-cdf7-11da-b466-806e6f6e6963}\ Fixed NTFS
10/12/06 15:11:23 E:\ \\?\Volume{c97dfbe4-cde6-11da-9def-505054503030}\ Fixed NTFS
10/12/06 15:11:24 \\?\Volume{a0ca09e5-cdf7-11da-b466-806e6f6e6963}\ CD-ROM
10/12/06 15:11:25 \\?\Volume{a0ca09e4-cdf7-11da-b466-806e6f6e6963}\ Removable
10/12/06 15:11:25 ------- End of list --------
10/12/06 15:11:25 CacheFile Broker - Checking if volume is a valid cache file target: \\?\Volume{a0ca09e7-cdf7-11da-b466-806e6f6e6963}\ Num vols: 4
10/12/06 15:11:25 CacheFile Broker - Checking if volume is a valid cache file target: \\?\Volume{c97dfbe4-cde6-11da-9def-505054503030}\ Num vols: 4
10/12/06 15:11:25 CacheFile Broker - Checking if volume is a valid cache file target: \\?\Volume{a0ca09e5-cdf7-11da-b466-806e6f6e6963}\ Num vols: 4
10/12/06 15:11:25 Volume is invalid as cache file target.
10/12/06 15:11:25 CacheFile Broker - Checking if volume is a valid cache file target: \\?\Volume{a0ca09e4-cdf7-11da-b466-806e6f6e6963}\ Num vols: 3
10/12/06 15:11:25 Volume is invalid as cache file target.
10/12/06 15:11:25 CacheFile Broker:
10/12/06 15:11:25 Num vols to snap: 1
10/12/06 15:11:25 Num Preferred vols: 1
10/12/06 15:11:25 Num Target vol: 2
10/12/06 15:11:25 Default Target Path: Backup Exec AOFO Store
10/12/06 15:11:25 User-defined target paths:
10/12/06 15:11:25 Volumes to snap:
10/12/06 15:11:25 \\?\Volume{a0ca09e7-cdf7-11da-b466-806e6f6e6963}\
10/12/06 15:11:25 Target volumes available for cache file:
10/12/06 15:11:25 \\?\Volume{a0ca09e7-cdf7-11da-b466-806e6f6e6963}\
10/12/06 15:11:25 \\?\Volume{c97dfbe4-cde6-11da-9def-505054503030}\
10/12/06 15:11:25 Preferred volumes for cache file:
10/12/06 15:11:25 \\?\Volume{c97dfbe4-cde6-11da-9def-505054503030}\
10/12/06 15:11:25 CacheFile Broker. Cache file is located on volume other than source volume.
10/12/06 15:11:25 CacheFile Broker - Size Parameters:
10/12/06 15:11:25 sourceVol : \\?\Volume{a0ca09e7-cdf7-11da-b466-806e6f6e6963}\
10/12/06 15:11:25 cacheVol : \\?\Volume{c97dfbe4-cde6-11da-9def-505054503030}\
10/12/06 15:11:25 free space : 8157
10/12/06 15:11:25 used space : 4238
10/12/06 15:11:25 min (percent): 0
10/12/06 15:11:25 max (percent): 30
10/12/06 15:11:25 min (MB) : 0
10/12/06 15:11:25 max (MB) : 1271
10/12/06 15:11:25 CacheFile Broker - Cache File Name is (\\?\Volume{c97dfbe4-cde6-11da-9def-505054503030}\Backup Exec AOFO Store\_BEVspCacheFile_0.VSP)
10/12/06 15:11:25 VspSnapshotvolume::PrepareToSnapVolumeSet() - cache files are
10/12/06 15:11:25 \\?\Volume{c97dfbe4-cde6-11da-9def-505054503030}\Backup Exec AOFO Store\_BEVspCacheFile_0.VSP
10/12/06 15:11:25 Dumping snap params:
10/12/06 15:11:25 SourceVolumeObject = 00000460
10/12/06 15:11:25 SnapshotVolumeName = Volume{312694ac-978a-447e-8909-c72ff32e5f6d}
10/12/06 15:11:25 CacheFileName = \\?\Volume{c97dfbe4-cde6-11da-9def-505054503030}\Backup Exec AOFO Store\_BEVspCacheFile_0.VSP
10/12/06 15:11:25 InitialCacheFileSize = 0
10/12/06 15:11:25 MaximumCacheFileSize = 1271
10/12/06 15:11:25 Reserved = 0
10/12/06 15:11:25 List of SourceVolumeNames, SourceRawVolumeNames, SnapVolumeNames, CacheFileNames:
10/12/06 15:11:25
10/12/06 15:11:25 calling vsp::Prepare for all volumes
10/12/06 15:11:25 Entering VspSnapshotVolume::RegisterWithOrphanage(). NumVolumesInSnapSet_ = 1
10/12/06 15:11:25 VspSnapshotVolume::RegisterWithOrphanage -> \\?\Volume{312694ac-978a-447e-8909-c72ff32e5f6d},\\?\Volume{c97dfbe4-cde6-11da-9def-505054503030}\Backup Exec AOFO Store\_BEVspCacheFile_0.VSP
10/12/06 15:11:25 Out of VspSnapshotVolume::RegisterWithOrphanage().
10/12/06 15:11:25 VspSNapshotVolume::SnapVolumeSet() - calling create with wait (seconds) = 2 timeout (seconds) = 2000
10/12/06 15:11:30 VspSnapshotVolume::SnapVolumeSet() successfully snapped:
10/12/06 15:11:31 Src vol-> C: Snapped Vol-> Volume{312694ac-978a-447e-8909-c72ff32e5f6d}
10/12/06 15:11:31 Out of VspSnapshotVolume::SnapVolumeSet() with status: 1
10/12/06 15:11:31 SnapshotBackupEngine::snap_file_systems. End. Status: 1
10/12/06 15:11:31 ndmpdSnapshotPrepare2: sending reply...
10/12/06 15:11:31 Detach from \\LOGNAV02\C:
10/12/06 15:11:31 ndmpdSnapshotPrepare2: cleanup: all done
10/12/06 15:11:33 Media Server has initiated the connection for data transfer
10/12/06 15:11:33 Remote Agent is listening for the Data Connection at:
IP : 192.168.0.110
Port : 1270
10/12/06 15:11:33 dataAcceptConnection : Data Connection information : connection established between IP 192.168.0.110, port 1270 and IP 192.168.0.242, port 1117
10/12/06 15:11:33 ENV: USERNAME=
10/12/06 15:11:33 ENV: NOPASSWORD=
10/12/06 15:11:33 ENV: USERNAME=LOGICOM\administrator
10/12/06 15:11:33 ENV: PASSWORD=
10/12/06 15:11:33 ENV: INITIATOR_SID=0@D0000000DE0000FRIoGe9idC7VO0A_m04000
10/12/06 15:11:33 ENV: PRESCANDLE=0
10/12/06 15:11:33 ENV: OPER_TYPE=1
10/12/06 15:11:33 ENV: BLOCKSIZE=400
10/12/06 15:11:33 ENV: SSETRESERVED=400
10/12/06 15:11:33 ENV: BU_SQL_PRE_BKUP_DBCC_TYPE=0
10/12/06 15:11:33 ENV: BU_SQL_POST_BKUP_DBCC_TYPE=0
10/12/06 15:11:33 ENV: REST_SQL_POST_REST_DBCC_TYPE=0
10/12/06 15:11:33 ENV: LAST_SET=0
10/12/06 15:11:33 ENV: BU_REGISTRY=0
10/12/06 15:11:33 ENV: BU_INUSE=1
10/12/06 15:11:33 ENV: BU_MIGRATED=0
10/12/06 15:11:33 ENV: BU_EXPANDED=0
10/12/06 15:11:33 ENV: PROCESS_EMPTY=0
10/12/06 15:11:33 ENV: SWCOMPMODE=0
10/12/06 15:11:33 ENV: SWCOMPLEVEL=0
10/12/06 15:11:33 ENV: SWCOMPTHRESH=10
10/12/06 15:11:33 ENV: BACKUPTYPE=1
10/12/06 15:11:33 ENV: BU_SPS_METHOD=1
10/12/06 15:11:33 ENV: BU_SQL_METHOD=0
10/12/06 15:11:33 ENV: BU_SQL_NO_RECOVER=0
10/12/06 15:11:33 ENV: BU_SQL_STANDBY=0
10/12/06 15:11:33 ENV: BU_SQL_ALWAYS_SNAP=0
10/12/06 15:11:33 ENV: BU_XCH_METHOD=1
10/12/06 15:11:33 ENV: BU_MBOX_METHOD=1
10/12/06 15:11:33 ENV: BU_MBOX_SIS=1
10/12/06 15:11:33 ENV: BU_NTFS_SIS=0
10/12/06 15:11:33 ENV: AA_PRIORITY=0
10/12/06 15:11:33 ENV: BU_RSM=0
10/12/06 15:11:33 ENV: BU_EXCLUDE_ACTIVE_FILES=1
10/12/06 15:11:33 ENV: TRAVERSE_LOCAL_MP=1
10/12/06 15:11:33 ENV: TRAVERSE_REMOTE_MP=0
10/12/06 15:11:33 ENV: DO_SNAPSHOT=1
10/12/06 15:11:33 ENV: SQL_FORCE_NP=0
10/12/06 15:11:33 ENV: SQL_OVERRIDE_FGDEPS=0
10/12/06 15:11:33 ENV: SQL_ALERT_FGDEP_OVERRIDE=1
10/12/06 15:11:33 ENV: BU_SFC_WITH_SS=1
10/12/06 15:11:33 ENV: BU_REMOTE_STORAGE_HSM=0
10/12/06 15:11:33 ENV: SKIP_OPEN_FILES=0
10/12/06 15:11:33 ENV: WAIT_SKIP=0
10/12/06 15:11:33 ENV: HIDDEN=1
10/12/06 15:11:33 ENV: PROC_SYSTEM_FILES=1
10/12/06 15:11:33 ENV: BU_LDM_STATE=0
10/12/06 15:11:33 ENV: BU_DISK_QUOTA=0
10/12/06 15:11:33 ENV: BU_IN_DOC_FMT=0
10/12/06 15:11:33 ENV: REST_REGISTRY=0
10/12/06 15:11:33 ENV: REST_HW_REGISTRY=0
10/12/06 15:11:33 ENV: IGNORE_TREE_RESTORE=0
10/12/06 15:11:33 ENV: REST_SECURITY=1
10/12/06 15:11:33 ENV: VOL_RESTRICTIONS=0
10/12/06 15:11:33 ENV: REST_XCH_PUBLIC=1
10/12/06 15:11:33 ENV: REST_MBOX_USER_FLAG=0
10/12/06 15:11:33 ENV: REST_MBOX_USER_PASSWORD=
10/12/06 15:11:33 ENV: MEDIA_SERVER=BACKUPSRV
10/12/06 15:11:33 ENV: SPS_SERVER_LIST=
10/12/06 15:11:33 ENV: SPS_COMMIT_RESTORE=0
10/12/06 15:11:33 ENV: BU_SPS_PRE_BKUP_DBCC_TYPE=0
10/12/06 15:11:33 ENV: BU_SPS_POST_BKUP_DBCC_TYPE=0
10/12/06 15:11:33 ENV: REST_SPS_POST_REST_DBCC_TYPE=2
10/12/06 15:11:33 ENV: CONTINUE_ON_SPS_DBCC_ERROR=0
10/12/06 15:11:33 ENV: JOBNAME=Backup 00040
10/12/06 15:11:33 ENV: REST_XCH_PRIVATE=1
10/12/06 15:11:33 ENV: REST_REMOTE_HSM=0
10/12/06 15:11:33 ENV: REST_RSM=0
10/12/06 15:11:33 ENV: REST_DISK_QUOTA=0
10/12/06 15:11:33 ENV: REST_JUNC_AS_DIR=0
10/12/06 15:11:33 ENV: REST_PRIM_REPLICA=0
10/12/06 15:11:33 ENV: REST_TERMINAL_SERVICES=0
10/12/06 15:11:33 ENV: REST_WMI=0
10/12/06 15:11:33 ENV: REST_CLUSTER_QUORUM_DB=0
10/12/06 15:11:33 ENV: REST_FORCE_RECOVERY=0
10/12/06 15:11:33 ENV: REST_EXISTING=3
10/12/06 15:11:33 ENV: REST_XCH_NO_LOSS=1
10/12/06 15:11:33 ENV: REST_ESE_MOUNT=0
10/12/06 15:11:33 ENV: REST_ESE_DISMOUNT=0
10/12/06 15:11:33 ENV: REST_ESE_LOG_PATH=C:\TEMP\
10/12/06 15:11:33 ENV: REST_ESE_LAST_SET=0
10/12/06 15:11:33 ENV: REST_ESE_NO_LOSS=1
10/12/06 15:11:33 ENV: REST_ESE_CONSISTENCY_CHECK=1
10/12/06 15:11:33 ENV: REST_ESE_CONTINUE_CONSISTENCY_CHECK=1
10/12/06 15:11:33 ENV: REST_SQL_DATABASE_OVERWRITE=0
10/12/06 15:11:33 ENV: REST_SQL_POINT_IN_TIME=0
10/12/06 15:11:33 ENV: REST_SQL_POINT_IN_TIME_DATE=0
10/12/06 15:11:33 ENV: REST_SQL_POINT_IN_TIME_TIME=0
10/12/06 15:11:33 ENV: BU_SQL_PRE_BKUP_DBCC=0
10/12/06 15:11:33 ENV: BU_SQL_POST_BKUP_DBCC=0
10/12/06 15:11:33 ENV: REST_SQL_POST_REST_DBCC=2
10/12/06 15:11:33 ENV: CONTINUE_ON_DBCC_ERROR=1
10/12/06 15:11:33 ENV: REST_SQL_AUTO_MASTER=0
10/12/06 15:11:33 ENV: REST_SQL_DATABASE_STANDBY=0
10/12/06 15:11:33 ENV: REST_SQL_DATABASE_FORCERESTORE=0
10/12/06 15:11:33 ENV: REST_SQL_DATABASE_RECOVER=1
10/12/06 15:11:33 ENV: REST_SQL_LOG_MARK_RESTORE=0
10/12/06 15:11:33 ENV: REST_SQL_LOG_MARK_NAME=
10/12/06 15:11:33 ENV: REST_SQL_LOG_MARK_STOP_BEFORE=0
10/12/06 15:11:33 ENV: REST_SQL_LOG_MARK_AFTER_TIME=0
10/12/06 15:11:33 ENV: REST_SQL_LOG_MARK_DATE=0
10/12/06 15:11:33 ENV: REST_SQL_LOG_MARK_TIME=0
10/12/06 15:11:33 ENV: REST_SQL_DEF_INSTANCE_DIR=0
10/12/06 15:11:33 ENV: REST_SQL_USE_DEFAULT_DRIVE=0
10/12/06 15:11:33 ENV: REST_SQL_ALL_TO_DEFAULT_DRIVE=0
10/12/06 15:11:33 ENV: REST_SQL_DEFAULT_DRIVE=0
10/12/06 15:11:33 ENV: ARCHIVE_PRESERVE_TREE=0
10/12/06 15:11:33 ENV: UTILITY_PARTITION_OEMIDS=
10/12/06 15:11:33 ENV: APPLY_CPR_TO_BACKUPSET=0
10/12/06 15:11:33 ENV: IMAGE_METHOD=0
10/12/06 15:11:33 ENV: GUARANTEED_FROZEN_IMAGE=0
10/12/06 15:11:33 ENV: FULL_IMAGE_METHOD=0
10/12/06 15:11:33 ENV: TESTRUN_JOB_OPTIONS=0
10/12/06 15:11:33 ENV: USE_CHANGE_JOURNAL=0
10/12/06 15:11:33 ENV: DOMINO_BACKUP_METHOD=1
10/12/06 15:11:33 ENV: DOMINO_BACKUP_RECYCLE_LOGFILE=0
10/12/06 15:11:33 ENV: DOMINO_LAST_BACKUP_DATE=0
10/12/06 15:11:33 ENV: DOMINO_LAST_BACKUP_TIME=0
10/12/06 15:11:33 ENV: DOMINO_MAX_TRANLOG_EXTENTS=46
10/12/06 15:11:33 ENV: DOMINO_RESTORE_DBRECOVEROPTION=0
10/12/06 15:11:33 ENV: DOMINO_RESTORE_WAITINUSE=0
10/12/06 15:11:33 ENV: DOMINO_RESTORE_MSECSFORWAIT=1e
10/12/06 15:11:33 ENV: DOMINO_RESTORE_POINTINTIMERESTORE=0
10/12/06 15:11:33 ENV: DOMINO_RESTORE_PITTIME_DATE=0
10/12/06 15:11:33 ENV: DOMINO_RESTORE_PITTIME_TIME=0
10/12/06 15:11:33 ENV: SAP_JOB_FLAG=0
10/12/06 15:11:33 ENV: IMAGE_DBLK_TYPE=0
10/12/06 15:11:33 ENV: PROC_CHECKSUM_STRM=1
10/12/06 15:11:33 ENV: DOMINO_OFFLINE_BACKUP=0
10/12/06 15:11:33 ENV: ENABLE_IDR_INFO_GATHERING=1
10/12/06 15:11:33 ENV: IMAGE_OPTION_AUTHORIZED=0
10/12/06 15:11:33 ENV: DPM_OPTION_AUTHORIZED=1
10/12/06 15:11:33 ENV: GRFS_TIMEOUT=5a
10/12/06 15:11:33 ENV: DO_OFF_HOST_BACKUP=0
10/12/06 15:11:33 ENV: OFF_HOST_BACKUP_OPER_TYPE=0
10/12/06 15:11:33 ENV: OFF_HOST_METADATA_COLL_NAME=
10/12/06 15:11:33 ENV: PRESERVE_CTIME=0
10/12/06 15:11:33 ENV: FOLLOW_SYMDIRS=0
10/12/06 15:11:33 ENV: INCLUDE_REMOTE=0
10/12/06 15:11:33 ENV: NO_NFS_LOCKING=0
10/12/06 15:11:33 ENV: FOLLOW_MOUNTPOINTS=1
10/12/06 15:11:33 ENV: TRUE_IMAGE_BACKUP=0
10/12/06 15:11:33 ENV: NDMP_PROP_PORT_RANGE_ENABLED=0
10/12/06 15:11:33 ENV: NDMP_PORT_RANGE=
10/12/06 15:11:33 ENV: REVERSE_CONNECTION=1
10/12/06 15:11:33 ENV: SNAPSHOT_ID={087CF8A7-AAA0-4EF8-B451-0FB0BA2D1FDD}
10/12/06 15:11:33 ENV: OFF_HOST_SNAPSHOT_ID={00000000-0000-0000-0000-000000000000}
10/12/06 15:11:33 ENV: DEVICENAME="\\LOGNAV02\C:"
10/12/06 15:11:33 ENV: DEVICE_OS_ID=e
10/12/06 15:11:33 ENV: DEVICE_OS_VER=3
10/12/06 15:11:33 ENV: DEVICE_MAINTYPE=1
10/12/06 15:11:33 ENV: DEVICE_SUBTYPE=4
10/12/06 15:11:33 ENV: FILESYSTEM="\\LOGNAV02\C:\*.*",s,v0,t0,l0,n0,f0
10/12/06 15:11:33 ENV: FILESYSTEM="\\LOGNAV02\C:\WINDOWS\system32\wbem\*.*",s,x,v0,t0,l0,n0,f0
10/12/06 15:11:33 ENV: FILESYSTEM="\\LOGNAV02\C:\WINDOWS\Windows Update.log",x,v0,t0,l0,n0,f0
10/12/06 15:11:33 ENV: FILESYSTEM="\\LOGNAV02\C:\WINDOWS\WindowsUpdate.log",x,v0,t0,l0,n0,f0
10/12/06 15:11:33 ENV: BSD_DEVICE_ATTRIBUTES=0
10/12/06 15:11:33 ENV: JOBNAME=Backup 00040
10/12/06 15:11:33 ENV: REST_ESE_LOG_PATH=C:\TEMP\
10/12/06 15:11:33 ENV: REST_SQL_LOG_MARK_NAME=
10/12/06 15:11:33 ModifiedOnly is 0
10/12/06 15:11:33 SWCompMode is 0
10/12/06 15:11:33 ENV: MEDIA_SERVER=BACKUPSRV
10/12/06 15:11:33 ENV: SPS_SERVER_LIST=
10/12/06 15:11:33 ENV: SPS_COMMIT_RESTORE=0
10/12/06 15:11:33 ENV: GRFS_TIMEOUT=5a
10/12/06 15:11:33 ENV: DO_OFF_HOST_BACKUP=0
10/12/06 15:11:33 ENV: OFF_HOST_BACKUP_OPER_TYPE=0
10/12/06 15:11:33 ENV: OFF_HOST_METADATA_COLL_NAME=
10/12/06 15:11:33 ENV: PRESERVE_CTIME=0
10/12/06 15:11:33 ENV: FOLLOW_SYMDIRS=0
10/12/06 15:11:33 ENV: INCLUDE_REMOTE=0
10/12/06 15:11:33 ENV: NO_NFS_LOCKING=0
10/12/06 15:11:33 ENV: FOLLOW_MOUNTPOINTS=1
10/12/06 15:11:33 ENV: TRUE_IMAGE_BACKUP=0
10/12/06 15:11:33
SMSAPIShim: Couldn't load BESMDR.DLL. No SMS support is loaded.
10/12/06 15:11:33 SQL2_FindDrives - a default SQL Service is installed on LOGNAV02.
10/12/06 15:11:33 Opened CurrentVersion registry key.
10/12/06 15:11:33 Retrieved CurrentVersion data.
10/12/06 15:11:33 SQL2_FindDrives - the default SQL Service appears to be SQL 2000.
10/12/06 15:11:33 Found SOFTWARE\MICROSOFT\MSSQLServer in the registry.
10/12/06 15:11:33 isClusterOK returning 0
10/12/06 15:11:33 SQL2_FindDrives - Sorry, not cluster OK.
10/12/06 15:11:33 Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
10/12/06 15:11:33 AddESE_DLEs( )
10/12/06 15:11:33 first load attempt of esebcli2.dll failed: The specified module could not be found.
10/12/06 15:11:33 second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
10/12/06 15:11:33 third load attempt failed from path = '': The specified module could not be found.
10/12/06 15:11:33 Looking for esebcli2.dll in sysetm path
10/12/06 15:11:33 never found EseBcli2.dll
10/12/06 15:11:33 esebcli2.dll not loaded
10/12/06 15:11:33 DeviceIOControl() Failed with error: 21
10/12/06 15:11:33 No utility partitions found on any of the disks
10/12/06 15:11:33 Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:705
10/12/06 15:11:33 Informational: Cps library not available. Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:709
10/12/06 15:11:33 ENTER DPM::FindDrives
10/12/06 15:11:33 ENTER DPM::IsServicePresent
10/12/06 15:11:33 DPM: Failed OpenService
10/12/06 15:11:33 DPM: Service is present:
10/12/06 15:11:33 EXIT DPM::IsServicePresent
10/12/06 15:11:33 DPM: DPM Service not present
10/12/06 15:11:33 EXIT DPM::FindDrives return=
10/12/06 15:11:33 FS_CreateTempDLE
10/12/06 15:11:33 0 = 1
10/12/06 15:11:33 1 = 1
10/12/06 15:11:33 2 = 1
10/12/06 15:11:33 3 = 1
10/12/06 15:11:33 4 = 1
10/12/06 15:11:33 5 = 1
10/12/06 15:11:33 6 = 1
10/12/06 15:11:33 7 = 0
10/12/06 15:11:33 Error 0 on NetShareEnum of \\LOGNAV02, level 2
10/12/06 15:11:33 \\LOGNAV02 is clustered
10/12/06 15:11:33 \\LOGNAV02 is a cluster node
10/12/06 15:11:33 NTFS_SurrogateCalling: LOGNAV02
10/12/06 15:11:33 Disk Q: N: not owned
10/12/06 15:11:33 All clustered drives:
10/12/06 15:11:33 Q:
10/12/06 15:11:33 N:
10/12/06 15:11:33 Enumerating local drives
10/12/06 15:11:33 Creating DLEs:
10/12/06 15:11:33 \\LOGNAV02\C:
10/12/06 15:11:33 \\LOGNAV02\D:
10/12/06 15:11:33 \\LOGNAV02\E:
10/12/06 15:11:33 SQL2_SurrogateCalling - the default SQL Service is running on LOGNAV02.
10/12/06 15:11:33 Opened CurrentVersion registry key.
10/12/06 15:11:33 Retrieved CurrentVersion data.
10/12/06 15:11:33 Found SOFTWARE\MICROSOFT\MSSQLServer in the registry.
10/12/06 15:11:33 isClusterOK returning 0
10/12/06 15:11:33 SQL2_SurrogateCalling - Sorry, not cluster OK.
10/12/06 15:11:33 Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
10/12/06 15:11:33 AddESE_DLEs( )
10/12/06 15:11:33 first load attempt of esebcli2.dll failed: The specified module could not be found.
10/12/06 15:11:33 second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
10/12/06 15:11:33 third load attempt failed from path = '': The specified module could not be found.
10/12/06 15:11:33 Looking for esebcli2.dll in sysetm path
10/12/06 15:11:33 never found EseBcli2.dll
10/12/06 15:11:33 esebcli2.dll not loaded
10/12/06 15:11:33 DeviceIOControl() Failed with error: 21
10/12/06 15:11:33 No utility partitions found on any of the disks
10/12/06 15:11:33 Informational: Cps root device creation using default Cps library mechanism when creating device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:705
10/12/06 15:11:33 Informational: Cps library not available. Not creating Cps root device 'Cont?Prot?Srv' in CPS::DetermineRootCpsComponent:709
10/12/06 15:11:33 ENTER DPM::SurrogateCalling
10/12/06 15:11:33 ENTER DPM::IsServicePresent
10/12/06 15:11:33 DPM: Failed OpenService
10/12/06 15:11:33 DPM: Service is present:
10/12/06 15:11:33 EXIT DPM::IsServicePresent
10/12/06 15:11:33 DPM: DPM Service not present
10/12/06 15:11:33 EXIT DPM::SurrogateCalling return=
10/12/06 15:11:33 Attach to \\LOGNAV02
10/12/06 15:11:33 Entering SetupLocalShareInfo
10/12/06 15:11:33 Informational: Not enumerating DFS
10/12/06 15:11:33 Attach to \\LOGNAV02\C:
10/12/06 15:11:33 Detach from \\LOGNAV02
10/12/06 15:11:33 line = "\\LOGNAV02\C:\*.*",s,v0,t0,l0,n0,f0
10/12/06 15:11:33 dir =
10/12/06 15:11:33 file = *.*
10/12/06 15:11:33 oper = Include
10/12/06 15:11:33 subs = True
10/12/06 15:11:33 wild = True
10/12/06 15:11:33 attr_on_mask = 0
10/12/06 15:11:33 attr_off_mask = 0
10/12/06 15:11:33 line = "\\LOGNAV02\C:\WINDOWS\system32\wbem\*.*",s,x,v0,t0,l0,n0,f0
10/12/06 15:11:33 dir = WINDOWS\system32\wbem
10/12/06 15:11:33 file = *.*
10/12/06 15:11:33 oper = Exclude
10/12/06 15:11:33 subs = True
10/12/06 15:11:33 wild = True
10/12/06 15:11:33 attr_on_mask = 0
10/12/06 15:11:33 attr_off_mask = 0
10/12/06 15:11:33 line = "\\LOGNAV02\C:\WINDOWS\Windows Update.log",x,v0,t0,l0,n0,f0
10/12/06 15:11:33 dir = WINDOWS
10/12/06 15:11:33 file = Windows Update.log
10/12/06 15:11:33 oper = Exclude
10/12/06 15:11:33 subs = False
10/12/06 15:11:33 wild = False
10/12/06 15:11:33 attr_on_mask = 0
10/12/06 15:11:33 attr_off_mask = 0
10/12/06 15:11:33 line = "\\LOGNAV02\C:\WINDOWS\WindowsUpdate.log",x,v0,t0,l0,n0,f0
10/12/06 15:11:33 dir = WINDOWS
10/12/06 15:11:33 file = WindowsUpdate.log
10/12/06 15:11:33 oper = Exclude
10/12/06 15:11:33 subs = False
10/12/06 15:11:33 wild = False
10/12/06 15:11:33 attr_on_mask = 0
10/12/06 15:11:33 attr_off_mask = 0
10/12/06 15:11:33 AddFsExcludes:
10/12/06 15:11:33 BSD for \\LOGNAV02\C:
10/12/06 15:11:33 + \*.* /s
10/12/06 15:11:33 - \WINDOWS\system32\wbem\*.* /s
10/12/06 15:11:33 - \WINDOWS\Windows Update.log
10/12/06 15:11:33 - \WINDOWS\WindowsUpdate.log
10/12/06 15:11:33 INFORMATIONAL: REG_MULTI_SZ registry value "SYSTEM\CurrentControlSet\Control\BackupRestore\FilesNotToBackup\DRM" lacks proper termination
10/12/06 15:11:33 FilesNotToBackup and Hardcoded exclusion files:
10/12/06 15:11:33 C:\WINDOWS\Cluster\MajorityNodeSet_FileMutex
10/12/06 15:11:33 C:\WINDOWS\Cluster\MNS*\*.* /s
10/12/06 15:11:33 C:\WINDOWS\repair\asr.log
10/12/06 15:11:33 C:\WINDOWS\repair\asr.err
10/12/06 15:11:33 C:\WINDOWS\csc\* /s
10/12/06 15:11:33 C:\Documents and Settings\administrator.LOGICOM\index.dat /s
10/12/06 15:11:33 C:\Pagefile.sys
10/12/06 15:11:33 C:\WINDOWS\Registration\*.clb
10/12/06 15:11:33 C:\*.crmlog /s
10/12/06 15:11:33 C:\System Volume Information\MountPointManagerRemoteDatabase
10/12/06 15:11:33 C:\WINDOWS\netlogon.chg
10/12/06 15:11:33 C:\hiberfil.sys
10/12/06 15:11:33 C:\System Volume Information\*{3808876B-C176-4e48-B7AE-04046E6CC752} /s
10/12/06 15:11:33 C:\System Volume Information\*.{7cc467ef-6865-4831-853f-2a4817fd1bca}DB
10/12/06 15:11:33 C:\System Volume Information\*.{7cc467ef-6865-4831-853f-2a4817fd1bca}ALT
10/12/06 15:11:33 C:\WINDOWS\Tasks\schedlgu.txt
10/12/06 15:11:33 C:\WINDOWS\TEMP\* /s
10/12/06 15:11:33 C:\WINDOWS\debug\*
10/12/06 15:11:33 C:\WINDOWS\System32\CatRoot2\* /s
10/12/06 15:11:33 C:\WINDOWS\system32\MSDTC\MSDTC.LOG
10/12/06 15:11:33 C:\WINDOWS\system32\MSDtc\trace\dtctrace.log
10/12/06 15:11:33 C:\Documents and Settings\All Users\DRM\* /s
10/12/06 15:11:33 C:\WINDOWS\SoftwareDistribution\* /s
10/12/06 15:11:33 C:\Documents and Settings\All Users\Application Data\Microsoft\Network\Downloader\*
10/12/06 15:11:33 C:\win386.swp /s
10/12/06 15:11:33 C:\pagefile.sys /s
10/12/06 15:11:33 C:\386spart.par
10/12/06 15:11:33 C:\ea data. sf
10/12/06 15:11:33 C:\SSH??P*.SSS /s
10/12/06 15:11:33 C:\SSH?P*.SSS /s
10/12/06 15:11:33 C:\SIS COMMON STORE\*.* /s
10/12/06 15:11:33 C:\dblspace.*
10/12/06 15:11:33 C:\drvspace.*
10/12/06 15:11:33 C:\stacvol.*
10/12/06 15:11:33 C:\_swap_.mem
10/12/06 15:11:33 C:\_BEVspCacheFile_*.VSP /s
10/12/06 15:11:33 C:\system\q_*.* /s
10/12/06 15:11:33 C:\system\*.q /s
10/12/06 15:11:33 C:\system\btrieve.trn
10/12/06 15:11:33 C:\cdrom$$.rom\*.* /s
10/12/06 15:11:33 C:\desktop.afp\*.*
10/12/06 15:11:33 C:\snapshot\pool*.dat /s
10/12/06 15:11:33 C:\Backup Exec AOFO Store\* /s
10/12/06 15:11:33 C:\Program Files\VERITAS\Backup Exec\RANT\Catalogs\FD??????.FDD
10/12/06 15:11:33 C:\Program Files\VERITAS\Backup Exec\RANT\Catalogs\EM??????.FDD
10/12/06 15:11:33 C:\Program Files\VERITAS\Backup Exec\RANT\Catalogs\SM??????.SM
10/12/06 15:11:33 C:\Program Files\VERITAS\Backup Exec\RANT\Catalogs\*.tmp
10/12/06 15:11:33 BSD for \\LOGNAV02\C:
10/12/06 15:11:33 + \*.* /s
10/12/06 15:11:33 - \WINDOWS\system32\wbem\*.* /s
10/12/06 15:11:33 - \WINDOWS\Windows Update.log
10/12/06 15:11:33 - \WINDOWS\WindowsUpdate.log
10/12/06 15:11:33 - \WINDOWS\Cluster\MajorityNodeSet_FileMutex
10/12/06 15:11:33 - \WINDOWS\Cluster\MNS*\*.* /s
10/12/06 15:11:33 - \WINDOWS\repair\asr.log
10/12/06 15:11:33 - \WINDOWS\repair\asr.err
10/12/06 15:11:33 - \WINDOWS\csc\* /s
10/12/06 15:11:33 - \Documents and Settings\administrator.LOGICOM\index.dat /s
10/12/06 15:11:33 - \Pagefile.sys
10/12/06 15:11:33 - \WINDOWS\Registration\*.clb
10/12/06 15:11:33 - \*.crmlog /s
10/12/06 15:11:33 - \System Volume Information\MountPointManagerRemoteDatabase
10/12/06 15:11:33 - \WINDOWS\netlogon.chg
10/12/06 15:11:33 - \hiberfil.sys
10/12/06 15:11:33 - \System Volume Information\*{3808876B-C176-4e48-B7AE-04046E6CC752} /s
10/12/06 15:11:33 - \System Volume Information\*.{7cc467ef-6865-4831-853f-2a4817fd1bca}DB
10/12/06 15:11:33 - \System Volume Information\*.{7cc467ef-6865-4831-853f-2a4817fd1bca}ALT
10/12/06 15:11:33 - \WINDOWS\Tasks\schedlgu.txt
10/12/06 15:11:33 - \WINDOWS\TEMP\* /s
10/12/06 15:11:33 - \WINDOWS\debug\*
10/12/06 15:11:33 - \WINDOWS\System32\CatRoot2\* /s
10/12/06 15:11:33 - \WINDOWS\system32\MSDTC\MSDTC.LOG
10/12/06 15:11:33 - \WINDOWS\system32\MSDtc\trace\dtctrace.log
10/12/06 15:11:33 - \Documents and Settings\All Users\DRM\* /s
10/12/06 15:11:33 - \WINDOWS\SoftwareDistribution\* /s
10/12/06 15:11:33 - \Documents and Settings\All Users\Application Data\Microsoft\Network\Downloader\*
10/12/06 15:11:33 - \win386.swp /s
10/12/06 15:11:33 - \pagefile.sys /s
10/12/06 15:11:33 - \386spart.par
10/12/06 15:11:33 - \ea data. sf
10/12/06 15:11:33 - \SSH??P*.SSS /s
10/12/06 15:11:33 - \SSH?P*.SSS /s
10/12/06 15:11:33 - \SIS COMMON STORE\*.* /s
10/12/06 15:11:33 - \dblspace.*
10/12/06 15:11:33 - \drvspace.*
10/12/06 15:11:33 - \stacvol.*
10/12/06 15:11:33 - \_swap_.mem
10/12/06 15:11:33 - \_BEVspCacheFile_*.VSP /s
10/12/06 15:11:33 - \system\q_*.* /s
10/12/06 15:11:33 - \system\*.q /s
10/12/06 15:11:33 - \system\btrieve.trn
10/12/06 15:11:33 - \cdrom$$.rom\*.* /s
10/12/06 15:11:33 - \desktop.afp\*.*
10/12/06 15:11:33 - \snapshot\pool*.dat /s
10/12/06 15:11:33 - \Backup Exec AOFO Store\* /s
10/12/06 15:11:33 - \Program Files\VERITAS\Backup Exec\RANT\Catalogs\FD??????.FDD
10/12/06 15:11:33 - \Program Files\VERITAS\Backup Exec\RANT\Catalogs\EM??????.FDD
10/12/06 15:11:33 - \Program Files\VERITAS\Backup Exec\RANT\Catalogs\SM??????.SM
10/12/06 15:11:33 - \Program Files\VERITAS\Backup Exec\RANT\Catalogs\*.tmp
10/12/06 15:11:33 Detach from \\LOGNAV02\C:
10/12/06 15:11:33 Job Start - Thu Oct 12 15:11:33 2006
10/12/06 15:11:33 Entering SetupLocalShareInfo
10/12/06 15:11:33 Informational: Enumerating DFS
10/12/06 15:11:33 Attach to \\LOGNAV02\C:
10/12/06 15:11:33 Informational status -536805885 calling FS_AttachToDLE for device C: in LP_ENV::LoadEnumSpecFileExcludes
10/12/06 15:11:33 Informational status -536805885 calling FS_AttachToDLE for device E: in LP_ENV::LoadEnumSpecFileExcludes
10/12/06 15:11:33 Status RPC_E_TOO_LATE (0x80010119) returned initializing COM when initializing shadow copy
10/12/06 15:11:33 Calling IVssBackupComponents::GatherWriterMetadata...
10/12/06 15:11:34 ...completed IVssBackupComponents::GatherWriterMetadata
10/12/06 15:11:34 brUtil::brUtil( img ) Constructor
10/12/06 15:11:34 Attach to Shadow?Copy?Components
10/12/06 15:11:34 Informational status CODE (0x00000002) returned calling FindFirstFile for C:\WINDOWS\system32\perf?00?.bak when getting additional files
10/12/06 15:11:38 Detach from Shadow?Copy?Components
10/12/06 15:11:38 brUtil::brUtil Destructor
10/12/06 15:11:38 Informational status -536805885 calling FS_AttachToDLE for device \\LOGNAV02\C: in LP_ENV::LoadEnumSpecFileExcludes
10/12/06 15:11:38 Informational status -536805885 calling FS_AttachToDLE for device \\LOGNAV02\E: in LP_ENV::LoadEnumSpecFileExcludes
10/12/06 15:11:38 Status RPC_E_TOO_LATE (0x80010119) returned initializing COM when initializing shadow copy
10/12/06 15:11:38 Calling IVssBackupComponents::GatherWriterMetadata...
10/12/06 15:11:39 ...completed IVssBackupComponents::GatherWriterMetadata
10/12/06 15:11:39 brUtil::brUtil( img ) Constructor
10/12/06 15:11:39 Attach to \\LOGNAV02\Shadow?Copy?Components
10/12/06 15:11:39 Informational status CODE (0x00000002) returned calling FindFirstFile for C:\WINDOWS\system32\perf?00?.bak when getting additional files
10/12/06 15:11:47 Detach from \\LOGNAV02\Shadow?Copy?Components
10/12/06 15:11:47 brUtil::brUtil Destructor
10/12/06 15:11:47 TF_OpenTape()
10/12/06 15:11:47 TF_GetDriveContext ...
10/12/06 15:11:47 TF_GetDriveContext returning 0, context = 479D3E8
10/12/06 15:11:47 Allocated 10 buffers, size 32768 bytes, total used: 328520
10/12/06 15:11:47 TF_OpenSet()
10/12/06 15:11:47 SetupFormatEnv( fmt=0 )
10/12/06 15:11:47 End of TF_OpenSet() ret_val = 0, num buffers = 10
10/12/06 15:11:47 Windows Server 2003 (or higher) detected. No S2LP mapping required.
10/12/06 15:14:07 TF_GetNextTapeRequest( ) Error = E00084F9
10/12/06 15:14:07 TF_GetNextTapeRequest( :( Recalled in Error State
10/12/06 15:14:07 TF_GetNextTapeRequest( :( Recalled in Error State
10/12/06 15:14:07 TF_CloseSet()
10/12/06 15:14:07 Fatal error in channel.
10/12/06 15:14:07 FreeFormatEnv( cur_fmt=0 )
10/12/06 15:14:07 Detach from \\LOGNAV02\C:
10/12/06 15:14:07 TF_FreeDriveContext( 479D3E8 )
10/12/06 15:14:07 TF_FreeTapeBuffers: from 10 to 0 buffers
10/12/06 15:14:07 Job Stop(0) - Thu Oct 12 15:14:07 2006
10/12/06 15:18:26 ndmpRun: accept() returned 10004
10/12/06 15:18:26 FS_RemoveFileSys
10/12/06 15:18:26 Notes Agent: NOTES_DeInitFileSys
10/12/06 15:18:26 Notes Agent: Lotus Notes not installed.
10/12/06 15:18:26 Informational: De-initializing the BeDiskFind library 'BEDiskFind.dll' in SHADOW::DeInitBeDiskFindHelperApis
10/12/06 15:18:26 Informational: De-initializing the BeDisk library 'BeDisk.dll' in SHADOW::DeInitBeDiskHelperApis
10/12/06 15:18:26 Informational: De-initializing the Cps library 'CPSVersion.dll' in CPS::DeInitCpsHelperApis:540
10/12/06 15:18:26 ENTER DPM::DeInit
10/12/06 15:18:26 ENTER DPM::IsServiceRunning
10/12/06 15:18:26 DPM: Failed OpenSCManager.
10/12/06 15:18:26 DPM: Service is running:
10/12/06 15:18:26 EXIT DPM::IsServiceRunning
10/12/06 15:18:26 EXIT DPM::DeInit
10/12/06 15:18:26 unloading bedssms.dll
10/12/06 15:18:26 unloading bedsxchg.dll
10/12/06 15:18:26 unloading bedssmsp.dll
10/12/06 15:18:26 unloading bedsnote.dll
10/12/06 15:18:26 unloading bedsnt5.dll
10/12/06 15:18:26 unloading bedssql2.dll
10/12/06 15:18:26 unloading bedsmdoc.dll
10/12/06 15:18:26 unloading bedsshadow.dll
10/12/06 15:18:26 unloading bedsxese.dll
10/12/06 15:18:26 unloading bedsupfs.dll
10/12/06 15:18:26 unloading bedssps2.dll
10/12/06 15:18:26 unloading bedsra.dll
10/12/06 15:18:26 unloading bedsoffhost.dll
10/12/06 15:18:26 unloading bedscps.dll
10/12/06 15:18:26 unloading bedsdpm.dll
10/12/06 15:18:26 ENTER DpmSettings::~DpmSettings
10/12/06 15:18:26 EXIT DpmSettings::~DpmSettings return=

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

now the backup for this server is keep on crashing as soon as i take the backup whether with system state or not. or only c: \ etc. also

the version for veritas is : symantec BE 10d for windows servers

version 10.1 rev 5629 ... and we have al lthe updates.

afetr the backup thge remote server will stuck and we cant even ping it , not to mention the backup will fail.

" backup- \\--------\C: AOFO: Initialization failure on: "\\LOGNAV02\Shadow?Copy?Components". Advanced Open File Option used: No.
The network connection failed during the snapshot. Check the network, and then run the job again.
V-79-57344-65072 - The connection to target system has been lost. Backup set canceled.
"
Pls help us since we cant have one server without backup and which keeps on getting crashed during the backup.

Port for backup is used by veritas only.

thanks

HARRY

Henry_Tjham_2 · ‎10-13-2006

I've had this same problem for the past 2 nights of differential backup, Wednesday and Thursday. I had to manually start the service and then run the jobs again. I suspect the service is going to crash again on my next backup job, which is scheduled for Sunday night.

Anyhow, on Wednesday evening, I installed Microsoft patches that came out on Patch Tuesday on the SBS 2003 server. Might have been the culprit.
Harjinder, did you install MS Updates as well?

harjinder_singh · ‎10-16-2006

Hi Henry,

thanks for replying.

well I am using veritas for last 6 years and the new version (10d)is really very weird.I have tried to start the service manually also but the same old problem.
I had this problem for almost a month now , so dont think that it has to do with windows updates.and since my server is on cluster and the other node is fine and i always update both of them one day after the other.

Can u specify the error you are getting.Pls let me know if your veritas backup was fine on sunday.

thanks

HARJINDER

Henry_Tjham_2 · ‎10-16-2006

Sunday backup ran fine. The beremote service was undisturbed. Basically, clueless, but grateful.

I take a closer look at my Event Viewer. This one is simply an Information, and it was the last one I ever got regarding beremote.

Event Type:Information
Event Source:Application Error
Event Category:(100)
Event ID:1004
Date:10/13/2006
Time:7:39:22 AM
User:N/A
Computer:edited
Description:
Reporting queued error: faulting application beremote.exe, version 10.1.5629.34, faulting module bedssql2.dll, version 10.1.5629.37, fault address 0x0002e9a9.

And the last two times when beremote failed, this was the error:

Event Type:Error
Event Source:Application Error
Event Category:(100)
Event ID:1000
Date:10/12/2006
Time:9:53:55 PM
User:N/A
Computer:edited
Description:
Faulting application beremote.exe, version 10.1.5629.34, faulting module bedssql2.dll, version 10.1.5629.37, fault address 0x0002e9a9.

My search on these on the internet produced nothing relevant. But I hope this helps. Good luck.

shweta_rege · ‎10-17-2006

Hello,

Try repairing the Backup Exec installation using the following technote

http://support.veritas.com/docs/253199

Thank You,

Shweta

harjinder_singh · ‎10-20-2006

Hi shweta,

thanks for your reply.

Well i have tried to repair the backup exec server (backup server) and agent also (for the remote server) but the same result.

This problem is horrible for me , since not only it doesnt backup the server but it crashes the server.

Pls help me to fix this problem

Regards

Harjinder Singh
(h.singh@lgcom.net)

VOX

Backup Exec Remote Agent for Windows Servers service keep crashing