Since the other threads on this are being ignored, I'm going to re-post this again.
Backup Exec 10d sp2 on a Windows 2003 server, Sp1, all recent updates
Backup source is a Windows 2003 x64 sp1 server running SQL 2000, SP4
The job completes, with errors, and states all of the databases were in use and skipped. Normal files backed up with OFA work fine, only SQL jobs are affected.
The backup exec remote agent is running under local system, the backup exec server service is running under a domain admin account. Changes to that setup have made no difference.
"Database XXX Could not be found" The item "Server\XXX in use - skipped" is the error we get when a x32 veritas10d server tries to back up sql 2000 sp4 on a windows 2003 x64 server. We have numerous other servers that are x64 and backup fine, however anything with sql 2000 will fail with the above error
Seems like a ton of people are having this same problem, how about a fix for this veritas?
SGMon produces the following output:
-------------------------------------------------------
bengine: 08/15/06 15:10:52 JobEngine::LaunchJob
bengine: 08/15/06 15:10:52 RunJobWithGuidAndServer( {BD086A84-78EA-4F50-9D5F-56C403DD6390}, GINGPDA ) = 0
bengine: 08/15/06 15:10:52 Thread for job SQL Data ({BD086A84-78EA-4F50-9D5F-56C403DD6390}) starting
bengine: 08/15/06 15:10:52 Checking for Evaluation expiration.
bengine: 08/15/06 15:10:52 ENGSCRPT: ConvertDeviceName osId = 0X2b
bengine: 08/15/06 15:10:52 ENGSCRPT: IN - oldDeviceName = GINGSQL1
bengine: 08/15/06 15:10:52 ENGSCRPT: OUT - newName = GINGSQL1
bengine: 08/15/06 15:10:52 ENGSCRPT: ConvertDeviceName osId = 0X2b
bengine: 08/15/06 15:10:52 ENGSCRPT: IN - oldDeviceName = GINGSQL1\CTX
bengine: 08/15/06 15:10:52 ENGSCRPT: OUT - newName = GINGSQL1\CTX
bengine: 08/15/06 15:10:52 ENGSCRPT: ConvertDeviceName osId = 0X2b
bengine: 08/15/06 15:10:52 ENGSCRPT: IN - oldDeviceName = GINGSQL1\NAV
bengine: 08/15/06 15:10:52 ENGSCRPT: OUT - newName = GINGSQL1\NAV
bengine: 08/15/06 15:10:52 ENGSCRPT: ConvertDeviceName osId = 0Xe
bengine: 08/15/06 15:10:52 ENGSCRPT: IN - oldDeviceName = \\GINGSQL1\D:
bengine: 08/15/06 15:10:52 ENGSCRPT: OUT - newName = \\GINGSQL1\D:
bengine: 08/15/06 15:10:52 ENGSCRPT: No script found
bengine: 08/15/06 15:10:52 DeviceManager: incoming event fired
bengine: 08/15/06 15:10:52 DeviceManager: processing pending requests
bengine: 08/15/06 15:10:52 DeviceManager: query cache miss
bengine: 08/15/06 15:10:52 Available and held drives from the pool
bengine: 08/15/06 15:10:52 IBM 1 {bbfc33ba-f5d3-4c56-96d8-2d28d7932225}
bengine: 08/15/06 15:10:52 Drives not in use by the Engine
bengine: 08/15/06 15:10:52 IBM 1 {bbfc33ba-f5d3-4c56-96d8-2d28d7932225}
bengine: 08/15/06 15:10:52 Drives available (not in use and not held)
bengine: 08/15/06 15:10:52 IBM 1 {bbfc33ba-f5d3-4c56-96d8-2d28d7932225}
bengine: 08/15/06 15:10:52 Handing out session {1f74606f-599d-4c85-978e-420a1532d40c} based on available drive:
bengine: 08/15/06 15:10:52 IBM 1 {bbfc33ba-f5d3-4c56-96d8-2d28d7932225}
bengine: 08/15/06 15:10:52 DeviceManager: going to sleep for 900000 msecs
bengine: 08/15/06 15:10:52 BackupJob: acquired device IBM 1
bengine: 08/15/06 15:10:52 BackupJob: trying to mount appending volume
bengine: 08/15/06 15:11:29 Updating session {1f74606f-599d-4c85-978e-420a1532d40c} with drive IBM 1 {bbfc33ba-f5d3-4c56-96d8-2d28d7932225}
bengine: 08/15/06 15:11:29 Block size: 65536
bengine: 08/15/06 15:11:29 Buffer size: 65536
bengine: 08/15/06 15:11:30 Num buffers: 10
bengine: 08/15/06 15:11:30 High water: 0
bengine: 08/15/06 15:11:30 BackupJob: medium successfully mounted
bengine: 08/15/06 15:11:30 Media Label: 000003
bengine: 08/15/06 15:11:30 Media Label: {1287dc83-d867-48e8-b917-3f14c91ebbbb}
bengine: 08/15/06 15:11:30 Overwrite Protected Until: 8/22/2006 3:05:08 PM
bengine: 08/15/06 15:11:30 Appendable Until: 12/30/9999 7:00:00 PM
bengine: 08/15/06 15:11:30 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 08/15/06 15:11:30 TAPEALERT: TapeAlert Device Flag = 0X0
bengine: 08/15/06 15:11:30 TAPEALERT: TapeAlert Changer Flag = 0X0
bengine: 08/15/06 15:11:30 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 08/15/06 15:11:30 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 08/15/06 15:11:30 Failed to Load Software\VERITAS\Backup Exec\Engine\IDR key, We will update DR file evenif there are userExcludes. Error: 2
bengine: 08/15/06 15:11:30 Failed to Load Software\VERITAS\Backup Exec\Engine\IDR key, We will update DR file evenif there are userExcludes. Error: 2
bengine: 08/15/06 15:11:30 ndmpConnect : Control Connection information : connection established between IP 172.19.5.14, port 1280 and IP 172.19.5.11, port 10000
bengine: 08/15/06 15:11:30 NDMP version 3 connection CONNECTED
bengine: 08/15/06 15:11:30 Single logical volume snapshot is enabled for this job.
bengine: 08/15/06 15:11:30 BESC: Parsing OS version info -
bengine: 08/15/06 15:11:30 ndmpcSnapshotPrepare2: Warning. No devices to snap. Returning with NDMP_SNAPSHOT_NO_DEVICES2SNAP
bengine: 08/15/06 15:11:30 TF_OpenTape()
bengine: 08/15/06 15:11:30 TF_GetDriveContext ...
sessionGuid = {1f74606f-599d-4c85-978e-420a1532d40c}
initAsync = 1
bengine: 08/15/06 15:11:30 HARDWARE COMPRESSION ===> Compression is configurable.
bengine: 08/15/06 15:11:30 GET_DRV_INF: bsize = 65536
bengine: 08/15/06 15:11:30 HARDWARE COMPRESSION ===> Setting compression off.
bengine: 08/15/06 15:11:30 TF_GetDriveContext returning 0, context = 1C25FD0
bengine: 08/15/06 15:11:30 Allocated 2 buffers, size 65536 bytes, total used: 131256
bengine: 08/15/06 15:11:30 HARDWARE COMPRESSION ===> Compression is configurable.
bengine: 08/15/06 15:11:30 GET_DRV_INF: bsize = 65536
bengine: 08/15/06 15:11:30 Media Server to initiate connection for data transfer
bengine: 08/15/06 15:11:30 TF_OpenSet( )
bengine: 08/15/06 15:11:30 FreeFormatEnv( cur_fmt=65535 )
bengine: 08/15/06 15:11:30 RewindDrive mover ret = 0 (0x0)
bengine: 08/15/06 15:11:30 ret_val = 0
bengine: 08/15/06 15:11:30 Requested Set: ID = ffffffff Seq = -1 Set = -1
bengine: 08/15/06 15:11:30 Attempting to VCB storage media
bengine: 08/15/06 15:11:30 TpRead( :(
bengine: 08/15/06 15:11:30 Error = 0 Req = 65536 Got = 65536
bengine: 08/15/06 15:11:30 HARDWARE COMPRESSION ===> Compression is configurable.
bengine: 08/15/06 15:11:30 GET_DRV_INF: bsize = 65536
bengine: 08/15/06 15:11:30 FreeFormatEnv( cur_fmt=65535 )
bengine: 08/15/06 15:11:30 SetupFormatEnv( fmt=0 )
bengine: 08/15/06 15:11:30 TpRead( :(
bengine: 08/15/06 15:11:30 Error = 0 Req = 65536 Got = 65536
bengine: 08/15/06 15:11:30 ReadThisSet( cur_fmt=0 )
bengine: 08/15/06 15:11:30 ReadThisSet() return=0
bengine: 08/15/06 15:11:30 Current VCB: ID = 34e75ae7 Seq = 2 Set = 659
bengine: 08/15/06 15:11:30 PositionAtSet( :( TF Msg = b
bengine: 08/15/06 15:11:30 UI Msg = 800f
bengine: 08/15/06 15:11:30 HARDWARE COMPRESSION ===> Compression is configurable.
bengine: 08/15/06 15:11:30 GET_DRV_INF: bsize = 65536
bengine: 08/15/06 15:11:30 F40_SeekEOD starting seek...
bengine: 08/15/06 15:12:46 F40_SeekEOD calling OTC_GetPrevSM with expect_sm = 1 ...
bengine: 08/15/06 15:12:46 OTC_GetPrevSM spacing back two filemarks...
bengine: 08/15/06 15:12:46 OTC_GetPrevSM: ESET position = 2665556
bengine: 08/15/06 15:12:46 OTC_GetPrevSM calling OTC_SMtoFile...
bengine: 08/15/06 15:12:46 SetupFormatEnv( fmt=0 )
bengine: 08/15/06 15:12:46 End of TF_OpenSet: Ret_val = 0 Buffs = 2 HiWater = 0
bengine: 08/15/06 15:12:46 HARDWARE COMPRESSION ===> Setting compression on.
bengine: 08/15/06 15:12:46 Current Block is = 28ac5f
bengine: 08/15/06 15:12:46 TF_InitMediaServerReverseConnection : Data Connection information : connection established between IP 172.19.5.14, port 1284 and IP 172.19.5.11, port 1297
bengine: 08/15/06 15:12:46
dataStartBackup: ndmpSendRequest returned: 0x0, 0
bengine: 08/15/06 15:12:47 data halted: SUCCESSFUL
bengine: 08/15/06 15:12:47 NDMPEngine: Shutting down.
bengine: 08/15/06 15:12:47 NDMPEngine: Shutting down.
bengine: 08/15/06 15:12:47 TF_NDMPGetResult(): MediaServer thread done, returning TFLE 0
bengine: 08/15/06 15:12:51 WriteEndSet( 1 ) returning 0
bengine: 08/15/06 15:12:53 WriteEndSet( 1 ) returning 0
bengine: 08/15/06 15:12:53 WriteEndSet( 0 ) returning 0
bengine: 08/15/06 15:12:53 HARDWARE COMPRESSION ===> Setting compression off.
bengine: 08/15/06 15:12:53 TF_CloseSet
bengine: 08/15/06 15:12:53 BESC: Parsing OS version info -
bengine: 08/15/06 15:12:53 ndmpcSnapshotPrepare2: Warning. No devices to snap. Returning with NDMP_SNAPSHOT_NO_DEVICES2SNAP
bengine: 08/15/06 15:12:53 Media Server to initiate connection for data transfer
bengine: 08/15/06 15:12:53 TF_OpenSet( )
bengine: 08/15/06 15:12:53 Requested Set: ID = ffffffff Seq = -1 Set = -1
bengine: 08/15/06 15:12:53 Current VCB: ID = 34e75ae7 Seq = 2 Set = 773
bengine: 08/15/06 15:12:53 PositionAtSet( :( TF Msg = 6
bengine: 08/15/06 15:12:53 UI Msg = 8002
bengine: 08/15/06 15:12:53 HARDWARE COMPRESSION ===> Compression is configurable.
bengine: 08/15/06 15:12:53 GET_DRV_INF: bsize = 65536
bengine: 08/15/06 15:12:53 SetupFormatEnv( fmt=0 )
bengine: 08/15/06 15:12:53 End of TF_OpenSet: Ret_val = 0 Buffs = 2 HiWater = 0
bengine: 08/15/06 15:12:53 HARDWARE COMPRESSION ===> Setting compression on.
bengine: 08/15/06 15:12:53 Current Block is = 28ac6c
bengine: 08/15/06 15:12:53 TF_InitMediaServerReverseConnection : Data Connection information : connection established between IP 172.19.5.14, port 1288 and IP 172.19.5.11, port 1301
bengine: 08/15/06 15:12:53
dataStartBackup: ndmpSendRequest returned: 0x0, 0
bengine: 08/15/06 15:12:54 data halted: SUCCESSFUL
bengine: 08/15/06 15:12:54 NDMPEngine: Shutting down.
bengine: 08/15/06 15:12:54 TF_NDMPGetResult(): MediaServer thread done, returning TFLE 0
bengine: 08/15/06 15:12:55 WriteEndSet( 1 ) returning 0
bengine: 08/15/06 15:12:57 WriteEndSet( 1 ) returning 0
bengine: 08/15/06 15:12:57 WriteEndSet( 0 ) returning 0
bengine: 08/15/06 15:12:57 HARDWARE COMPRESSION ===> Setting compression off.
bengine: 08/15/06 15:12:57 TF_CloseSet
bengine: 08/15/06 15:12:57 BESC: Parsing OS version info -
bengine: 08/15/06 15:12:57 ndmpcSnapshotPrepare2: Warning. No devices to snap. Returning with NDMP_SNAPSHOT_NO_DEVICES2SNAP
bengine: 08/15/06 15:12:57 Media Server to initiate connection for data transfer
bengine: 08/15/06 15:12:57 TF_OpenSet( )
bengine: 08/15/06 15:12:57 Requested Set: ID = ffffffff Seq = -1 Set = -1
bengine: 08/15/06 15:12:57 Current VCB: ID = 34e75ae7 Seq = 2 Set = 774
bengine: 08/15/06 15:12:57 PositionAtSet( :( TF Msg = 6
bengine: 08/15/06 15:12:57 UI Msg = 8002
bengine: 08/15/06 15:12:57 HARDWARE COMPRESSION ===> Compression is configurable.
bengine: 08/15/06 15:12:57 GET_DRV_INF: bsize = 65536
bengine: 08/15/06 15:12:57 SetupFormatEnv( fmt=0 )
bengine: 08/15/06 15:12:57 End of TF_OpenSet: Ret_val = 0 Buffs = 2 HiWater = 0
bengine: 08/15/06 15:12:57 HARDWARE COMPRESSION ===> Setting compression on.
bengine: 08/15/06 15:12:57 Current Block is = 28ac79
bengine: 08/15/06 15:12:57 TF_InitMediaServerReverseConnection : Data Connection information : connection established between IP 172.19.5.14, port 1289 and IP 172.19.5.11, port 1308
bengine: 08/15/06 15:12:57
dataStartBackup: ndmpSendRequest returned: 0x0, 0
bengine: 08/15/06 15:12:58 TF_NDMPGetResult(): MediaServer thread done, returning TFLE 0
bengine: 08/15/06 15:12:58 NDMPEngine::MessagePumpAndWaitForResults(): TF_NDMPGetResult() returned 0
bengine: 08/15/06 15:12:58 data halted: SUCCESSFUL
bengine: 08/15/06 15:12:58 NDMPEngine: Shutting down.
bengine: 08/15/06 15:12:59 WriteEndSet( 1 ) returning 0
bengine: 08/15/06 15:13:01 WriteEndSet( 1 ) returning 0
bengine: 08/15/06 15:13:01 WriteEndSet( 0 ) returning 0
bengine: 08/15/06 15:13:01 HARDWARE COMPRESSION ===> Setting compression off.
bengine: 08/15/06 15:13:01 TF_CloseSet
bengine: 08/15/06 15:13:01 BESC: Parsing OS version info -
bengine: 08/15/06 15:13:01 ndmpcSnapshotPrepare2: Warning. No devices to snap. Returning with NDMP_SNAPSHOT_NO_DEVICES2SNAP
bengine: 08/15/06 15:13:01 Media Server to initiate connection for data transfer
bengine: 08/15/06 15:13:01 TF_OpenSet( )
bengine: 08/15/06 15:13:01 Requested Set: ID = ffffffff Seq = -1 Set = -1
bengine: 08/15/06 15:13:01 Current VCB: ID = 34e75ae7 Seq = 2 Set = 775
bengine: 08/15/06 15:13:01 PositionAtSet( :( TF Msg = 6
bengine: 08/15/06 15:13:01 UI Msg = 8002
bengine: 08/15/06 15:13:01 HARDWARE COMPRESSION ===> Compression is configurable.
bengine: 08/15/06 15:13:01 GET_DRV_INF: bsize = 65536
bengine: 08/15/06 15:13:01 SetupFormatEnv( fmt=0 )
bengine: 08/15/06 15:13:01 End of TF_OpenSet: Ret_val = 0 Buffs = 2 HiWater = 0
bengine: 08/15/06 15:13:01 HARDWARE COMPRESSION ===> Setting compression on.
bengine: 08/15/06 15:13:01 Current Block is = 28ac86
bengine: 08/15/06 15:13:01 TF_InitMediaServerReverseConnection : Data Connection information : connection established between IP 172.19.5.14, port 1290 and IP 172.19.5.11, port 1315
bengine: 08/15/06 15:13:01
dataStartBackup: ndmpSendRequest returned: 0x0, 0
bengine: 08/15/06 15:13:04 TF_NDMPGetResult(): MediaServer thread done, returning TFLE 0
bengine: 08/15/06 15:13:04 NDMPEngine::MessagePumpAndWaitForResults(): TF_NDMPGetResult() returned 0
bengine: 08/15/06 15:13:04 data halted: SUCCESSFUL
bengine: 08/15/06 15:13:04 NDMPEngine: Shutting down.
bengine: 08/15/06 15:13:05 WriteEndSet( 1 ) returning 0
bengine: 08/15/06 15:13:07 WriteEndSet( 1 ) returning 0
bengine: 08/15/06 15:13:07 WriteEndSet( 0 ) returning 0
bengine: 08/15/06 15:13:07 HARDWARE COMPRESSION ===> Setting compression off.
bengine: 08/15/06 15:13:08 TF_CloseSet
bengine: 08/15/06 15:14:18 RewindDrive mover ret = 0 (0x0)
bengine: 08/15/06 15:14:18 ret_val = 0
bengine: 08/15/06 15:14:18 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 08/15/06 15:14:18 TAPEALERT: TapeAlert Device Flag = 0X0
bengine: 08/15/06 15:14:18 TAPEALERT: TapeAlert Changer Flag = 0X0
bengine: 08/15/06 15:14:18 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 08/15/06 15:14:18 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 08/15/06 15:14:19 Updating session {1f74606f-599d-4c85-978e-420a1532d40c} with drive IBM 1 {bbfc33ba-f5d3-4c56-96d8-2d28d7932225}
bengine: 08/15/06 15:14:19 TF_OpenTape()
bengine: 08/15/06 15:14:19 Allocated 10 buffers, size 65536 bytes, total used: 656280
bengine: 08/15/06 15:14:19 HARDWARE COMPRESSION ===> Compression is configurable.
bengine: 08/15/06 15:14:19 GET_DRV_INF: bsize = 65536
bengine: 08/15/06 15:14:19 TF_OpenSet( )
bengine: 08/15/06 15:14:19 Requested Set: ID = 34e75ae7 Seq = 2 Set = 773
bengine: 08/15/06 15:14:19 Attempting to VCB storage media
bengine: 08/15/06 15:14:19 TpRead( :(
bengine: 08/15/06 15:14:19 Error = 0 Req = 65536 Got = 65536
bengine: 08/15/06 15:14:19 HARDWARE COMPRESSION ===> Compression is configurable.
bengine: 08/15/06 15:14:19 GET_DRV_INF: bsize = 65536
bengine: 08/15/06 15:14:19 TpRead( :(
bengine: 08/15/06 15:14:19 Error = 0 Req = 65536 Got = 65536
bengine: 08/15/06 15:14:19 ReadThisSet( cur_fmt=0 )
bengine: 08/15/06 15:14:19 ReadThisSet() return=0
bengine: 08/15/06 15:14:19 Current VCB: ID = 34e75ae7 Seq = 2 Set = 659
bengine: 08/15/06 15:14:19 End of TF_OpenSet: Ret_val = 0 Buffs = 10 HiWater = 0
bengine: 08/15/06 15:14:19 GotoBlock: VCB_PBA = 2665567, VCB_LBA = 0, LBA = 0,
bengine: 08/15/06 15:14:19 PBA = 2665567, offset = 0
bengine: 08/15/06 15:15:31 Device Error = 1101
bengine: 08/15/06 15:15:31 Len Req = 65536 Len Got = 0
bengine: 08/15/06 15:15:31 TF xfer time = 72 seconds.
bengine: 08/15/06 15:15:31 TF_CloseSet
bengine: 08/15/06 15:15:31 TF_OpenSet( )
bengine: 08/15/06 15:15:31 Requested Set: ID = 34e75ae7 Seq = 2 Set = 774
bengine: 08/15/06 15:15:31 Current VCB: ID = 34e75ae7 Seq = 2 Set = 773
bengine: 08/15/06 15:15:31 End of TF_OpenSet: Ret_val = 0 Buffs = 10 HiWater = 0
bengine: 08/15/06 15:15:31 GotoBlock: VCB_PBA = 2665580, VCB_LBA = 0, LBA = 0,
bengine: 08/15/06 15:15:31 PBA = 2665580, offset = 0
bengine: 08/15/06 15:15:31 Device Error = 1101
bengine: 08/15/06 15:15:31 Len Req = 65536 Len Got = 0
bengine: 08/15/06 15:15:31 TF xfer time = 0 seconds.
bengine: 08/15/06 15:15:31 TF_CloseSet
bengine: 08/15/06 15:15:31 TF_OpenSet( )
bengine: 08/15/06 15:15:31 Requested Set: ID = 34e75ae7 Seq = 2 Set = 775
bengine: 08/15/06 15:15:31 Current VCB: ID = 34e75ae7 Seq = 2 Set = 774
bengine: 08/15/06 15:15:31 End of TF_OpenSet: Ret_val = 0 Buffs = 10 HiWater = 0
bengine: 08/15/06 15:15:31 GotoBlock: VCB_PBA = 2665593, VCB_LBA = 0, LBA = 0,
bengine: 08/15/06 15:15:31 PBA = 2665593, offset = 0
bengine: 08/15/06 15:15:33 Device Error = 1101
bengine: 08/15/06 15:15:33 Len Req = 65536 Len Got = 0
bengine: 08/15/06 15:15:33 TF xfer time = 1 seconds.
bengine: 08/15/06 15:15:33 TF_CloseSet
bengine: 08/15/06 15:15:33 TF_OpenSet( )
bengine: 08/15/06 15:15:33 Requested Set: ID = 34e75ae7 Seq = 2 Set = 776
bengine: 08/15/06 15:15:33 Current VCB: ID = 34e75ae7 Seq = 2 Set = 775
bengine: 08/15/06 15:15:33 End of TF_OpenSet: Ret_val = 0 Buffs = 10 HiWater = 0
bengine: 08/15/06 15:15:33 GotoBlock: VCB_PBA = 2665606, VCB_LBA = 0, LBA = 0,
bengine: 08/15/06 15:15:33 PBA = 2665606, offset = 0
bengine: 08/15/06 15:15:33 Device Error = 1101
bengine: 08/15/06 15:15:33 Len Req = 65536 Len Got = 0
bengine: 08/15/06 15:15:33 TF xfer time = 0 seconds.
bengine: 08/15/06 15:15:33 TF_CloseSet
bengine: 08/15/06 15:16:42 RewindDrive mover ret = 0 (0x0)
bengine: 08/15/06 15:16:42 ret_val = 0
bengine: 08/15/06 15:16:42 DeviceManager: incoming event fired
bengine: 08/15/06 15:16:42 Updating session {1f74606f-599d-4c85-978e-420a1532d40c} with drive IBM 1 {bbfc33ba-f5d3-4c56-96d8-2d28d7932225}
bengine: 08/15/06 15:16:42 DeviceManager: processing pending requests
bengine: 08/15/06 15:16:42 DeviceManager: going to sleep for 61000 msecs
bengine: 08/15/06 15:16:42 BackupJob::MergeBEVSRJobLogsIfNecessary: No VSR log file found, no merging necessary
bengine: 08/15/06 15:16:42 Job thread terminating