Turn on suggestions
Auto-suggest helps you quickly narrow down your search results by suggesting possible matches as you type.
Showing results for
- VOX
- Data Protection
- Backup Exec
- Remote Agent fials to connect
Options
- Subscribe to RSS Feed
- Mark Topic as New
- Mark Topic as Read
- Float this Topic for Current User
- Bookmark
- Subscribe
- Mute
- Printer Friendly Page
Remote Agent fials to connect
Options
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
05-30-2005 06:01 AM
Hi,
I have an w2k3 server set up as the media server and have installed the remote agent on an SBS2k3 server.
I have completed all the required updates sp2 and relative patches and also carried out an alternative local install of the rant32 setupaa.cmd file.
I have confirmed that the Backupexec remote agent service has started.
Following the article http://seer.support.veritas.com/docs/265736.htm
But my remote backup continues to fail with the error
a00084f9 - A communications failure has occurred between the Backup Exec job engine and the remote
My debug logs are as follows:-
bremote
528 30/05/2005 12:06:16: Opening debug log C:\Program Files\VERITAS\Backup Exec\NT\logs\DOODLEBUG-beremote04.log
538 30/05/2005 12:06:16: FS_InitFileSys
538 30/05/2005 12:06:17: loaded bedsnt5.dll
538 30/05/2005 12:06:17: loaded bedssql2.dll
538 30/05/2005 12:06:17: loaded bedsxchg.dll
538 30/05/2005 12:06:17: loaded bedsxese.dll
538 30/05/2005 12:06:17: loaded bedsmbox.dll
538 30/05/2005 12:06:17: loaded bedspush.dll
538 30/05/2005 12:06:17: loaded bedsnote.dll
538 30/05/2005 12:06:17: loaded bedsmdoc.dll
538 30/05/2005 12:06:17: loaded bedsupfs.dll
538 30/05/2005 12:06:17: loaded bedsshadow.dll
538 30/05/2005 12:06:17: loaded bedsagnt.dll
538 30/05/2005 12:06:17: loaded bedssms.dll
538 30/05/2005 12:06:17: loaded bedssmsp.dll
538 30/05/2005 12:06:17: Initializing FSs
538 30/05/2005 12:06:17: This is NOT an Exchange server.
538 30/05/2005 12:06:17: FS 12 failed to initialize: -489
538 30/05/2005 12:06:17: unloading bedsmbox.dll
538 30/05/2005 12:06:18: first load attempt of esebcli2.dll failed: The specified module could not be found.
538 30/05/2005 12:06:18: second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
538 30/05/2005 12:06:18: Looking for esebcli2.dll in sysetm path
538 30/05/2005 12:06:18: never found EseBcli2.dll
538 30/05/2005 12:06:18: esebcli2.dll not loaded
528 30/05/2005 12:06:18: Running... 'Q' to stop
Bengine
aec 30/05/2005 12:06:43: FS_InitFileSys
aec 30/05/2005 12:06:43: loaded bedsnt5.dll
aec 30/05/2005 12:06:43: loaded bedssql2.dll
aec 30/05/2005 12:06:43: loaded bedsagnt.dll
aec 30/05/2005 12:06:43: loaded bedssms.dll
aec 30/05/2005 12:06:43: loaded bedsxchg.dll
aec 30/05/2005 12:06:43: loaded bedsxese.dll
aec 30/05/2005 12:06:43: loaded bedsmbox.dll
aec 30/05/2005 12:06:43: loaded bedspush.dll
aec 30/05/2005 12:06:43: loaded bedssmsp.dll
aec 30/05/2005 12:06:43: loaded bedsnote.dll
aec 30/05/2005 12:06:43: loaded bedsmdoc.dll
aec 30/05/2005 12:06:43: loaded bedsupfs.dll
aec 30/05/2005 12:06:43: loaded bedsshadow.dll
aec 30/05/2005 12:06:43: Initializing FSs
aec 30/05/2005 12:06:43: This is NOT an Exchange server.
aec 30/05/2005 12:06:43: FS 12 failed to initialize: -489
aec 30/05/2005 12:06:43: unloading bedsmbox.dll
aec 30/05/2005 12:06:43: first load attempt of esebcli2.dll failed: The specified module could not be found.
aec 30/05/2005 12:06:43: second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
aec 30/05/2005 12:06:43: Looking for esebcli2.dll in sysetm path
aec 30/05/2005 12:06:43: never found EseBcli2.dll
aec 30/05/2005 12:06:43: esebcli2.dll not loaded
aec 30/05/2005 12:06:43: Initializing SNMP traps
aec 30/05/2005 12:06:43: Catalog path: C:\Program Files\VERITAS\Backup Exec\NT\Catalogs\
aec 30/05/2005 12:06:43: Data path: C:\Program Files\VERITAS\Backup Exec\NT\Data\
aec 30/05/2005 12:06:43: Log file root: BEX
aec 30/05/2005 12:06:43: Software Edition: SOFTWARE_EDITION_DATACENTER_MULTI
aec 30/05/2005 12:06:43: NSE: 0
aec 30/05/2005 12:06:43: Authorized Agents:
aec 30/05/2005 12:06:43: AUTH_AGENT_DOS
aec 30/05/2005 12:06:43: AUTH_AGENT_WIN16
aec 30/05/2005 12:06:43: AUTH_AGENT_OS2
aec 30/05/2005 12:06:43: AUTH_AGENT_WIN95
aec 30/05/2005 12:06:43: AUTH_AGENT_UNIX
aec 30/05/2005 12:06:43: AUTH_AGENT_MAC
aec 30/05/2005 12:06:43: AUTH_AGENT_SQL2
aec 30/05/2005 12:06:43: AUTH_AGENT_SQLS
aec 30/05/2005 12:06:43: AUTH_AGENT_XCH
aec 30/05/2005 12:06:43: AUTH_AGENT_ESE
aec 30/05/2005 12:06:43: AUTH_AGENT_ORACLE
aec 30/05/2005 12:06:43: AUTH_AGENT_NETWARE
aec 30/05/2005 12:06:43: AUTH_AGENT_NT_NOTES
aec 30/05/2005 12:06:43: AUTH_AGENT_NT_ORACLE
aec 30/05/2005 12:06:43: AUTH_AGENT_MSDOC
aec 30/05/2005 12:06:43: WinNT information: 5.2 (3790) SP 1.0 "Service Pack 1"
aec 30/05/2005 12:06:43: WinNT ProductType: 2 "LanmanNT"
aec 30/05/2005 12:06:43: WinNT ProductSuite: 0x0110
aec 30/05/2005 12:06:43: Terminal Server
aec 30/05/2005 12:06:43: Server listening on RPC endpoint 'BackupExecJobRunner'
aec 30/05/2005 12:06:43: Server listening on RPC endpoint 'BackupExecSelectionService'
aec 30/05/2005 12:06:43: Running... 'Q' to stop
b88 30/05/2005 12:06:43: JobStatus thread starting
b18 30/05/2005 12:21:42: DeviceManager: timeout event fired
b18 30/05/2005 12:21:42: DeviceManager: processing pending requests
b18 30/05/2005 12:21:42: DeviceManager: going to sleep for 900000 msecs
b18 30/05/2005 12:36:42: DeviceManager: timeout event fired
b18 30/05/2005 12:36:42: DeviceManager: processing pending requests
b18 30/05/2005 12:36:42: DeviceManager: going to sleep for 900000 msecs
b8c 30/05/2005 12:45:50: JobEngine::LaunchJob
b8c 30/05/2005 12:45:50: RunJobWithGuidAndServer( {3695B101-152E-4F30-8B90-356E4FB65D07}, ) = 0
e08 30/05/2005 12:45:50: Thread for job Backup 0014 ({3695B101-152E-4F30-8B90-356E4FB65D07}) starting
e08 30/05/2005 12:45:50:
SMSAPIShim: Using BESMDR.DLL.
e08 30/05/2005 12:45:50: AddESE_DLEs( )
e08 30/05/2005 12:45:50: first load attempt of esebcli2.dll failed: The specified module could not be found.
e08 30/05/2005 12:45:50: second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
e08 30/05/2005 12:45:50: Looking for esebcli2.dll in sysetm path
e08 30/05/2005 12:45:50: never found EseBcli2.dll
e08 30/05/2005 12:45:50: esebcli2.dll not loaded
e08 30/05/2005 12:45:50: SQL2_FindDrives - the default SQL Service is not running on DOODLEBUG.
e08 30/05/2005 12:45:50: SQL2_FindDrives - checking named instance BKUPEXEC.
e08 30/05/2005 12:45:50: SQL2_CreateDLE - creating DOODLEBUG\BKUPEXEC.
e08 30/05/2005 12:45:50: SQL2_FindDrives - checking named instance BKUPEXECDLO.
e08 30/05/2005 12:45:50: SQL2_CreateDLE - creating DOODLEBUG\BKUPEXECDLO.
e08 30/05/2005 12:45:50: Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
e08 30/05/2005 12:45:50: No utility partitions found on any of the disks
e08 30/05/2005 12:45:50: ENGSCRPT: ConvertDeviceName osId = 0X20
e08 30/05/2005 12:45:50: ENGSCRPT: IN - oldDeviceName = \\SBS01\Microsoft Exchange Mailboxes
e08 30/05/2005 12:45:50: ENGSCRPT: OUT - newName = \\SBS01\Microsoft Exchange Mailboxes
e08 30/05/2005 12:45:50: ENGSCRPT: ConvertDeviceName osId = 0X20
e08 30/05/2005 12:45:50: ENGSCRPT: IN - oldDeviceName = \\SBS01\Microsoft Exchange Public Folders
e08 30/05/2005 12:45:50: ENGSCRPT: OUT - newName = \\SBS01\Microsoft Exchange Public Folders
e08 30/05/2005 12:45:51: ENGSCRPT: ConvertDeviceName osId = 0X26
e08 30/05/2005 12:45:51: ENGSCRPT: IN - oldDeviceName = \\SBS01\Microsoft Information Store\First Storage Group
e08 30/05/2005 12:45:51: ENGSCRPT: OUT - newName = \\SBS01\Microsoft Information Store\First Storage Group
b18 30/05/2005 12:45:51: DeviceManager: incoming event fired
b18 30/05/2005 12:45:51: DeviceManager: processing pending requests
b18 30/05/2005 12:45:51: DeviceManager: query cache miss
b18 30/05/2005 12:45:51: DeviceManager: query result = 0x00000000
b18 30/05/2005 12:45:51: Available and held drives from the pool
b18 30/05/2005 12:45:51: DELL 1 {fd24ecaf-c389-41f4-8315-49147db3c22c}
b18 30/05/2005 12:45:51: SBS {bf41462b-c2b9-43ca-a6f6-901a5b3fc935}
b18 30/05/2005 12:45:51: Drives not in use by the Engine
b18 30/05/2005 12:45:51: DELL 1 {fd24ecaf-c389-41f4-8315-49147db3c22c}
b18 30/05/2005 12:45:51: SBS {bf41462b-c2b9-43ca-a6f6-901a5b3fc935}
b18 30/05/2005 12:45:51: Drives available (not in use and not held)
b18 30/05/2005 12:45:51: DELL 1 {fd24ecaf-c389-41f4-8315-49147db3c22c}
b18 30/05/2005 12:45:51: SBS {bf41462b-c2b9-43ca-a6f6-901a5b3fc935}
b18 30/05/2005 12:45:51: Handing out drive:
b18 30/05/2005 12:45:51: DELL 1 {fd24ecaf-c389-41f4-8315-49147db3c22c}
b18 30/05/2005 12:45:51: DeviceManager: going to sleep for 900000 msecs
e08 30/05/2005 12:45:51: BackupJob: acquired device DELL 1
e08 30/05/2005 12:45:51: BackupJob: trying to mount scratch volume
e08 30/05/2005 12:45:55: Block size: 8192
e08 30/05/2005 12:45:55: Buffer size: 32768
e08 30/05/2005 12:45:55: Num buffers: 10
e08 30/05/2005 12:45:55: High water: 0
e08 30/05/2005 12:45:55: BackupJob: medium successfully mounted
e08 30/05/2005 12:45:55: Media Label: 4MM000002
e08 30/05/2005 12:45:55: Media GUID: {C76985BF-452C-4A8C-9426-17F76EF81F5D}
e08 30/05/2005 12:45:55: Overwrite Protected Until: 31/12/9999 00:00:00
e08 30/05/2005 12:45:55: Appendable Until: 31/12/9999 00:00:00
e08 30/05/2005 12:45:55: TAPEALERT: Get TapeAlert Flags Return Code = 0X0
e08 30/05/2005 12:45:55: TAPEALERT: TapeAlert Device Flag = 0X0
e08 30/05/2005 12:45:55: TAPEALERT: TapeAlert Changer Flag = 0X0
e08 30/05/2005 12:45:55: SetupNDMPConnection(RANT)
e08 30/05/2005 12:45:55: SetupNDMPConnection('SBS01' Use Auth: True)
e08 30/05/2005 12:45:55: NDMP version 3 connection CONNECTED
e08 30/05/2005 12:45:55: SetupNDMPConnection(SBS01) connection open Success
e08 30/05/2005 12:45:55: SetupNDMPConnection(SBS01) Find User Name & Password
e08 30/05/2005 12:45:55: ndmpcGetUsernamePassword('\\SBS01\Microsoft Exchange Mailboxes')
e08 30/05/2005 12:45:55: ndmpcGetUsernamePassword('\\SBS01\Microsoft Exchange Mailboxes') Found
e08 30/05/2005 12:45:55: ndmpcGetUsernamePassword('\\SBS01')
e08 30/05/2005 12:45:55: ndmpcGetUsernamePassword('\\SBS01') Found
e08 30/05/2005 12:45:55: SetupNDMPConnection(SBS01): connectClientAuth()
e08 30/05/2005 12:45:55: ndmpcSnapshotPrepare: Warning. OSId: 32 is not snappable. Skipped.
e08 30/05/2005 12:45:55: ndmpcSnapshotPrepare: Warning. OSId: 32 is not snappable. Skipped.
e08 30/05/2005 12:45:55: ndmpcSnapshotPrepare: Warning. OSId: 38 is not snappable. Skipped.
e08 30/05/2005 12:45:55: ndmpcSnapshotPrepare: Warning. No devices to snap. Returning with NDMP_SNAPSHOT_NO_DEVICES2SNAP
e08 30/05/2005 12:45:55: TF_OpenTape()
e08 30/05/2005 12:45:55: TF_GetDriveContext ...
sessionId = \\DOODLEBUG\SESSION\{8A5723C7-551A-483B-A7F6-B1B8E33565AA}
initAsync = 1
e08 30/05/2005 12:45:56: HARDWARE COMPRESSION ===> Compression is configurable.
e08 30/05/2005 12:45:56: GET_DRV_INF: bsize = 8192
e08 30/05/2005 12:45:56: HARDWARE COMPRESSION ===> Setting compression off.
e08 30/05/2005 12:45:56: TF_GetDriveContext returning 0, context = 1C47008
e08 30/05/2005 12:45:56: Allocated 2 buffers, size 32768 bytes, total used: 65720
e08 30/05/2005 12:45:56: HARDWARE COMPRESSION ===> Compression is configurable.
e08 30/05/2005 12:45:56: GET_DRV_INF: bsize = 8192
e08 30/05/2005 12:45:56: NDMPEngine::Run(): calling ProcessBSD()
e08 30/05/2005 12:45:56: TF_OpenSet( )
e08 30/05/2005 12:45:56: FreeFormatEnv( cur_fmt=65535 )
e08 30/05/2005 12:45:56: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:45:56: ret_val = 0
e08 30/05/2005 12:45:56: Requested Set: ID = ffffffff Seq = -1 Set = -1
e08 30/05/2005 12:45:56: Attempting to VCB storage media
e08 30/05/2005 12:45:56: TpRead( :(
e08 30/05/2005 12:45:57: Error = 0 Req = 8192 Got = 8192
e08 30/05/2005 12:45:57: HARDWARE COMPRESSION ===> Compression is configurable.
e08 30/05/2005 12:45:57: GET_DRV_INF: bsize = 8192
e08 30/05/2005 12:45:57: FreeFormatEnv( cur_fmt=65535 )
e08 30/05/2005 12:45:57: SetupFormatEnv( fmt=0 )
e08 30/05/2005 12:45:57: TpRead( :(
e08 30/05/2005 12:45:57: Error = 1104 Req = 8192 Got = 0
e08 30/05/2005 12:45:57: FreeFormatEnv( cur_fmt=0 )
e08 30/05/2005 12:45:58: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:45:58: ret_val = 0
e08 30/05/2005 12:45:58: PositionAtSet( :( TF Msg = 7
e08 30/05/2005 12:45:58: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:45:58: ret_val = 0
e08 30/05/2005 12:45:58: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:45:58: ret_val = 0
e08 30/05/2005 12:45:58: UI Msg = 8003
e08 30/05/2005 12:45:58: HARDWARE COMPRESSION ===> Compression is configurable.
e08 30/05/2005 12:45:58: GET_DRV_INF: bsize = 8192
e08 30/05/2005 12:45:58: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:45:58: ret_val = 0
e08 30/05/2005 12:45:58: FreeFormatEnv( cur_fmt=65535 )
e08 30/05/2005 12:45:58: SetupFormatEnv( fmt=0 )
e08 30/05/2005 12:45:58: End of TF_OpenSet: Ret_val = 0 Buffs = 2 HiWater = 0
e08 30/05/2005 12:45:58: HARDWARE COMPRESSION ===> Setting compression on.
e08 30/05/2005 12:46:03: WriteEndSet( 1 ) returning 0
e08 30/05/2005 12:46:03: Current Block is = 3
e08 30/05/2005 12:46:03: ndmpcGetUsernamePassword('\\SBS01\Microsoft Exchange Mailboxes')
e08 30/05/2005 12:46:03: ndmpcGetUsernamePassword('\\SBS01\Microsoft Exchange Mailboxes') Found
e08 30/05/2005 12:46:03: ndmpcGetUsernamePassword('\\SBS01')
e08 30/05/2005 12:46:03: ndmpcGetUsernamePassword('\\SBS01') Found
e08 30/05/2005 12:46:03: OpenListenSocket: Media server IP address: a00a8c0
e08 30/05/2005 12:46:03: OpenListenSocket: Media server port: 304
e08 30/05/2005 12:46:44: ERROR: Error: Cannot connect / not connected
e08 30/05/2005 12:46:44: TF_InitMediaServerConnection: dataConnect failed with error code : 23
e08 30/05/2005 12:46:44: TF_CloseSet
e08 30/05/2005 12:46:44: - Read Buffer Left Over
e08 30/05/2005 12:46:44: NDMPEngine::Run(): ProcessBSD() returned 0
e08 30/05/2005 12:46:44: NDMPEngine::Run(): calling ProcessBSD()
e08 30/05/2005 12:46:44: TF_OpenSet( )
e08 30/05/2005 12:46:44: Hold Buffer from last Close
e08 30/05/2005 12:46:44: Requested Set: ID = ffffffff Seq = -1 Set = -1
e08 30/05/2005 12:46:44: Attempting to VCB storage media
e08 30/05/2005 12:46:44: TpRead( :(
e08 30/05/2005 12:46:44: Error = 1104 Req = 8192 Got = 0
e08 30/05/2005 12:46:44: FreeFormatEnv( cur_fmt=0 )
e08 30/05/2005 12:46:50: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:46:50: ret_val = 0
e08 30/05/2005 12:46:50: PositionAtSet( :( TF Msg = 7
e08 30/05/2005 12:46:50: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:46:50: ret_val = 0
e08 30/05/2005 12:46:50: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:46:50: ret_val = 0
e08 30/05/2005 12:46:50: UI Msg = 8003
e08 30/05/2005 12:46:50: HARDWARE COMPRESSION ===> Compression is configurable.
e08 30/05/2005 12:46:50: GET_DRV_INF: bsize = 8192
e08 30/05/2005 12:46:50: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:46:50: ret_val = 0
e08 30/05/2005 12:46:50: FreeFormatEnv( cur_fmt=65535 )
e08 30/05/2005 12:46:50: SetupFormatEnv( fmt=0 )
e08 30/05/2005 12:46:50: End of TF_OpenSet: Ret_val = 0 Buffs = 2 HiWater = 0
e08 30/05/2005 12:46:50: HARDWARE COMPRESSION ===> Setting compression on.
e08 30/05/2005 12:46:54: WriteEndSet( 1 ) returning 0
e08 30/05/2005 12:46:54: Current Block is = 3
e08 30/05/2005 12:46:54: ndmpcGetUsernamePassword('\\SBS01\Microsoft Exchange Public Folders')
e08 30/05/2005 12:46:54: ndmpcGetUsernamePassword('\\SBS01\Microsoft Exchange Public Folders') Found
e08 30/05/2005 12:46:54: ndmpcGetUsernamePassword('\\SBS01')
e08 30/05/2005 12:46:54: ndmpcGetUsernamePassword('\\SBS01') Found
e08 30/05/2005 12:46:54: OpenListenSocket: Media server IP address: a00a8c0
e08 30/05/2005 12:46:54: OpenListenSocket: Media server port: 404
e08 30/05/2005 12:47:36: ERROR: Error: Cannot connect / not connected
e08 30/05/2005 12:47:36: TF_InitMediaServerConnection: dataConnect failed with error code : 23
e08 30/05/2005 12:47:36: TF_CloseSet
e08 30/05/2005 12:47:36: - Read Buffer Left Over
e08 30/05/2005 12:47:36: NDMPEngine::Run(): ProcessBSD() returned 0
e08 30/05/2005 12:47:36: NDMPEngine::Run(): calling ProcessBSD()
e08 30/05/2005 12:47:36: TF_OpenSet( )
e08 30/05/2005 12:47:36: Hold Buffer from last Close
e08 30/05/2005 12:47:36: Requested Set: ID = ffffffff Seq = -1 Set = -1
e08 30/05/2005 12:47:36: Attempting to VCB storage media
e08 30/05/2005 12:47:36: TpRead( :(
e08 30/05/2005 12:47:36: Error = 1104 Req = 8192 Got = 0
e08 30/05/2005 12:47:36: FreeFormatEnv( cur_fmt=0 )
e08 30/05/2005 12:47:41: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:47:41: ret_val = 0
e08 30/05/2005 12:47:41: PositionAtSet( :( TF Msg = 7
e08 30/05/2005 12:47:41: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:47:41: ret_val = 0
e08 30/05/2005 12:47:41: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:47:41: ret_val = 0
e08 30/05/2005 12:47:41: UI Msg = 8003
e08 30/05/2005 12:47:41: HARDWARE COMPRESSION ===> Compression is configurable.
e08 30/05/2005 12:47:41: GET_DRV_INF: bsize = 8192
e08 30/05/2005 12:47:41: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:47:41: ret_val = 0
e08 30/05/2005 12:47:41: FreeFormatEnv( cur_fmt=65535 )
e08 30/05/2005 12:47:41: SetupFormatEnv( fmt=0 )
e08 30/05/2005 12:47:41: End of TF_OpenSet: Ret_val = 0 Buffs = 2 HiWater = 0
e08 30/05/2005 12:47:41: HARDWARE COMPRESSION ===> Setting compression on.
e08 30/05/2005 12:47:46: WriteEndSet( 1 ) returning 0
e08 30/05/2005 12:47:46: Current Block is = 3
e08 30/05/2005 12:47:46: ndmpcGetUsernamePassword('\\SBS01\Microsoft Information Store\First Storage Group')
e08 30/05/2005 12:47:46: ndmpcGetUsernamePassword('\\SBS01\Microsoft Information Store\First Storage Group') Not Found
e08 30/05/2005 12:47:46: ndmpcGetUsernamePassword('\\SBS01')
e08 30/05/2005 12:47:46: ndmpcGetUsernamePassword('\\SBS01') Found
e08 30/05/2005 12:47:46: OpenListenSocket: Media server IP address: a00a8c0
e08 30/05/2005 12:47:46: OpenListenSocket: Media server port: 504
e08 30/05/2005 12:48:28: ERROR: Error: Cannot connect / not connected
e08 30/05/2005 12:48:28: TF_InitMediaServerConnection: dataConnect failed with error code : 23
e08 30/05/2005 12:48:28: TF_CloseSet
e08 30/05/2005 12:48:28: - Read Buffer Left Over
e08 30/05/2005 12:48:28: NDMPEngine::Run(): ProcessBSD() returned 0
e08 30/05/2005 12:48:28: TAPEALERT: Get TapeAlert Flags Return Code = 0X0
e08 30/05/2005 12:48:28: TAPEALERT: TapeAlert Device Flag = 0X0
e08 30/05/2005 12:48:28: TAPEALERT: TapeAlert Changer Flag = 0X0
b18 30/05/2005 12:48:28: DeviceManager: incoming event fired
b18 30/05/2005 12:48:28: DeviceManager: processing pending requests
b18 30/05/2005 12:48:28: DeviceManager: going to sleep for 61000 msecs
e08 30/05/2005 12:48:28: Job thread terminating
b18 30/05/2005 12:49:29: DeviceManager: timeout event fired
b18 30/05/2005 12:49:29: DeviceManager: processing pending requests
b18 30/05/2005 12:49:29: Tossing drive:
b18 30/05/2005 12:49:29: DELL 1 {fd24ecaf-c389-41f4-8315-49147db3c22c}
b18 30/05/2005 12:49:29: TF_FreeDriveContext( 1C47008 )
b18 30/05/2005 12:49:29: TF_FreeTapeBuffers: from 2 to 1 buffers
b18 30/05/2005 12:49:29: FreeFormatEnv( cur_fmt=0 )
b18 30/05/2005 12:49:29: DeviceManager: going to sleep for 900000 msecs
b18 30/05/2005 12:49:29: DeviceManager: dismount event fired
b18 30/05/2005 12:49:29: DeviceManager: processing pending requests
b18 30/05/2005 12:49:29: DeviceManager: going to sleep for 900000 msecs
b18 30/05/2005 13:04:29: DeviceManager: timeout event fired
b18 30/05/2005 13:04:29: DeviceManager: processing pending requests
b18 30/05/2005 13:04:29: DeviceManager: going to sleep for 900000 msecs
b18 30/05/2005 13:19:29: DeviceManager: timeout event fired
b18 30/05/2005 13:19:29: DeviceManager: processing pending requests
b18 30/05/2005 13:19:29: DeviceManager: going to sleep for 900000 msecs
b18 30/05/2005 13:34:29: DeviceManager: timeout event fired
b18 30/05/2005 13:34:29: DeviceManager: processing pending requests
b18 30/05/2005 13:34:29: DeviceManager: going to sleep for 900000 msecs
b18 30/05/2005 13:49:29: DeviceManager: timeout event fired
b18 30/05/2005 13:49:29: DeviceManager: processing pending requests
b18 30/05/2005 13:49:29: DeviceManager: going to sleep for 900000 msecs
Any futher help would be appreciated.
I have an w2k3 server set up as the media server and have installed the remote agent on an SBS2k3 server.
I have completed all the required updates sp2 and relative patches and also carried out an alternative local install of the rant32 setupaa.cmd file.
I have confirmed that the Backupexec remote agent service has started.
Following the article http://seer.support.veritas.com/docs/265736.htm
But my remote backup continues to fail with the error
a00084f9 - A communications failure has occurred between the Backup Exec job engine and the remote
My debug logs are as follows:-
bremote
528 30/05/2005 12:06:16: Opening debug log C:\Program Files\VERITAS\Backup Exec\NT\logs\DOODLEBUG-beremote04.log
538 30/05/2005 12:06:16: FS_InitFileSys
538 30/05/2005 12:06:17: loaded bedsnt5.dll
538 30/05/2005 12:06:17: loaded bedssql2.dll
538 30/05/2005 12:06:17: loaded bedsxchg.dll
538 30/05/2005 12:06:17: loaded bedsxese.dll
538 30/05/2005 12:06:17: loaded bedsmbox.dll
538 30/05/2005 12:06:17: loaded bedspush.dll
538 30/05/2005 12:06:17: loaded bedsnote.dll
538 30/05/2005 12:06:17: loaded bedsmdoc.dll
538 30/05/2005 12:06:17: loaded bedsupfs.dll
538 30/05/2005 12:06:17: loaded bedsshadow.dll
538 30/05/2005 12:06:17: loaded bedsagnt.dll
538 30/05/2005 12:06:17: loaded bedssms.dll
538 30/05/2005 12:06:17: loaded bedssmsp.dll
538 30/05/2005 12:06:17: Initializing FSs
538 30/05/2005 12:06:17: This is NOT an Exchange server.
538 30/05/2005 12:06:17: FS 12 failed to initialize: -489
538 30/05/2005 12:06:17: unloading bedsmbox.dll
538 30/05/2005 12:06:18: first load attempt of esebcli2.dll failed: The specified module could not be found.
538 30/05/2005 12:06:18: second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
538 30/05/2005 12:06:18: Looking for esebcli2.dll in sysetm path
538 30/05/2005 12:06:18: never found EseBcli2.dll
538 30/05/2005 12:06:18: esebcli2.dll not loaded
528 30/05/2005 12:06:18: Running... 'Q' to stop
Bengine
aec 30/05/2005 12:06:43: FS_InitFileSys
aec 30/05/2005 12:06:43: loaded bedsnt5.dll
aec 30/05/2005 12:06:43: loaded bedssql2.dll
aec 30/05/2005 12:06:43: loaded bedsagnt.dll
aec 30/05/2005 12:06:43: loaded bedssms.dll
aec 30/05/2005 12:06:43: loaded bedsxchg.dll
aec 30/05/2005 12:06:43: loaded bedsxese.dll
aec 30/05/2005 12:06:43: loaded bedsmbox.dll
aec 30/05/2005 12:06:43: loaded bedspush.dll
aec 30/05/2005 12:06:43: loaded bedssmsp.dll
aec 30/05/2005 12:06:43: loaded bedsnote.dll
aec 30/05/2005 12:06:43: loaded bedsmdoc.dll
aec 30/05/2005 12:06:43: loaded bedsupfs.dll
aec 30/05/2005 12:06:43: loaded bedsshadow.dll
aec 30/05/2005 12:06:43: Initializing FSs
aec 30/05/2005 12:06:43: This is NOT an Exchange server.
aec 30/05/2005 12:06:43: FS 12 failed to initialize: -489
aec 30/05/2005 12:06:43: unloading bedsmbox.dll
aec 30/05/2005 12:06:43: first load attempt of esebcli2.dll failed: The specified module could not be found.
aec 30/05/2005 12:06:43: second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
aec 30/05/2005 12:06:43: Looking for esebcli2.dll in sysetm path
aec 30/05/2005 12:06:43: never found EseBcli2.dll
aec 30/05/2005 12:06:43: esebcli2.dll not loaded
aec 30/05/2005 12:06:43: Initializing SNMP traps
aec 30/05/2005 12:06:43: Catalog path: C:\Program Files\VERITAS\Backup Exec\NT\Catalogs\
aec 30/05/2005 12:06:43: Data path: C:\Program Files\VERITAS\Backup Exec\NT\Data\
aec 30/05/2005 12:06:43: Log file root: BEX
aec 30/05/2005 12:06:43: Software Edition: SOFTWARE_EDITION_DATACENTER_MULTI
aec 30/05/2005 12:06:43: NSE: 0
aec 30/05/2005 12:06:43: Authorized Agents:
aec 30/05/2005 12:06:43: AUTH_AGENT_DOS
aec 30/05/2005 12:06:43: AUTH_AGENT_WIN16
aec 30/05/2005 12:06:43: AUTH_AGENT_OS2
aec 30/05/2005 12:06:43: AUTH_AGENT_WIN95
aec 30/05/2005 12:06:43: AUTH_AGENT_UNIX
aec 30/05/2005 12:06:43: AUTH_AGENT_MAC
aec 30/05/2005 12:06:43: AUTH_AGENT_SQL2
aec 30/05/2005 12:06:43: AUTH_AGENT_SQLS
aec 30/05/2005 12:06:43: AUTH_AGENT_XCH
aec 30/05/2005 12:06:43: AUTH_AGENT_ESE
aec 30/05/2005 12:06:43: AUTH_AGENT_ORACLE
aec 30/05/2005 12:06:43: AUTH_AGENT_NETWARE
aec 30/05/2005 12:06:43: AUTH_AGENT_NT_NOTES
aec 30/05/2005 12:06:43: AUTH_AGENT_NT_ORACLE
aec 30/05/2005 12:06:43: AUTH_AGENT_MSDOC
aec 30/05/2005 12:06:43: WinNT information: 5.2 (3790) SP 1.0 "Service Pack 1"
aec 30/05/2005 12:06:43: WinNT ProductType: 2 "LanmanNT"
aec 30/05/2005 12:06:43: WinNT ProductSuite: 0x0110
aec 30/05/2005 12:06:43: Terminal Server
aec 30/05/2005 12:06:43: Server listening on RPC endpoint 'BackupExecJobRunner'
aec 30/05/2005 12:06:43: Server listening on RPC endpoint 'BackupExecSelectionService'
aec 30/05/2005 12:06:43: Running... 'Q' to stop
b88 30/05/2005 12:06:43: JobStatus thread starting
b18 30/05/2005 12:21:42: DeviceManager: timeout event fired
b18 30/05/2005 12:21:42: DeviceManager: processing pending requests
b18 30/05/2005 12:21:42: DeviceManager: going to sleep for 900000 msecs
b18 30/05/2005 12:36:42: DeviceManager: timeout event fired
b18 30/05/2005 12:36:42: DeviceManager: processing pending requests
b18 30/05/2005 12:36:42: DeviceManager: going to sleep for 900000 msecs
b8c 30/05/2005 12:45:50: JobEngine::LaunchJob
b8c 30/05/2005 12:45:50: RunJobWithGuidAndServer( {3695B101-152E-4F30-8B90-356E4FB65D07}, ) = 0
e08 30/05/2005 12:45:50: Thread for job Backup 0014 ({3695B101-152E-4F30-8B90-356E4FB65D07}) starting
e08 30/05/2005 12:45:50:
SMSAPIShim: Using BESMDR.DLL.
e08 30/05/2005 12:45:50: AddESE_DLEs( )
e08 30/05/2005 12:45:50: first load attempt of esebcli2.dll failed: The specified module could not be found.
e08 30/05/2005 12:45:50: second load attempt failed from path = 'esebcli2.dll': The specified module could not be found.
e08 30/05/2005 12:45:50: Looking for esebcli2.dll in sysetm path
e08 30/05/2005 12:45:50: never found EseBcli2.dll
e08 30/05/2005 12:45:50: esebcli2.dll not loaded
e08 30/05/2005 12:45:50: SQL2_FindDrives - the default SQL Service is not running on DOODLEBUG.
e08 30/05/2005 12:45:50: SQL2_FindDrives - checking named instance BKUPEXEC.
e08 30/05/2005 12:45:50: SQL2_CreateDLE - creating DOODLEBUG\BKUPEXEC.
e08 30/05/2005 12:45:50: SQL2_FindDrives - checking named instance BKUPEXECDLO.
e08 30/05/2005 12:45:50: SQL2_CreateDLE - creating DOODLEBUG\BKUPEXECDLO.
e08 30/05/2005 12:45:50: Device Shadow?Copy?Components Dle platform 2 major version 5 minor version 2 build 3790
e08 30/05/2005 12:45:50: No utility partitions found on any of the disks
e08 30/05/2005 12:45:50: ENGSCRPT: ConvertDeviceName osId = 0X20
e08 30/05/2005 12:45:50: ENGSCRPT: IN - oldDeviceName = \\SBS01\Microsoft Exchange Mailboxes
e08 30/05/2005 12:45:50: ENGSCRPT: OUT - newName = \\SBS01\Microsoft Exchange Mailboxes
e08 30/05/2005 12:45:50: ENGSCRPT: ConvertDeviceName osId = 0X20
e08 30/05/2005 12:45:50: ENGSCRPT: IN - oldDeviceName = \\SBS01\Microsoft Exchange Public Folders
e08 30/05/2005 12:45:50: ENGSCRPT: OUT - newName = \\SBS01\Microsoft Exchange Public Folders
e08 30/05/2005 12:45:51: ENGSCRPT: ConvertDeviceName osId = 0X26
e08 30/05/2005 12:45:51: ENGSCRPT: IN - oldDeviceName = \\SBS01\Microsoft Information Store\First Storage Group
e08 30/05/2005 12:45:51: ENGSCRPT: OUT - newName = \\SBS01\Microsoft Information Store\First Storage Group
b18 30/05/2005 12:45:51: DeviceManager: incoming event fired
b18 30/05/2005 12:45:51: DeviceManager: processing pending requests
b18 30/05/2005 12:45:51: DeviceManager: query cache miss
b18 30/05/2005 12:45:51: DeviceManager: query result = 0x00000000
b18 30/05/2005 12:45:51: Available and held drives from the pool
b18 30/05/2005 12:45:51: DELL 1 {fd24ecaf-c389-41f4-8315-49147db3c22c}
b18 30/05/2005 12:45:51: SBS {bf41462b-c2b9-43ca-a6f6-901a5b3fc935}
b18 30/05/2005 12:45:51: Drives not in use by the Engine
b18 30/05/2005 12:45:51: DELL 1 {fd24ecaf-c389-41f4-8315-49147db3c22c}
b18 30/05/2005 12:45:51: SBS {bf41462b-c2b9-43ca-a6f6-901a5b3fc935}
b18 30/05/2005 12:45:51: Drives available (not in use and not held)
b18 30/05/2005 12:45:51: DELL 1 {fd24ecaf-c389-41f4-8315-49147db3c22c}
b18 30/05/2005 12:45:51: SBS {bf41462b-c2b9-43ca-a6f6-901a5b3fc935}
b18 30/05/2005 12:45:51: Handing out drive:
b18 30/05/2005 12:45:51: DELL 1 {fd24ecaf-c389-41f4-8315-49147db3c22c}
b18 30/05/2005 12:45:51: DeviceManager: going to sleep for 900000 msecs
e08 30/05/2005 12:45:51: BackupJob: acquired device DELL 1
e08 30/05/2005 12:45:51: BackupJob: trying to mount scratch volume
e08 30/05/2005 12:45:55: Block size: 8192
e08 30/05/2005 12:45:55: Buffer size: 32768
e08 30/05/2005 12:45:55: Num buffers: 10
e08 30/05/2005 12:45:55: High water: 0
e08 30/05/2005 12:45:55: BackupJob: medium successfully mounted
e08 30/05/2005 12:45:55: Media Label: 4MM000002
e08 30/05/2005 12:45:55: Media GUID: {C76985BF-452C-4A8C-9426-17F76EF81F5D}
e08 30/05/2005 12:45:55: Overwrite Protected Until: 31/12/9999 00:00:00
e08 30/05/2005 12:45:55: Appendable Until: 31/12/9999 00:00:00
e08 30/05/2005 12:45:55: TAPEALERT: Get TapeAlert Flags Return Code = 0X0
e08 30/05/2005 12:45:55: TAPEALERT: TapeAlert Device Flag = 0X0
e08 30/05/2005 12:45:55: TAPEALERT: TapeAlert Changer Flag = 0X0
e08 30/05/2005 12:45:55: SetupNDMPConnection(RANT)
e08 30/05/2005 12:45:55: SetupNDMPConnection('SBS01' Use Auth: True)
e08 30/05/2005 12:45:55: NDMP version 3 connection CONNECTED
e08 30/05/2005 12:45:55: SetupNDMPConnection(SBS01) connection open Success
e08 30/05/2005 12:45:55: SetupNDMPConnection(SBS01) Find User Name & Password
e08 30/05/2005 12:45:55: ndmpcGetUsernamePassword('\\SBS01\Microsoft Exchange Mailboxes')
e08 30/05/2005 12:45:55: ndmpcGetUsernamePassword('\\SBS01\Microsoft Exchange Mailboxes') Found
e08 30/05/2005 12:45:55: ndmpcGetUsernamePassword('\\SBS01')
e08 30/05/2005 12:45:55: ndmpcGetUsernamePassword('\\SBS01') Found
e08 30/05/2005 12:45:55: SetupNDMPConnection(SBS01): connectClientAuth()
e08 30/05/2005 12:45:55: ndmpcSnapshotPrepare: Warning. OSId: 32 is not snappable. Skipped.
e08 30/05/2005 12:45:55: ndmpcSnapshotPrepare: Warning. OSId: 32 is not snappable. Skipped.
e08 30/05/2005 12:45:55: ndmpcSnapshotPrepare: Warning. OSId: 38 is not snappable. Skipped.
e08 30/05/2005 12:45:55: ndmpcSnapshotPrepare: Warning. No devices to snap. Returning with NDMP_SNAPSHOT_NO_DEVICES2SNAP
e08 30/05/2005 12:45:55: TF_OpenTape()
e08 30/05/2005 12:45:55: TF_GetDriveContext ...
sessionId = \\DOODLEBUG\SESSION\{8A5723C7-551A-483B-A7F6-B1B8E33565AA}
initAsync = 1
e08 30/05/2005 12:45:56: HARDWARE COMPRESSION ===> Compression is configurable.
e08 30/05/2005 12:45:56: GET_DRV_INF: bsize = 8192
e08 30/05/2005 12:45:56: HARDWARE COMPRESSION ===> Setting compression off.
e08 30/05/2005 12:45:56: TF_GetDriveContext returning 0, context = 1C47008
e08 30/05/2005 12:45:56: Allocated 2 buffers, size 32768 bytes, total used: 65720
e08 30/05/2005 12:45:56: HARDWARE COMPRESSION ===> Compression is configurable.
e08 30/05/2005 12:45:56: GET_DRV_INF: bsize = 8192
e08 30/05/2005 12:45:56: NDMPEngine::Run(): calling ProcessBSD()
e08 30/05/2005 12:45:56: TF_OpenSet( )
e08 30/05/2005 12:45:56: FreeFormatEnv( cur_fmt=65535 )
e08 30/05/2005 12:45:56: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:45:56: ret_val = 0
e08 30/05/2005 12:45:56: Requested Set: ID = ffffffff Seq = -1 Set = -1
e08 30/05/2005 12:45:56: Attempting to VCB storage media
e08 30/05/2005 12:45:56: TpRead( :(
e08 30/05/2005 12:45:57: Error = 0 Req = 8192 Got = 8192
e08 30/05/2005 12:45:57: HARDWARE COMPRESSION ===> Compression is configurable.
e08 30/05/2005 12:45:57: GET_DRV_INF: bsize = 8192
e08 30/05/2005 12:45:57: FreeFormatEnv( cur_fmt=65535 )
e08 30/05/2005 12:45:57: SetupFormatEnv( fmt=0 )
e08 30/05/2005 12:45:57: TpRead( :(
e08 30/05/2005 12:45:57: Error = 1104 Req = 8192 Got = 0
e08 30/05/2005 12:45:57: FreeFormatEnv( cur_fmt=0 )
e08 30/05/2005 12:45:58: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:45:58: ret_val = 0
e08 30/05/2005 12:45:58: PositionAtSet( :( TF Msg = 7
e08 30/05/2005 12:45:58: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:45:58: ret_val = 0
e08 30/05/2005 12:45:58: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:45:58: ret_val = 0
e08 30/05/2005 12:45:58: UI Msg = 8003
e08 30/05/2005 12:45:58: HARDWARE COMPRESSION ===> Compression is configurable.
e08 30/05/2005 12:45:58: GET_DRV_INF: bsize = 8192
e08 30/05/2005 12:45:58: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:45:58: ret_val = 0
e08 30/05/2005 12:45:58: FreeFormatEnv( cur_fmt=65535 )
e08 30/05/2005 12:45:58: SetupFormatEnv( fmt=0 )
e08 30/05/2005 12:45:58: End of TF_OpenSet: Ret_val = 0 Buffs = 2 HiWater = 0
e08 30/05/2005 12:45:58: HARDWARE COMPRESSION ===> Setting compression on.
e08 30/05/2005 12:46:03: WriteEndSet( 1 ) returning 0
e08 30/05/2005 12:46:03: Current Block is = 3
e08 30/05/2005 12:46:03: ndmpcGetUsernamePassword('\\SBS01\Microsoft Exchange Mailboxes')
e08 30/05/2005 12:46:03: ndmpcGetUsernamePassword('\\SBS01\Microsoft Exchange Mailboxes') Found
e08 30/05/2005 12:46:03: ndmpcGetUsernamePassword('\\SBS01')
e08 30/05/2005 12:46:03: ndmpcGetUsernamePassword('\\SBS01') Found
e08 30/05/2005 12:46:03: OpenListenSocket: Media server IP address: a00a8c0
e08 30/05/2005 12:46:03: OpenListenSocket: Media server port: 304
e08 30/05/2005 12:46:44: ERROR: Error: Cannot connect / not connected
e08 30/05/2005 12:46:44: TF_InitMediaServerConnection: dataConnect failed with error code : 23
e08 30/05/2005 12:46:44: TF_CloseSet
e08 30/05/2005 12:46:44: - Read Buffer Left Over
e08 30/05/2005 12:46:44: NDMPEngine::Run(): ProcessBSD() returned 0
e08 30/05/2005 12:46:44: NDMPEngine::Run(): calling ProcessBSD()
e08 30/05/2005 12:46:44: TF_OpenSet( )
e08 30/05/2005 12:46:44: Hold Buffer from last Close
e08 30/05/2005 12:46:44: Requested Set: ID = ffffffff Seq = -1 Set = -1
e08 30/05/2005 12:46:44: Attempting to VCB storage media
e08 30/05/2005 12:46:44: TpRead( :(
e08 30/05/2005 12:46:44: Error = 1104 Req = 8192 Got = 0
e08 30/05/2005 12:46:44: FreeFormatEnv( cur_fmt=0 )
e08 30/05/2005 12:46:50: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:46:50: ret_val = 0
e08 30/05/2005 12:46:50: PositionAtSet( :( TF Msg = 7
e08 30/05/2005 12:46:50: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:46:50: ret_val = 0
e08 30/05/2005 12:46:50: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:46:50: ret_val = 0
e08 30/05/2005 12:46:50: UI Msg = 8003
e08 30/05/2005 12:46:50: HARDWARE COMPRESSION ===> Compression is configurable.
e08 30/05/2005 12:46:50: GET_DRV_INF: bsize = 8192
e08 30/05/2005 12:46:50: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:46:50: ret_val = 0
e08 30/05/2005 12:46:50: FreeFormatEnv( cur_fmt=65535 )
e08 30/05/2005 12:46:50: SetupFormatEnv( fmt=0 )
e08 30/05/2005 12:46:50: End of TF_OpenSet: Ret_val = 0 Buffs = 2 HiWater = 0
e08 30/05/2005 12:46:50: HARDWARE COMPRESSION ===> Setting compression on.
e08 30/05/2005 12:46:54: WriteEndSet( 1 ) returning 0
e08 30/05/2005 12:46:54: Current Block is = 3
e08 30/05/2005 12:46:54: ndmpcGetUsernamePassword('\\SBS01\Microsoft Exchange Public Folders')
e08 30/05/2005 12:46:54: ndmpcGetUsernamePassword('\\SBS01\Microsoft Exchange Public Folders') Found
e08 30/05/2005 12:46:54: ndmpcGetUsernamePassword('\\SBS01')
e08 30/05/2005 12:46:54: ndmpcGetUsernamePassword('\\SBS01') Found
e08 30/05/2005 12:46:54: OpenListenSocket: Media server IP address: a00a8c0
e08 30/05/2005 12:46:54: OpenListenSocket: Media server port: 404
e08 30/05/2005 12:47:36: ERROR: Error: Cannot connect / not connected
e08 30/05/2005 12:47:36: TF_InitMediaServerConnection: dataConnect failed with error code : 23
e08 30/05/2005 12:47:36: TF_CloseSet
e08 30/05/2005 12:47:36: - Read Buffer Left Over
e08 30/05/2005 12:47:36: NDMPEngine::Run(): ProcessBSD() returned 0
e08 30/05/2005 12:47:36: NDMPEngine::Run(): calling ProcessBSD()
e08 30/05/2005 12:47:36: TF_OpenSet( )
e08 30/05/2005 12:47:36: Hold Buffer from last Close
e08 30/05/2005 12:47:36: Requested Set: ID = ffffffff Seq = -1 Set = -1
e08 30/05/2005 12:47:36: Attempting to VCB storage media
e08 30/05/2005 12:47:36: TpRead( :(
e08 30/05/2005 12:47:36: Error = 1104 Req = 8192 Got = 0
e08 30/05/2005 12:47:36: FreeFormatEnv( cur_fmt=0 )
e08 30/05/2005 12:47:41: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:47:41: ret_val = 0
e08 30/05/2005 12:47:41: PositionAtSet( :( TF Msg = 7
e08 30/05/2005 12:47:41: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:47:41: ret_val = 0
e08 30/05/2005 12:47:41: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:47:41: ret_val = 0
e08 30/05/2005 12:47:41: UI Msg = 8003
e08 30/05/2005 12:47:41: HARDWARE COMPRESSION ===> Compression is configurable.
e08 30/05/2005 12:47:41: GET_DRV_INF: bsize = 8192
e08 30/05/2005 12:47:41: RewindDrive mover ret = 0 (0x0)
e08 30/05/2005 12:47:41: ret_val = 0
e08 30/05/2005 12:47:41: FreeFormatEnv( cur_fmt=65535 )
e08 30/05/2005 12:47:41: SetupFormatEnv( fmt=0 )
e08 30/05/2005 12:47:41: End of TF_OpenSet: Ret_val = 0 Buffs = 2 HiWater = 0
e08 30/05/2005 12:47:41: HARDWARE COMPRESSION ===> Setting compression on.
e08 30/05/2005 12:47:46: WriteEndSet( 1 ) returning 0
e08 30/05/2005 12:47:46: Current Block is = 3
e08 30/05/2005 12:47:46: ndmpcGetUsernamePassword('\\SBS01\Microsoft Information Store\First Storage Group')
e08 30/05/2005 12:47:46: ndmpcGetUsernamePassword('\\SBS01\Microsoft Information Store\First Storage Group') Not Found
e08 30/05/2005 12:47:46: ndmpcGetUsernamePassword('\\SBS01')
e08 30/05/2005 12:47:46: ndmpcGetUsernamePassword('\\SBS01') Found
e08 30/05/2005 12:47:46: OpenListenSocket: Media server IP address: a00a8c0
e08 30/05/2005 12:47:46: OpenListenSocket: Media server port: 504
e08 30/05/2005 12:48:28: ERROR: Error: Cannot connect / not connected
e08 30/05/2005 12:48:28: TF_InitMediaServerConnection: dataConnect failed with error code : 23
e08 30/05/2005 12:48:28: TF_CloseSet
e08 30/05/2005 12:48:28: - Read Buffer Left Over
e08 30/05/2005 12:48:28: NDMPEngine::Run(): ProcessBSD() returned 0
e08 30/05/2005 12:48:28: TAPEALERT: Get TapeAlert Flags Return Code = 0X0
e08 30/05/2005 12:48:28: TAPEALERT: TapeAlert Device Flag = 0X0
e08 30/05/2005 12:48:28: TAPEALERT: TapeAlert Changer Flag = 0X0
b18 30/05/2005 12:48:28: DeviceManager: incoming event fired
b18 30/05/2005 12:48:28: DeviceManager: processing pending requests
b18 30/05/2005 12:48:28: DeviceManager: going to sleep for 61000 msecs
e08 30/05/2005 12:48:28: Job thread terminating
b18 30/05/2005 12:49:29: DeviceManager: timeout event fired
b18 30/05/2005 12:49:29: DeviceManager: processing pending requests
b18 30/05/2005 12:49:29: Tossing drive:
b18 30/05/2005 12:49:29: DELL 1 {fd24ecaf-c389-41f4-8315-49147db3c22c}
b18 30/05/2005 12:49:29: TF_FreeDriveContext( 1C47008 )
b18 30/05/2005 12:49:29: TF_FreeTapeBuffers: from 2 to 1 buffers
b18 30/05/2005 12:49:29: FreeFormatEnv( cur_fmt=0 )
b18 30/05/2005 12:49:29: DeviceManager: going to sleep for 900000 msecs
b18 30/05/2005 12:49:29: DeviceManager: dismount event fired
b18 30/05/2005 12:49:29: DeviceManager: processing pending requests
b18 30/05/2005 12:49:29: DeviceManager: going to sleep for 900000 msecs
b18 30/05/2005 13:04:29: DeviceManager: timeout event fired
b18 30/05/2005 13:04:29: DeviceManager: processing pending requests
b18 30/05/2005 13:04:29: DeviceManager: going to sleep for 900000 msecs
b18 30/05/2005 13:19:29: DeviceManager: timeout event fired
b18 30/05/2005 13:19:29: DeviceManager: processing pending requests
b18 30/05/2005 13:19:29: DeviceManager: going to sleep for 900000 msecs
b18 30/05/2005 13:34:29: DeviceManager: timeout event fired
b18 30/05/2005 13:34:29: DeviceManager: processing pending requests
b18 30/05/2005 13:34:29: DeviceManager: going to sleep for 900000 msecs
b18 30/05/2005 13:49:29: DeviceManager: timeout event fired
b18 30/05/2005 13:49:29: DeviceManager: processing pending requests
b18 30/05/2005 13:49:29: DeviceManager: going to sleep for 900000 msecs
Any futher help would be appreciated.
Labels:
9 REPLIES 9
Options
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
05-31-2005 03:16 AM
Hi John,
After referring to the Bengine log, I noticed that following error had occured.
e08 30/05/2005 12:46:44: ERROR: Error: Cannot connect / not connected
e08 30/05/2005 12:46:44: TF_InitMediaServerConnection: dataConnect failed with error code : 23
In order to resolve this issue please refer to the following technote
http://support.veritas.com/docs/258331
After referring to the Bengine log, I noticed that following error had occured.
e08 30/05/2005 12:46:44: ERROR: Error: Cannot connect / not connected
e08 30/05/2005 12:46:44: TF_InitMediaServerConnection: dataConnect failed with error code : 23
In order to resolve this issue please refer to the following technote
http://support.veritas.com/docs/258331
Options
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
05-31-2005 08:32 AM
I have followed the procedure described in your link but the settings were already as the article recommended.
I have also enabled the dynamic port range but this has no effect either.
Is there any other information that may be helpful or do you have any other procedures to try?
The servers are separated by a pix that allows traffic to flow unrestricted between the tow servers although they are on different address ranges and replication functions correctly.
I have also enabled the dynamic port range but this has no effect either.
Is there any other information that may be helpful or do you have any other procedures to try?
The servers are separated by a pix that allows traffic to flow unrestricted between the tow servers although they are on different address ranges and replication functions correctly.
Options
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
06-06-2005 02:06 AM
Hello,
Does the problem regarding remote backups still persist? It seems that you already had the settings for the 'use any available network card' enabled. You have mentioned that you have enabled the dynamic port range, what is the port range that you have specified?
You can additionally refer to the technotes given below in order to resolve the problem:
Title: "A communications failure has occurred between the Backup Exec job engine and the remote agent" (a00084f9 HEX or e00084f9 HEX) is reported in the job log while performing a backup of a remote computer
http://support.veritas.com/docs/256120
Title: When backing up or restoring local or remote media servers with Backup Exec for Windows Servers, the job fails with "A communications failure has occurred between the Backup Exec job engine and the remote agent."
http://support.veritas.com/docs/263776
Do update us if the problem persists even after doing these modifications.
In case we do not receive your update within two business days, this post would be marked ‘assumed answered’ and would be moved to ‘answered questions’ pool.
Regards.
Does the problem regarding remote backups still persist? It seems that you already had the settings for the 'use any available network card' enabled. You have mentioned that you have enabled the dynamic port range, what is the port range that you have specified?
You can additionally refer to the technotes given below in order to resolve the problem:
Title: "A communications failure has occurred between the Backup Exec job engine and the remote agent" (a00084f9 HEX or e00084f9 HEX) is reported in the job log while performing a backup of a remote computer
http://support.veritas.com/docs/256120
Title: When backing up or restoring local or remote media servers with Backup Exec for Windows Servers, the job fails with "A communications failure has occurred between the Backup Exec job engine and the remote agent."
http://support.veritas.com/docs/263776
Do update us if the problem persists even after doing these modifications.
In case we do not receive your update within two business days, this post would be marked ‘assumed answered’ and would be moved to ‘answered questions’ pool.
Regards.
Options
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
06-06-2005 02:05 PM
Thank for your reply, I am still experiencing the problem. I will try the other articles and let you know the results.
Thanks
Thanks
Options
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
06-07-2005 08:08 AM
Hello,
Thank you for the update. Awaiting your reply.
NOTE : If we do not receive your reply within two business days, this post would be marked assumed answeredand would be moved toanswered questions pool.
Thank you for the update. Awaiting your reply.
NOTE : If we do not receive your reply within two business days, this post would be marked assumed answeredand would be moved toanswered questions pool.
Options
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
06-08-2005 01:59 AM
Hi
I have been through both tech sheets now the problem still exists.
I used the dynamic port range that was entered as default 1025 - 65535 for both the media server and the remote agent.
My media server is on network 192.168.0.0 and the remote server is on network 192.168.196.0 they are connected via a pix 501 and all traffic is allowed between the two servers. I have confirmed that all other function work correctly i.e. replication browsing and the like.
any further input would be appreciated in solving this issue.
I have been through both tech sheets now the problem still exists.
I used the dynamic port range that was entered as default 1025 - 65535 for both the media server and the remote agent.
My media server is on network 192.168.0.0 and the remote server is on network 192.168.196.0 they are connected via a pix 501 and all traffic is allowed between the two servers. I have confirmed that all other function work correctly i.e. replication browsing and the like.
any further input would be appreciated in solving this issue.
Options
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
06-09-2005 03:51 AM
Hello,
Thanks for your update. It seems you use the default dynamic port range and functions like replication, browsing etc..work well between the two servers. Do try to ping the remote server from the media server and vice versa and check the results.
Ensure that the duplex mode on the Network Interface Card (NIC) is set to Full or half duplex, (this should be selected on both the network switch and the computer's network adapter).
On the media server go to the command prompt and type the command 'telnet name of media server 10000' and hit Enter. Check if you get weird characters. If not, it means that the port 10000 is being used on the remote server for some other application. You can change the default ports used by backup exec. The following technote will help you in t his regard:
How to change the default port used by the Backup Exec 9.x and 10.x Remote Agent for Windows Servers
http://support.veritas.com/docs/255174
Hope this helps. In case the problem persists, do write back to the forum.
If we do not receive your update within two business days, this post would be marked ‘assumed answered’ and would be moved to ‘answered questions’ pool.
Regards.
Thanks for your update. It seems you use the default dynamic port range and functions like replication, browsing etc..work well between the two servers. Do try to ping the remote server from the media server and vice versa and check the results.
Ensure that the duplex mode on the Network Interface Card (NIC) is set to Full or half duplex, (this should be selected on both the network switch and the computer's network adapter).
On the media server go to the command prompt and type the command 'telnet name of media server 10000' and hit Enter. Check if you get weird characters. If not, it means that the port 10000 is being used on the remote server for some other application. You can change the default ports used by backup exec. The following technote will help you in t his regard:
How to change the default port used by the Backup Exec 9.x and 10.x Remote Agent for Windows Servers
http://support.veritas.com/docs/255174
Hope this helps. In case the problem persists, do write back to the forum.
If we do not receive your update within two business days, this post would be marked ‘assumed answered’ and would be moved to ‘answered questions’ pool.
Regards.
Options
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
06-11-2005 03:54 AM
I have checked and all interfaces are running at 100 full duplex.
I tested the telnet connection on both servers and the connection was successful.
I also have ensured that all updates are applied to both the servers.
When perform a test run on the proposed backup it returns as successful, but the actual backup job fails with the same communications error
I tested the telnet connection on both servers and the connection was successful.
I also have ensured that all updates are applied to both the servers.
When perform a test run on the proposed backup it returns as successful, but the actual backup job fails with the same communications error
Options
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
06-28-2005 06:36 AM
Hello John!
Have you tried doing telnet on the port 10 000 with both the servers from both the servers.
i.e telnet servername : 10000
It is also important that ports be open from both the sides of PIX. What does PIX actually do? Is it a firewall?
The reason why the test backup might run because it has less resources to be backed up whereas the actual backup might require more number of ports because the comparatively more resources being backed up.
Following might help you as mentioned in http://seer.support.veritas.com/docs/255831.htm
"When specifying these ports, it is not recommended that they overlap and there should be two ports opened per resource in the backup/restore job. A resource is considered a drive, an information store, a SQL server, and so on. The C drive, D drive, Exchange 2000 Information Store, SQL Server, and System State would be considered five resources. "
Regards,
Ashutosh
NOTE : If we do not receive your reply within two business days, this post would be marked assumed answered and would be moved to answered questions pool.
Have you tried doing telnet on the port 10 000 with both the servers from both the servers.
i.e telnet servername : 10000
It is also important that ports be open from both the sides of PIX. What does PIX actually do? Is it a firewall?
The reason why the test backup might run because it has less resources to be backed up whereas the actual backup might require more number of ports because the comparatively more resources being backed up.
Following might help you as mentioned in http://seer.support.veritas.com/docs/255831.htm
"When specifying these ports, it is not recommended that they overlap and there should be two ports opened per resource in the backup/restore job. A resource is considered a drive, an information store, a SQL server, and so on. The C drive, D drive, Exchange 2000 Information Store, SQL Server, and System State would be considered five resources. "
Regards,
Ashutosh
NOTE : If we do not receive your reply within two business days, this post would be marked assumed answered and would be moved to answered questions pool.
