./vlteject -eject -vault Gosi_Vault_2 -sessionid 372 starting eject process. Please wait... Exit error: process called but nothing to do EXIT status = 296 [root@netbackup1 logs]# cat detail.log | more 06:00:03.138 [31221] <4> vltrun@startSession: Session Information RVP = Cum_Vault_2 SID = 372 StartTime = 2012.10.01 06:00:03 AM (1349060403) 06:00:03.142 [31221] <2> vltrun@VaultJobMonitor::_send_jobdata^372: SENT JobDataEx_t to JOBD at 1349060403 06:00:03.142 [31221] <4> vltrun@save_vault_conf()^372: VAULT_PREFERENCES NotificationEmail=walnumai@gosi.gov.sa EjectNotificationEmail=walnumai@gosi.gov.sa SortOnExpiryDate=NO MGOImageSelectDays=0 LastMod=[T S=13303267537219580] 06:00:03.142 [31221] <4> vltrun@save_vault_conf()^372: ALIASES 06:00:03.142 [31221] <4> vltrun@save_vault_conf()^372: RETENTION_MAP 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=0, NEW=0 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=1, NEW=1 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=2, NEW=2 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=3, NEW=3 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=4, NEW=4 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=5, NEW=5 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=6, NEW=6 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=7, NEW=7 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=8, NEW=8 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=9, NEW=9 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=10, NEW=10 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=11, NEW=11 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=12, NEW=12 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=13, NEW=13 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=14, NEW=14 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=15, NEW=15 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=16, NEW=16 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=17, NEW=17 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=18, NEW=18 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=19, NEW=19 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=20, NEW=20 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=21, NEW=21 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=22, NEW=22 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=23, NEW=23 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: OLD=24, NEW=24 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: REPORTS 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: Report Name=0 Title=Picking List for Robot Option=YES File= Printer= Email=walnumai@gosi.gov.sa 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: Report Name=1 Title=Distribution List for Vault Option=NO File= Printer= Email= 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: Report Name=2 Title=Detailed Distribution List for Vault Option=NO File= Printer= Email= 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: Report Name=3 Title=Summary Distribution List for Vault Option=NO File= Printer= Email= 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: Report Name=4 Title=Picking List for Vault Option=YES File= Printer= Email=walnumai@gosi.gov.sa 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: Report Name=5 Title=Distribution List for Robot Option=NO File= Printer= Email= 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: Report Name=6 Title=Vault Inventory Option=YES File= Printer= Email=walnumai@gosi.gov.sa 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: Report Name=7 Title=Off-site Inventory Option=NO File= Printer= Email= 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: Report Name=8 Title=All Media Inventory Option=NO File= Printer= Email= 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: Report Name=9 Title=Recovery Report for Vault Option=NO File= Printer= Email= 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: Report Name=10 Title=Non-vaulted Images Option=NO File= Printer= Email= 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: ROBOT Name=TLD(1) Id=2 RobotNumber=1 RobotType=TLD RoboticControlHost=netbacksrv LastModSec=[TS=13303267448093160] Use_VP_ENE=YES 06:00:03.143 [31221] <4> vltrun@save_vault_conf()^372: VAULT Name=Gosi_Vault_2 Vendor=Iron Mountain Id=2 RobotId=2 CustomerID=123 RobotVolumeGroup=001_00001_TLD OffsiteVolumeGroup=Offsite_Volume_Group Vau ltContainers=NO VaultSeed=1 LastMod=[TS=13310218481522670] 06:00:03.144 [31221] <4> vltrun@save_vault_conf()^372: MAP 06:00:03.144 [31221] <4> vltrun@save_vault_conf()^372: RETENTION_MAP 06:00:03.144 [31221] <4> vltrun@save_vault_conf()^372: PROFILE Name=Cum_Vault_2 Id=8 VaultId=2 RobotId=2 LastMod=[TS=13406203568747580] 06:00:03.144 [31221] <4> vltrun@save_vault_conf()^372: 06:00:03.144 [31221] <4> vltrun@save_vault_conf()^372: SELECTION StartDay=4 StartHour=0 EndDay=1 EndHour=0 06:00:03.144 [31221] <4> vltrun@save_vault_conf()^372: ATTRIBUTE_FILTER = YES 06:00:03.144 [31221] <4> vltrun@save_vault_conf()^372: CLIENT Attributes: ClientOption=INCLUDE_ALL 06:00:03.144 [31221] <4> vltrun@save_vault_conf()^372: CLIENT: 06:00:03.144 [31221] <4> vltrun@save_vault_conf()^372: BACKUP_TYPE: Attributes: BackupTypeOption=INCLUDE_ALL 06:00:03.144 [31221] <4> vltrun@save_vault_conf()^372: BACKUP_TYPE: 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): RETENTION_MAP 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): PROFILE Name=Cum_Vault_2 Id=8 VaultId=2 RobotId=2 LastMod=[TS=13490854134449090] 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): SELECTION StartDay=4 StartHour=0 EndDay=1 EndHour=0 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): ATTRIBUTE_FILTER = YES 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): CLIENT Attributes: ClientOption=INCLUDE_ALL 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): CLIENT: 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): BACKUP_TYPE: Attributes: BackupTypeOption=INCLUDE_ALL 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): BACKUP_TYPE: 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): MEDIA_SERVER Attributes: MediaServerOption=INCLUDE_ALL 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): MEDIA_SERVER: 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): CLASS Attributes: ClassOption=INCLUDE 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): CLASS: tape_exa_proddb_daily 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): SCHEDULE Attributes: ScheduleOption=INCLUDE 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): SCHEDULE: Default-Application-Backup tape_exa_proddb_daily Default-Application-Backup-tape-daily 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): RETENTION_LEVEL: Attributes: RetentionLevelOption=ALL 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): RETENTION_LEVEL: 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): LOCATION_FILTER = NO 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): DUPLICATION Skip=NO SharedRobots=NO Multiplex=NO SortOrder=1 DupPriority=-1 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): DUPLICATION_ITEM BackupServer= AltReadHost= ReadDrives=1 WriteDrives=1 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): DUPLICATION_COPY StgUnit=netbacksrv-hcart-robot-tld-1 VolPool=Offsite_Pool Fail=YES Primary=NO Retention=-1 ShareGroup=*ANY* 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): CATALOG_BACKUP Skip=NO 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): CatalogBackupPolicy=Vault_Hot_Catalog 13:16:33.735 [404] <4> vlteject@save_vault_conf_in_eject(): VaultCatalogBackupSchedule=Cumulative-Inc_Catalog_Vault2 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): EJECT Skip=NO 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): EjectMode=Auto 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): SuspendMode=LATER 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): POOLS: Offsite_Pool Offsite_Catalog_Pool 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): AUXILIARY_POOLS: 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): Use_RBT_or_VP_ENE=NO 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): EjectNotificationEmail=walnumai@gosi.gov.sa 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): REPORTS HEADER 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): ReportsMode=Manual 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): IMFile= 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): ReportsHeader= 13:16:33.736 [404] <4> vlteject@save_vault_conf_in_eject(): UseGlobalRptsDist=YES 13:16:33.736 [404] <4> vlteject@VaultJobMonitor::_set_jobd_hostname: Jobd host=netbacksrv 13:16:33.738 [404] <4> vlteject@VaultJobMonitor::_connect: Successfully connected to Job Daemon at 1349086593 13:16:33.823 [404] <4> vlteject@VaultJobMonitor::_create_job_id: Acquired new Jobid=49762 at 1349086593 13:16:33.823 [404] <2> vlteject@VaultJobMonitor::_send_jobdata: SENT JobDataEx_t to JOBD at 1349086593 13:16:33.823 [404] <2> vlteject@main: Init 0 job 49762 13:16:33.825 [407] <2> vlteject@jobd_pinger_process: Entered with JOB_ID=49762 FD=12 13:16:33.825 [407] <4> vlteject@VaultJobMonitor::_set_jobd_hostname: Jobd host=netbacksrv 13:16:33.826 [404] <2> vlteject@init_global_lock(): MaxVltJobs=50 13:16:33.826 [404] <2> vlteject@VaultLockProxy::acquire_lock: Type=NBVAULT.MAXJOBS Key= Limit=50 13:16:33.826 [404] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086593 sent TRY_MSG: VAULT_WAITING_FOR_GLOBAL_LOCK 1349086593 13:16:33.828 [407] <4> vlteject@VaultJobMonitor::_connect: Successfully connected to Job Daemon at 1349086593 13:16:33.971 [404] <4> vlteject@VaultLockProxy::acquire_lock: Lock acquired key=netbacksrv.NBVAULT.MAXJOBS 13:16:33.972 [404] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086593 sent TRY_MSG: VAULT_GLOBAL_LOCK_ACQUIRED 1349086593 13:16:33.972 [404] <2> vlteject@VaultJobMonitor::_send_jobdata: SENT JobDataEx_t to JOBD at 1349086593 13:16:33.972 [404] <2> vlteject@main: MakeActive Job 49762 13:16:33.972 [404] <2> vlteject@VaultJobMonitor::_send_jobdata: SENT JobDataEx_t to JOBD at 1349086593 13:16:33.972 [404] <2> vlteject@VaultJobMonitor::_send_jobrundata: SENT JobRunDataEx_t to JOBD at 1349086593 13:16:33.972 [404] <4> vlteject@veject(): *************************VEJECT STARTS********************** 13:16:33.973 [404] <2> vlteject@veject(): Received eject request with following parms 13:16:33.973 [404] <2> vlteject@veject(): Robot Name = 1 13:16:33.973 [404] <2> vlteject@veject(): Vault Name = Gosi_Vault_2 13:16:33.973 [404] <2> vlteject@veject(): Profile Name = Cum_Vault_2 13:16:33.973 [404] <2> vlteject@veject(): Session Id= 372 13:16:33.973 [404] <2> vlteject@veject(): Printing the structure elements eject parms preview Requested:0 13:16:33.973 [404] <2> vlteject@veject(): Extending the scope of existing job id 49762 13:16:33.973 [404] <2> vlteject@VaultJobMonitor::_send_jobrundata: SENT JobRunDataEx_t to JOBD at 1349086593 13:16:33.973 [404] <4> vlteject@VaultJobMonitor::_send_operation: Sent Operation=8 op to Job daemon 13:16:33.973 [404] <2> vlteject@VaultJobMonitor::_find_op_string: Found 8->EJECT_AND_REPORT 13:16:33.973 [404] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086593 sent TRY_MSG: BEGIN_OPERATION 1349086593 EJECT_AND_REPORT 13:16:33.973 [404] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086593 sent TRY_MSG: CONNECT 1349086593 13:16:33.973 [404] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086593 sent TRY_MSG: CONNECTED 1349086593 13:16:33.973 [404] <2> vlteject@connectToVRTObject: Connecting to vccs server netbacksrv 13:16:33.977 [404] <2> vlteject@connectToVRTObject: VaultRuntimePortal init succeeded 13:16:33.977 [404] <2> vlteject@Consolidate::getSessionsForEject(): Consolidation request is for a session 13:16:33.978 [404] <2> vlteject@filterSessions(): Entering filterSessions Function [IN Size: 0] 13:16:33.978 [404] <2> vlteject@filterSessions(): Retruning... [OUT Size: 0] 13:16:33.978 [404] <2> vlteject@Consolidate::getSessionsForEject(): Returning 0 number of records 13:16:33.979 [404] <16> vlteject@veject(): Nothing to do for the specified profile list 13:16:33.981 [404] <2> vlteject@VaultLockProxy::release_all_locks: UpdJobd=1 13:16:33.981 [404] <2> vlteject@VaultLockProxy::release_all_locks: Releasing lock Type=NBVAULT.MAXJOBS 13:16:33.981 [404] <2> vlteject@VaultLockProxy::release_lock: Type=NBVAULT.MAXJOBS 13:16:33.982 [404] <4> vlteject@VaultLockProxy::release_lock: released lock. Key=netbacksrv.NBVAULT.MAXJOBS 13:16:33.982 [404] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086593 sent TRY_MSG: VAULT_GLOBAL_LOCK_RELEASED 1349086593 13:16:33.982 [404] <2> vlteject@VaultLockProxy::release_all_locks: UpdJobd=0 13:16:33.982 [404] <2> vlteject@bv_vlteject_exit(): In 13:16:33.982 [404] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086593 sent TRY_MSG: END_OPERATION 1349086593 13:16:33.982 [404] <2> vlteject@VaultJobMonitor::_send_jobdata: SENT JobDataEx_t to JOBD at 1349086593 13:16:33.985 [404] <4> vlteject@bv_vlteject_exit(): Job Complete 13:16:33.991 [404] <2> vlteject@cancel_keepalive_process: Entering to cancel PID=407, JOB_ID=49762 with FD=13 13:16:33.991 [407] <4> vlteject@jobd_pinger_process: select result = 1 13:16:33.991 [407] <4> vlteject@jobd_pinger_process: MSG from parent, Pinger done 13:16:33.991 [407] <8> vlteject@jobd_pinger_process: Child quitting with exit_status=0 13:16:33.992 [404] <2> vlteject@cancel_keepalive_process: Msg to Child: Exit now 13:16:33.992 [404] <4> vlteject@cancel_keepalive_process: write end of pipe closed 13:16:33.992 [404] <2> vlteject@cancel_keepalive_process: Harvesting child's exit status 13:16:34.009 [404] <8> vlteject@cancel_keepalive_process: Child exited with EC=0 SIG=0 13:20:44.864 [1561] <2> vlteject@connectToVRTObject: Connecting to vccs server netbacksrv 13:20:44.867 [1561] <2> vlteject@connectToVRTObject: VaultRuntimePortal init succeeded 13:20:44.868 [1561] <2> vlteject@getAllSessions: Returning 18 number of records 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): VAULT_PREFERENCES NotificationEmail=walnumai@gosi.gov.sa EjectNotificationEmail=walnumai@gosi.gov.sa SortOnExpiryDate=NO MGOImageSelectDays=0 LastMod=[TS=13490868448090140] 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): ALIASES 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): RETENTION_MAP 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=0, NEW=0 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=1, NEW=1 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=2, NEW=2 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=3, NEW=3 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=4, NEW=4 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=5, NEW=5 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=6, NEW=6 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=7, NEW=7 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=8, NEW=8 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=9, NEW=9 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=10, NEW=10 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=11, NEW=11 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=12, NEW=12 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=13, NEW=13 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=14, NEW=14 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=15, NEW=15 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=16, NEW=16 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=17, NEW=17 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=18, NEW=18 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=19, NEW=19 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=20, NEW=20 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=21, NEW=21 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=22, NEW=22 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=23, NEW=23 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): OLD=24, NEW=24 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): REPORTS 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): Report Name=0 Title=Picking List for Robot Option=YES File= Printer= Email=walnumai@gosi.gov.sa 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): Report Name=1 Title=Distribution List for Vault Option=NO File= Printer= Email= 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): Report Name=2 Title=Detailed Distribution List for Vault Option=NO File= Printer= Email= 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): Report Name=3 Title=Summary Distribution List for Vault Option=NO File= Printer= Email= 13:20:44.872 [1561] <4> vlteject@save_vault_conf_in_eject(): Report Name=4 Title=Picking List for Vault Option=YES File= Printer= Email=walnumai@gosi.gov.sa 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): Report Name=5 Title=Distribution List for Robot Option=NO File= Printer= Email= 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): Report Name=6 Title=Vault Inventory Option=YES File= Printer= Email=walnumai@gosi.gov.sa 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): Report Name=7 Title=Off-site Inventory Option=NO File= Printer= Email= 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): Report Name=8 Title=All Media Inventory Option=NO File= Printer= Email= 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): Report Name=9 Title=Recovery Report for Vault Option=NO File= Printer= Email= 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): Report Name=10 Title=Non-vaulted Images Option=NO File= Printer= Email= 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): ROBOT Name=TLD(1) Id=2 RobotNumber=1 RobotType=TLD RoboticControlHost=netbacksrv LastModSec=[TS=13303267448093160] Use_VP_ENE=YES 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): VAULT Name=Gosi_Vault_2 Vendor=Iron Mountain Id=2 RobotId=2 CustomerID=123 RobotVolumeGroup=001_00001_TLD OffsiteVolumeGroup=Offsite_Volume_Group VaultContainers=NO VaultSeed=1 LastMod=[TS=13310218481522670] 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): MAP 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): RETENTION_MAP 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): PROFILE Name=Cum_Vault_2 Id=8 VaultId=2 RobotId=2 LastMod=[TS=13490854134449090] 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): SELECTION StartDay=4 StartHour=0 EndDay=1 EndHour=0 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): ATTRIBUTE_FILTER = YES 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): CLIENT Attributes: ClientOption=INCLUDE_ALL 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): CLIENT: 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): BACKUP_TYPE: Attributes: BackupTypeOption=INCLUDE_ALL 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): BACKUP_TYPE: 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): MEDIA_SERVER Attributes: MediaServerOption=INCLUDE_ALL 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): MEDIA_SERVER: 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): CLASS Attributes: ClassOption=INCLUDE 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): CLASS: tape_exa_proddb_daily 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): SCHEDULE Attributes: ScheduleOption=INCLUDE 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): SCHEDULE: Default-Application-Backup tape_exa_proddb_daily Default-Application-Backup-tape-daily 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): RETENTION_LEVEL: Attributes: RetentionLevelOption=ALL 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): RETENTION_LEVEL: 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): LOCATION_FILTER = NO 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): DUPLICATION Skip=NO SharedRobots=NO Multiplex=NO SortOrder=1 DupPriority=-1 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): DUPLICATION_ITEM BackupServer= AltReadHost= ReadDrives=1 WriteDrives=1 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): DUPLICATION_COPY StgUnit=netbacksrv-hcart-robot-tld-1 VolPool=Offsite_Pool Fail=YES Primary=NO Retention=-1 ShareGroup=*ANY* 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): CATALOG_BACKUP Skip=NO 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): CatalogBackupPolicy=Vault_Hot_Catalog 13:20:44.873 [1561] <4> vlteject@save_vault_conf_in_eject(): VaultCatalogBackupSchedule=Cumulative-Inc_Catalog_Vault2 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): EJECT Skip=NO 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): EjectMode=Auto 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): SuspendMode=LATER 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): POOLS: Offsite_Pool Offsite_Catalog_Pool 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): AUXILIARY_POOLS: 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): Use_RBT_or_VP_ENE=NO 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): EjectNotificationEmail=walnumai@gosi.gov.sa 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): REPORTS HEADER 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): ReportsMode=Manual 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): IMFile= 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): ReportsHeader= 13:20:44.874 [1561] <4> vlteject@save_vault_conf_in_eject(): UseGlobalRptsDist=YES 13:20:44.874 [1561] <4> vlteject@VaultJobMonitor::_set_jobd_hostname: Jobd host=netbacksrv 13:20:44.876 [1561] <4> vlteject@VaultJobMonitor::_connect: Successfully connected to Job Daemon at 1349086844 13:20:44.918 [1561] <4> vlteject@VaultJobMonitor::_create_job_id: Acquired new Jobid=49763 at 1349086844 13:20:44.918 [1561] <2> vlteject@VaultJobMonitor::_send_jobdata: SENT JobDataEx_t to JOBD at 1349086844 13:20:44.918 [1561] <2> vlteject@main: Init 0 job 49763 13:20:44.919 [1564] <2> vlteject@jobd_pinger_process: Entered with JOB_ID=49763 FD=12 13:20:44.920 [1564] <4> vlteject@VaultJobMonitor::_set_jobd_hostname: Jobd host=netbacksrv 13:20:44.920 [1561] <2> vlteject@init_global_lock(): MaxVltJobs=50 13:20:44.920 [1561] <2> vlteject@VaultLockProxy::acquire_lock: Type=NBVAULT.MAXJOBS Key= Limit=50 13:20:44.920 [1561] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086844 sent TRY_MSG: VAULT_WAITING_FOR_GLOBAL_LOCK 1349086844 13:20:44.959 [1564] <4> vlteject@VaultJobMonitor::_connect: Successfully connected to Job Daemon at 1349086844 13:20:45.042 [1561] <4> vlteject@VaultLockProxy::acquire_lock: Lock acquired key=netbacksrv.NBVAULT.MAXJOBS 13:20:45.042 [1561] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086845 sent TRY_MSG: VAULT_GLOBAL_LOCK_ACQUIRED 1349086845 13:20:45.042 [1561] <2> vlteject@VaultJobMonitor::_send_jobdata: SENT JobDataEx_t to JOBD at 1349086845 13:20:45.042 [1561] <2> vlteject@main: MakeActive Job 49763 13:20:45.043 [1561] <2> vlteject@VaultJobMonitor::_send_jobdata: SENT JobDataEx_t to JOBD at 1349086845 13:20:45.043 [1561] <2> vlteject@VaultJobMonitor::_send_jobrundata: SENT JobRunDataEx_t to JOBD at 1349086845 13:20:45.043 [1561] <4> vlteject@veject(): *************************VEJECT STARTS********************** 13:20:45.043 [1561] <2> vlteject@veject(): Received eject request with following parms 13:20:45.043 [1561] <2> vlteject@veject(): Robot Name = 1 13:20:45.043 [1561] <2> vlteject@veject(): Vault Name = Gosi_Vault_2 13:20:45.043 [1561] <2> vlteject@veject(): Profile Name = Cum_Vault_2 13:20:45.044 [1561] <2> vlteject@veject(): Session Id= 372 13:20:45.044 [1561] <2> vlteject@veject(): Printing the structure elements eject parms preview Requested:0 13:20:45.044 [1561] <2> vlteject@veject(): Extending the scope of existing job id 49763 13:20:45.044 [1561] <2> vlteject@VaultJobMonitor::_send_jobrundata: SENT JobRunDataEx_t to JOBD at 1349086845 13:20:45.044 [1561] <4> vlteject@VaultJobMonitor::_send_operation: Sent Operation=8 op to Job daemon 13:20:45.044 [1561] <2> vlteject@VaultJobMonitor::_find_op_string: Found 8->EJECT_AND_REPORT 13:20:45.044 [1561] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086845 sent TRY_MSG: BEGIN_OPERATION 1349086845 EJECT_AND_REPORT 13:20:45.044 [1561] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086845 sent TRY_MSG: CONNECT 1349086845 13:20:45.044 [1561] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086845 sent TRY_MSG: CONNECTED 1349086845 13:20:45.044 [1561] <2> vlteject@connectToVRTObject: Connecting to vccs server netbacksrv 13:20:45.048 [1561] <2> vlteject@connectToVRTObject: VaultRuntimePortal init succeeded 13:20:45.048 [1561] <2> vlteject@Consolidate::getSessionsForEject(): Consolidation request is for a session 13:20:45.050 [1561] <2> vlteject@filterSessions(): Entering filterSessions Function [IN Size: 0] 13:20:45.050 [1561] <2> vlteject@filterSessions(): Retruning... [OUT Size: 0] 13:20:45.050 [1561] <2> vlteject@Consolidate::getSessionsForEject(): Returning 0 number of records 13:20:45.050 [1561] <16> vlteject@veject(): Nothing to do for the specified profile list 13:20:45.052 [1561] <2> vlteject@VaultLockProxy::release_all_locks: UpdJobd=1 13:20:45.052 [1561] <2> vlteject@VaultLockProxy::release_all_locks: Releasing lock Type=NBVAULT.MAXJOBS 13:20:45.052 [1561] <2> vlteject@VaultLockProxy::release_lock: Type=NBVAULT.MAXJOBS 13:20:45.053 [1561] <4> vlteject@VaultLockProxy::release_lock: released lock. Key=netbacksrv.NBVAULT.MAXJOBS 13:20:45.054 [1561] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086845 sent TRY_MSG: VAULT_GLOBAL_LOCK_RELEASED 1349086845 13:20:45.054 [1561] <2> vlteject@VaultLockProxy::release_all_locks: UpdJobd=0 13:20:45.054 [1561] <2> vlteject@bv_vlteject_exit(): In 13:20:45.054 [1561] <2> vlteject@VaultJobMonitor::_send_try_msg: At 1349086845 sent TRY_MSG: END_OPERATION 1349086845 13:20:45.054 [1561] <2> vlteject@VaultJobMonitor::_send_jobdata: SENT JobDataEx_t to JOBD at 1349086845 13:20:45.059 [1561] <4> vlteject@bv_vlteject_exit(): Job Complete 13:20:45.066 [1561] <2> vlteject@cancel_keepalive_process: Entering to cancel PID=1564, JOB_ID=49763 with FD=13 13:20:45.067 [1561] <2> vlteject@cancel_keepalive_process: Msg to Child: Exit now 13:20:45.067 [1561] <4> vlteject@cancel_keepalive_process: write end of pipe closed 13:20:45.067 [1564] <4> vlteject@jobd_pinger_process: select result = 1 13:20:45.067 [1561] <2> vlteject@cancel_keepalive_process: Harvesting child's exit status 13:20:45.067 [1564] <4> vlteject@jobd_pinger_process: MSG from parent, Pinger done 13:20:45.067 [1564] <8> vlteject@jobd_pinger_process: Child quitting with exit_status=0 13:20:45.085 [1561] <8> vlteject@cancel_keepalive_process: Child exited with EC=0 SIG=0