beserver: 06/29/05 12:11:40 17 JobManager::UpdateJobInstanceData() new task state=22
beserver: 06/29/05 12:11:42 12 AdammAdminBO::Query() - Parent = NULL , Entity = MACHINE
pvlsvr: 06/29/05 12:11:42 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = MACHINE_ENTITY_TYPE
EntityGuid = {4E6CD505-B7E0-4BAA-8432-3899B6637562}
EntityName = ""
EntityFlags = 0x00008000
beserver: 06/29/05 12:11:42 12 AdammAdminBO::Query() - hr = 0x0
beserver: 06/29/05 12:11:42 12 AdammAdminBO::Query() - Parent = NULL , Entity = DEVICE_POOL
pvlsvr: 06/29/05 12:11:42 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = DEVICE_POOL_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00008000
beserver: 06/29/05 12:11:42 12 AdammAdminBO::Query() - hr = 0x0
beserver: 06/29/05 12:11:42 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = DRIVE
pvlsvr: 06/29/05 12:11:42 PvlEntityDatabase::QueryEntity()
ParentEntityType = MACHINE_ENTITY_TYPE
ParentEntityGuid = {4E6CD505-B7E0-4BAA-8432-3899B6637562}
EntityType = DRIVE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00008000
beserver: 06/29/05 12:11:42 12 AdammAdminBO::Query() - hr = 0x0
beserver: 06/29/05 12:11:42 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = BACKUP_TO_DISK
pvlsvr: 06/29/05 12:11:42 PvlEntityDatabase::QueryEntity()
ParentEntityType = MACHINE_ENTITY_TYPE
ParentEntityGuid = {4E6CD505-B7E0-4BAA-8432-3899B6637562}
EntityType = BACKUP_TO_DISK_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00008000
beserver: 06/29/05 12:11:42 12 AdammAdminBO::Query() - hr = 0x0
beserver: 06/29/05 12:11:42 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = DRIVE_POOL_DRIVE
pvlsvr: 06/29/05 12:11:42 PvlEntityDatabase::QueryEntity()
ParentEntityType = MACHINE_ENTITY_TYPE
ParentEntityGuid = {4E6CD505-B7E0-4BAA-8432-3899B6637562}
EntityType = DRIVE_POOL_DRIVE_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00008000
beserver: 06/29/05 12:11:42 12 AdammAdminBO::Query() - hr = 0x0
beserver: 06/29/05 12:11:42 12 AdammAdminBO::Query() - Parent = MACHINE , Entity = CHANGER
pvlsvr: 06/29/05 12:11:42 PvlEntityDatabase::QueryEntity()
ParentEntityType = MACHINE_ENTITY_TYPE
ParentEntityGuid = {4E6CD505-B7E0-4BAA-8432-3899B6637562}
EntityType = LIBRARY_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00008000
beserver: 06/29/05 12:11:42 12 AdammAdminBO::Query() - hr = 0x0
beserver: 06/29/05 12:11:42 -1 ActiveState::doDispatch( :( 'TEST'
beserver: 06/29/05 12:11:42 17 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
beserver: 06/29/05 12:11:42 -1 LocalSvr, runTask():{53beedf7-4b3b-4696-bdda-240104f121ec}
beserver: 06/29/05 12:11:42 -1 BengineWrapper runtask() start
beserver: 06/29/05 12:11:42 -1 BengineWrapper JobEngine.Open() OK
beserver: 06/29/05 12:11:42 -1 Client requested key.
beserver: 06/29/05 12:11:42 -1 Client 'BACKUP1' connected('','DOMAIN\UserName'): 0xecd44f0
beserver: 06/29/05 12:11:42 18 Alert Job Start, Notify: Yes, EventLog: No, Trap: No
beserver: 06/29/05 12:11:43 18 Doing Notify
bengine: 06/29/05 12:11:43 JobEngine::LaunchJob
bengine: 06/29/05 12:11:43 RunJobWithGuidAndServer( {53BEEDF7-4B3B-4696-BDDA-240104F121EC}, BACKUP1 ) = 0
bengine: 06/29/05 12:11:43 Thread for job TEST ({53BEEDF7-4B3B-4696-BDDA-240104F121EC}) starting
beserver: 06/29/05 12:11:43 -1 BengineWrapper JobEngine.RunJobWithGuidAndServer() rc=0
beserver: 06/29/05 12:11:43 -1 JobManager: BengineWrapper RunJob() done
beserver: 06/29/05 12:11:43 11 LocalSvr, RunTask: EngineHandedJob SUCCESS, jobid:{53beedf7-4b3b-4696-bdda-240104f121ec}.
beserver: 06/29/05 12:11:43 -1 Client requested key.
beserver: 06/29/05 12:11:43 -1 Client 'BACKUP1' connected('','DOMAIN\UserName'): 0x7782be8
beserver: 06/29/05 12:11:43 -1 Client 'BACKUP1' Disconnected:0x7782be8
bengine: 06/29/05 12:11:43 Checking for Evaluation expiration.
bengine: 06/29/05 12:11:43 ENGSCRPT: ConvertDeviceName osId = 0Xe
bengine: 06/29/05 12:11:43 ENGSCRPT: IN - oldDeviceName = \\SERVER\D:
bengine: 06/29/05 12:11:43 ENGSCRPT: OUT - newName = \\SERVER\D:
beserver: 06/29/05 12:11:43 18 Notify Return Code:0, batch:121, index:0
bengine: 06/29/05 12:11:43 ENGSCRPT: No script found
bengine: 06/29/05 12:11:43 DeviceManager: incoming event fired
bengine: 06/29/05 12:11:43 DeviceManager: processing pending requests
bengine: 06/29/05 12:11:43 DeviceManager: query cache miss
pvlsvr: 06/29/05 12:11:43 PvlEntityDatabase::QueryEntity()
ParentEntityType = DRIVE_POOL_ENTITY_TYPE
ParentEntityGuid = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}
EntityType = NULL_ENTITY_TYPE
EntityGuid = {00000000-0000-0000-0000-000000000000}
EntityName = ""
EntityFlags = 0x00000000
pvlsvr: 06/29/05 12:11:43 PvlEntityDatabase::QueryEntity()
ParentEntityType = MACHINE_ENTITY_TYPE
ParentEntityGuid = {4E6CD505-B7E0-4BAA-8432-3899B6637562}
EntityType = BACKUP_TO_DISK_ENTITY_TYPE
EntityGuid = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}
EntityName = ""
EntityFlags = 0x00000000
bengine: 06/29/05 12:11:43 Available and held drives from the pool
bengine: 06/29/05 12:11:43 DATA1 {1cd33ffe-d875-4f68-b6d5-a92334ec0d65}.0
bengine: 06/29/05 12:11:43 Drives not in use by the Engine
bengine: 06/29/05 12:11:43 DATA1 {1cd33ffe-d875-4f68-b6d5-a92334ec0d65}.0
bengine: 06/29/05 12:11:43 Drives available (not in use and not held)
bengine: 06/29/05 12:11:43 DATA1 {1cd33ffe-d875-4f68-b6d5-a92334ec0d65}.0
pvlsvr: 06/29/05 12:11:43 AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_DEVICE_GUID )
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
TargetDevice = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1" (Backup To Disk)
bengine: 06/29/05 12:11:43 Handing out session {b7fe9f08-af6e-4dd7-93a3-c1110b90db37} based on available drive:
bengine: 06/29/05 12:11:43 DATA1 {1cd33ffe-d875-4f68-b6d5-a92334ec0d65}.0
bengine: 06/29/05 12:11:43 DeviceManager: going to sleep for 900000 msecs
pvlsvr: 06/29/05 12:11:43 AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_JOB_INFO )
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
Job = {53BEEDF7-4B3B-4696-BDDA-240104F121EC}, "TEST"
bengine: 06/29/05 12:11:43 BackupJob: acquired device DATA1
bengine: 06/29/05 12:11:43 BackupJob: trying to mount scratch volume
pvlsvr: 06/29/05 12:11:43 AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_MOUNT_OVERWRITE )
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
pvlsvr: 06/29/05 12:11:43 AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_INFO )
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
pvlsvr: 06/29/05 12:11:43 AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_DEVICE_GUID )
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
TargetDevice = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1" (Backup To Disk)
pvlsvr: 06/29/05 12:11:43 AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_TARGET_MEDIA_GUID )
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
TargetMedia = {8D3AB741-14D7-4FF3-B779-6A77DC663866}, "Test Media Set" (Media Set)
pvlsvr: 06/29/05 12:11:43 AdammSession::Execute( ADAMM_SESSION_EXECUTE_SESSION_SET_EXCLUDE_MEDIA_GUIDS )
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
beserver: 06/29/05 12:11:43 18 Notify Return Code:0, batch:121, index:1
pvlsvr: 06/29/05 12:11:43 AdammSession::CheckTargetDeviceStatus()
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
Job = {53BEEDF7-4B3B-4696-BDDA-240104F121EC}, "TEST"
TargetDevice = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1"
State = 0003, ReservationID = 0000, AvailableMovers = 0001
pvlsvr: 06/29/05 12:11:43 AdammSession::MountOverwriteMedia()
pvlsvr: 06/29/05 12:11:43 AdammSession::MountMedia()
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
Drive = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}
Slot = 0005
Side = 0000
pvlsvr: 06/29/05 12:11:43 PvlDrive::MountMedia()
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
Drive = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1"
Slot = 0005
Side = 0001
pvlsvr: 06/29/05 12:11:43 PvlChanger::MountMedia()
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
Library = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1"
Drive = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1"
Slot = 0005
Side = 0001
pvlsvr: 06/29/05 12:11:44 AdammSession::MountMedia()
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
Library = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1"
Slot = 0000
Drive = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1"
Media = {25280342-C39D-443A-90DE-AA76D2039EA2}, "B2D000009"
Side = 0001
SUCCESS!
pvlsvr: 06/29/05 12:11:44 AdammSession::IsOverwriteMediaMounted() - SUCCESS!
bengine: 06/29/05 12:11:44 Updating session {b7fe9f08-af6e-4dd7-93a3-c1110b90db37} with drive DATA1 {1cd33ffe-d875-4f68-b6d5-a92334ec0d65}.1
bengine: 06/29/05 12:11:44 Block size: 1024
bengine: 06/29/05 12:11:44 Buffer size: 32768
bengine: 06/29/05 12:11:44 Num buffers: 10
bengine: 06/29/05 12:11:44 High water: 7
bengine: 06/29/05 12:11:44 BackupJob: medium successfully mounted
bengine: 06/29/05 12:11:44 Media Label: B2D000009
bengine: 06/29/05 12:11:44 Media Label: {25280342-c39d-443a-90de-aa76d2039ea2}
bengine: 06/29/05 12:11:44 Overwrite Protected Until: 12/31/1899 6:00:00 PM
bengine: 06/29/05 12:11:44 Appendable Until: 12/31/1899 6:00:00 PM
bengine: 06/29/05 12:11:44 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 06/29/05 12:11:44 TAPEALERT: TapeAlert Device Flag = 0X0
bengine: 06/29/05 12:11:44 TAPEALERT: TapeAlert Changer Flag = 0X0
bengine: 06/29/05 12:11:44 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 06/29/05 12:11:44 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 06/29/05 12:11:44 Failed to Load Software\VERITAS\Backup Exec\Engine\IDR key, We will update DR file evenif there are userExcludes. Error: 2
bengine: 06/29/05 12:11:44 Failed to Load Software\VERITAS\Backup Exec\Engine\IDR key, We will update DR file evenif there are userExcludes. Error: 2
beserver: 06/29/05 12:11:44 -1 SQLLog(13403):AgeSession m_threadMap: SessionThreadID:e68, CurrentThreadID:f5c
bengine: 06/29/05 12:11:45 Informational: Subnet Address 192.1.1.0 specified
bengine: 06/29/05 12:11:45 Informational: Subnet Mask 255.255.252.0 input
bengine: 06/29/05 12:11:45 Informational: Local network address 192.1.1.231 returned
bengine: 06/29/05 12:11:45 Informational: Local network address 192.1.1.231 obtained in the subnet specified
bengine: 06/29/05 12:11:45 ndmpConnect : Control Connection information : connection established between IP 192.1.1.231, port 2764 and IP 192.1.1.220, port 10000
bengine: 06/29/05 12:11:45 NDMP version 3 connection CONNECTED
bengine: 06/29/05 12:11:45 BESC: Parsing OS version info -
bengine: 06/29/05 12:11:45 ndmpcSnapshotPrepare2: Warning. No devices to snap. Returning with NDMP_SNAPSHOT_NO_DEVICES2SNAP
bengine: 06/29/05 12:11:45 TF_OpenTape()
bengine: 06/29/05 12:11:45 TF_GetDriveContext ...
sessionGuid = {b7fe9f08-af6e-4dd7-93a3-c1110b90db37}
initAsync = 1
bengine: 06/29/05 12:11:45 HARDWARE COMPRESSION ===> Compression is NOT configurable.
bengine: 06/29/05 12:11:45 GET_DRV_INF: bsize = 1024
bengine: 06/29/05 12:11:45 TF_GetDriveContext returning 0, context = 1C9D850
bengine: 06/29/05 12:11:45 Allocated 2 buffers, size 32768 bytes, total used: 65720
bengine: 06/29/05 12:11:45 HARDWARE COMPRESSION ===> Compression is NOT configurable.
bengine: 06/29/05 12:11:45 GET_DRV_INF: bsize = 1024
bengine: 06/29/05 12:11:45 Media Server to initiate connection for data transfer
bengine: 06/29/05 12:11:45 TF_OpenSet( )
bengine: 06/29/05 12:11:45 FreeFormatEnv( cur_fmt=65535 )
bengine: 06/29/05 12:11:45 RewindDrive mover ret = 0 (0x0)
bengine: 06/29/05 12:11:45 ret_val = 0
bengine: 06/29/05 12:11:45 Requested Set: ID = ffffffff Seq = -1 Set = -1
bengine: 06/29/05 12:11:45 Attempting to VCB storage media
bengine: 06/29/05 12:11:45 TpRead( :(
bengine: 06/29/05 12:11:45 Error = 1101 Req = 6144 Got = 1024
bengine: 06/29/05 12:11:45 HARDWARE COMPRESSION ===> Compression is NOT configurable.
bengine: 06/29/05 12:11:45 GET_DRV_INF: bsize = 1024
bengine: 06/29/05 12:11:45 FreeFormatEnv( cur_fmt=65535 )
bengine: 06/29/05 12:11:45 SetupFormatEnv( fmt=0 )
bengine: 06/29/05 12:11:45 TpRead( :(
bengine: 06/29/05 12:11:45 Error = 0 Req = 6144 Got = 6144
bengine: 06/29/05 12:11:45 ReadThisSet( cur_fmt=0 )
bengine: 06/29/05 12:11:45 ReadThisSet() return=0
bengine: 06/29/05 12:11:45 Current VCB: ID = 32cd7dc8 Seq = 1 Set = 1
bengine: 06/29/05 12:11:45 PositionAtSet( :( TF Msg = b
bengine: 06/29/05 12:11:45 UI Msg = 8003
bengine: 06/29/05 12:11:45 HARDWARE COMPRESSION ===> Compression is NOT configurable.
bengine: 06/29/05 12:11:45 GET_DRV_INF: bsize = 1024
bengine: 06/29/05 12:11:45 RewindDrive mover ret = 0 (0x0)
bengine: 06/29/05 12:11:45 ret_val = 0
bengine: 06/29/05 12:11:45 SetupFormatEnv( fmt=0 )
bengine: 06/29/05 12:11:45 End of TF_OpenSet: Ret_val = 0 Buffs = 2 HiWater = 7
bengine: 06/29/05 12:11:45 B2D Buffered Writes ===> Setting buffering to default.
bengine: 06/29/05 12:11:45 WriteEndSet( 1 ) returning 0
bengine: 06/29/05 12:11:45 Current Block is = 3
bengine: 06/29/05 12:11:46 Informational: Subnet Address 192.1.1.0 specified
bengine: 06/29/05 12:11:46 Informational: Subnet Mask 255.255.252.0 input
bengine: 06/29/05 12:11:46 Informational: Local network address 192.1.1.231 returned
bengine: 06/29/05 12:11:46 Informational: Local network address 192.1.1.231 obtained in the subnet specified
bengine: 06/29/05 12:11:46 TF_InitMediaServerReverseConnection : Data Connection information : connection established between IP 192.1.1.231, port 2768 and IP 192.1.1.220, port 2290
bengine: 06/29/05 12:11:46
dataStartBackup: ndmpSendRequest returned: 0x0, 0
beserver: 06/29/05 12:11:47 17 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR
beserver: 06/29/05 12:11:48 12 AdammAdminBO::Get() - Parent = NULL , Entity = MEDIA
pvlsvr: 06/29/05 12:11:48 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = MEDIA_ENTITY_TYPE
EntityGuid = {25280342-C39D-443A-90DE-AA76D2039EA2}
EntityName = ""
EntityFlags = 0x00000000
pvlsvr: 06/29/05 12:11:48 PvlEntityDatabase::QueryEntity() : SUCCESS!
beserver: 06/29/05 12:11:48 12 AdammAdminBO::Get() - hr = 0x0
bengine: 06/29/05 12:11:49 data halted: SUCCESSFUL
bengine: 06/29/05 12:11:49 NDMPEngine: Shutting down.
bengine: 06/29/05 12:11:49 TF_NDMPGetResult(): MediaServer thread done, returning TFLE 0
pvlsvr: 06/29/05 12:11:49 PvlEntityDatabase::QueryEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = MEDIA_ENTITY_TYPE
EntityGuid = {25280342-C39D-443A-90DE-AA76D2039EA2}
EntityName = ""
EntityFlags = 0x00000000
pvlsvr: 06/29/05 12:11:49 PvlEntityDatabase::QueryEntity() : SUCCESS!
bengine: 06/29/05 12:11:49 WriteEndSet( 1 ) returning 0
bengine: 06/29/05 12:11:49 WriteEndSet( 1 ) returning 0
bengine: 06/29/05 12:11:49 WriteEndSet( 0 ) returning 0
bengine: 06/29/05 12:11:49 TF_CloseSet
pvlsvr: 06/29/05 12:11:49 AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
pvlsvr: 06/29/05 12:11:49 AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
bengine: 06/29/05 12:11:49 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 06/29/05 12:11:49 TAPEALERT: TapeAlert Device Flag = 0X0
bengine: 06/29/05 12:11:49 TAPEALERT: TapeAlert Changer Flag = 0X0
bengine: 06/29/05 12:11:49 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 06/29/05 12:11:50 TAPEALERT: Get TapeAlert Flags Return Code = 0X0
bengine: 06/29/05 12:11:50 Updating session {b7fe9f08-af6e-4dd7-93a3-c1110b90db37} with drive DATA1 {1cd33ffe-d875-4f68-b6d5-a92334ec0d65}.1
bengine: 06/29/05 12:11:50 TF_OpenTape()
bengine: 06/29/05 12:11:50 Allocated 10 buffers, size 32768 bytes, total used: 328600
bengine: 06/29/05 12:11:50 HARDWARE COMPRESSION ===> Compression is NOT configurable.
bengine: 06/29/05 12:11:50 GET_DRV_INF: bsize = 1024
bengine: 06/29/05 12:11:50 TF_OpenSet( )
bengine: 06/29/05 12:11:50 Requested Set: ID = 32dd6176 Seq = 1 Set = 1
bengine: 06/29/05 12:11:50 Current VCB: ID = 32dd6176 Seq = 1 Set = 1
bengine: 06/29/05 12:11:50 End of TF_OpenSet: Ret_val = 0 Buffs = 10 HiWater = 7
bengine: 06/29/05 12:11:50 GotoBlock: VCB_PBA = 3, VCB_LBA = 0, LBA = 0,
bengine: 06/29/05 12:11:50 PBA = 3, offset = 0
bengine: 06/29/05 12:11:50 Device Error = 1101
bengine: 06/29/05 12:11:50 Len Req = 32768 Len Got = 15360
bengine: 06/29/05 12:11:50 TF xfer time = 0 seconds.
bengine: 06/29/05 12:11:50 TF_CloseSet
pvlsvr: 06/29/05 12:11:50 AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
pvlsvr: 06/29/05 12:11:50 AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_RELEASE )
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
pvlsvr: 06/29/05 12:11:50 PvlEntityDatabase::UpdateEntity()
ParentEntityType = NULL_ENTITY_TYPE
ParentEntityGuid = {00000000-0000-0000-0000-000000000000}
EntityType = MEDIA_ENTITY_TYPE
Media = {25280342-C39D-443A-90DE-AA76D2039EA2}, ""
EntityFlags = 0x008C0000
pvlsvr: 06/29/05 12:11:50 PvlEntityDatabase::UpdateEntity() : SUCCESS!
bengine: 06/29/05 12:11:50 DeviceManager: incoming event fired
bengine: 06/29/05 12:11:50 TF_FreeDriveContext( 1C9D850 )
bengine: 06/29/05 12:11:50 TF_FreeTapeBuffers: from 10 to 0 buffers
bengine: 06/29/05 12:11:50 FreeFormatEnv( cur_fmt=0 )
pvlsvr: 06/29/05 12:11:50 AdammSession::Execute( ADAMM_SESSION_EXECUTE_MOVER_DISMOUNT )
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
Flags = 0x00000000
pvlsvr: 06/29/05 12:11:50 AdammSession::DismountMedia()
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
Library = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1"
Slot = 0000
Drive = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1"
Media = {25280342-C39D-443A-90DE-AA76D2039EA2}, "B2D000009"
Side = 0001
pvlsvr: 06/29/05 12:11:50 PvlDrive::DismountMedia()
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
Drive = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1"
Slot = 0005
Side = 0001
pvlsvr: 06/29/05 12:11:50 PvlChanger::DismountMedia()
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
Library = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1"
Drive = {1CD33FFE-D875-4F68-B6D5-A92334EC0D65}, "DATA1"
Slot = 0005
Side = 0001
pvlsvr: 06/29/05 12:11:50 AdammSession::Release()
Session = {B7FE9F08-AF6E-4DD7-93A3-C1110B90DB37}
bengine: 06/29/05 12:11:50 DeviceManager: processing pending requests
bengine: 06/29/05 12:11:50 BackupJob::MergeBEVSRJobLogsIfNecessary: No VSR log file found, no merging necessary
bengine: 06/29/05 12:11:50 DeviceManager: going to sleep for 900000 msecs
bengine: 06/29/05 12:11:50 DeviceManager: dismount event fired
beserver: 06/29/05 12:11:50 17 JobManager::HandleEndJob() called
bengine: 06/29/05 12:11:50 DeviceManager: processing pending requests
beserver: 06/29/05 12:11:50 -1 ActiveState::doEndEvent( :( 'TEST'
bengine: 06/29/05 12:11:50 DeviceManager: going to sleep for 900000 msecs
beserver: 06/29/05 12:11:50 17 JobManager::DoJobCompletionTasks(TEST): GetFinalJobStatus()=19
beserver: 06/29/05 12:11:50 18 Alert Job Success, Notify: Yes, EventLog: No, Trap: No
beserver: 06/29/05 12:11:50 18 Doing Notify
beserver: 06/29/05 12:11:50 -1 Released virtual array rowset(222).
beserver: 06/29/05 12:11:50 -1 ActiveState::doEndEvent( :( CJobManager::DoJobCompletionTasks() returned 0x0
beserver: 06/29/05 12:11:50 18 Notify Return Code:0, batch:122, index:0
bengine: 06/29/05 12:11:50 Job thread terminating
beserver: 06/29/05 12:11:50 -1 Registered virtual array rowset(223): Client:BACKUP1, Type:MD_OBJTYPE_JOBHISTORYVIEW
beserver: 06/29/05 12:11:50 -1 Client 'BACKUP1' Disconnected:0xecd44f0
beserver: 06/29/05 12:11:50 18 Notify Return Code:0, batch:122, index:1
beserver: 06/29/05 12:11:50 18 Notify Return Code:0, batch:122, index:2
beserver: 06/29/05 12:11:52 17 CJobManagerBO::Query QUERY_JOBSETUP_MONITOR