SAP Oracle Commvault GUI Restore Failed

Last post 06-24-2020, 4:14 PM by Gokhan. 2 replies.
Sort Posts: Previous Next
  • SAP Oracle Commvault GUI Restore Failed
    Posted: 06-24-2020, 2:52 AM
    SAP Oracle Commvault GUI Restore Failed


    After backing up SAP oracle Database backups running on Windows Server 2016 System with Commvault, error is received while restoring from the Commvault GUI to the same server.

    "sap BRRESTORE executon failed.Please, check the log files for details.
    Source SAP-test. Process ClSapAgent "

    I added logs and screenshot on the server. I couldn't find anything meaningful in logos.
    The command used to Restore on the Commvault GUI is as follows.
    "brrestore -d util_file -b2 235844187_2516 -m E: \ oracle \ HLD \ sapbackup \ backHLD.log == E: \ oracle \ HLD \ sapbackup -c force -u /"

    It is successful when it is restored with BRRESTORE standard command over BRTOOLS on the same server.
    "brrestore -d util_file -b" bfebusoo.anf ""

    The BRTOOLS version on the server is 7.40 (39).
    Commvault version is 11.19.11.
    Has anyone experienced this problem before? can you help me?
    Regards
    Gokhan
    Attachment: SAP-TEST-LOG.rar
  • Re: SAP Oracle Commvault GUI Restore Failed
    Posted: 06-24-2020, 3:46 PM

    Hi Gokhan,

     

    CISapAgent.log

    7788  1d40  06/22 17:58:25 2330 ::ExecuteBrRestore() - Invoking: [brrestore -d util_file -b2 235844187_2289 -m E:\oracle\HLD\sapbackup\backHLD.log==E:\oracle\HLD\\sapbackup -c force -u / ]

     

    It's a wild guess but have you tried to change the SAPDATA HOME value from "E:\oracle\HLD\" to "E:\oracle\HLD" (without backslash at the end) when configuring your SAP for Oracle instance?

  • Re: SAP Oracle Commvault GUI Restore Failed
    Posted: 06-24-2020, 4:14 PM
    Thank you for the information.
    I made the correction you specified. I started restore but got the same warning.
     
    Regards 
    Gokhan

     

     

     

    2108 f3c 06/24 22:57:32 2730 CVImpersonateLoggedOnUser() - caching user sid [S-1-5-21-4140439216-2044811844-3417608574-1001] for optimizing subsequent impersonate operations for this user
    2108 f3c 06/24 22:57:32 2730 ClSapAgent::Initialize3() - Enter JobId=[2730]
    2108 f3c 06/24 22:57:32 2730 ClSapAgent::Initialize3() - m_clientName=SAP-TEST
    2108 f3c 06/24 22:57:32 2730 ClSapAgent::Initialize3() - CVClient::getCommCellId=2
    2108 f3c 06/24 22:57:32 2730 ::JobControlInitialize() - [2730] getting the new m_jobControl for CommServer=...
    2108 f3c 06/24 22:57:32 2730 ::JobControlInitialize() - m_jobControl.init(CONTROL) 2730:2:1:0:39101...
    2108 f3c 06/24 22:57:32 2730 Init() - Initializing job control [token=2730:2:1:0:39101,cn=SAP-TEST], serverName [YDK-CS.horoz.com.tr], ControlFlag [1], Job Id [2730]
    2108 f3c 06/24 22:57:32 2730 setupControl() - Created SemName : 2730:2108
    2108 1630 06/24 22:57:32 2730 controlThread() - Going to wait on semaphore 2730:2108
    2108 f3c 06/24 22:57:32 2730 CVJobCtrlClient::registerJob()() - Sent Message to CVD, 2730
    2108 f3c 06/24 22:57:32 2730 CVJobCtrlClient::registerJob() Successfully received acknowledgement for job registration.
    2108 f3c 06/24 22:57:32 2730 CVJobCtrlLog::registerProcess(): successfully created file [C:\Program Files\Commvault\ContentStore\Base\JobControl\2.108]
    2108 f3c 06/24 22:57:32 2730 ::CreateRmanLogFileChosen() - enter
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - enter
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - nDisableCVSessionServerMode key = 0
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Successfully initialized restore job object with JM
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - EvRstTask.getAppTypeId=61 retCode=0
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Source clientId=[20] Oracle home=[E:\oracle\HLD\12201], SAP home=[E:\oracle\HLD], instId=[18], instanceName=[HLD]
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Destination client id=[20]
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - 2 Destination instance=[HLD] found. DestInstanceId=[18] destClientId=[20] AppType=[61]
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Destination SAP home=[E:\oracle\HLD], exe=[D:\usr\sap\HLD\SYS\exe\uc\NTAMD64]
    2108 f3c 06/24 22:57:32 2730 ClSapAgent::SetSapEnv() - SETENVIRONMENTVARIABLE(DIR_LIBRARY=D:\usr\sap\HLD\SYS\exe\uc\NTAMD64)
    2108 f3c 06/24 22:57:32 2730 FXRegistry::GetRegValues(341) - Wrong data type (4) enumerating registry key [SOFTWARE\CommVault Systems\Galaxy\Instance001\OracleSapAgent], value [nUPGRADETO90TIME]
    2108 f3c 06/24 22:57:32 2730 ClSapAgent::SetSapEnv() - Using sapbackupLoc=[E:\oracle\HLD\sapbackup] saparchLoc=[E:\oracle\HLD\saparch]
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Detected in-place restore. Source and destination databases are the same
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Before amgr.getArchFileListByTime(), clientId=20, instanceId=18, appType=61, before=1592927509
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - No of recs=8 cycleCreateTime=[1592925442] appId=[57] job[2516] snapRestore=0
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Job=2516 CommCellId=2
    2108 f3c 06/24 22:57:32 2730 JM Client CVJobClient::initialize(): Invalid job id passed as parameter.
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Job Init ok
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Job=2516 CommCellId=2 []
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - retCode from unserialize=0
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - LOG util_file afebuvnv.svd 2020-06-23 18:50:35 2020-06-23 18:51:22 Range=4864-4874
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - FULL util_file bfebusoo.anf 2020-06-23 18:17:06 2020-06-23 18:50:10
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - logRangeRman=<> logRangeUtil=<4864-4874> logEndTime=<2020-06-23 18:51:22>
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - checking .... crossMachineRestore=0 crossSIDRestore=0 restoreData=1 restoreArchiveLog=1 recoverDb=0 restoreTime=1592927509 recoverTime=1592927509 restoreControlFile=1 openDatabase=0 resetLogs=1 restorePartial=0 revert=0 copyPrec=0 archLogBy=0 resetDatabase=0 logFromTime=0 logToTime=0 logStart=0 logEnd=0 numStreams=2 useRmanFull=0 rmanDetail= backupValidations=0 validationType=0 switchDbMode=0
    2108 f3c 06/24 22:57:32 2730 JOBRESCACHEDIR: job 2730 creating 'C:\Program Files\Commvault\ContentStore\iDataAgent\JobResults\CV_JobResults\2\0\2730'
    2108 f3c 06/24 22:57:32 2730 SapJobProgress() - Constructor
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Restore Point In Time - restoreTime=1592927509...
    2108 f3c 06/24 22:57:32 2730 ::GetNlsLang() - fetching registry key NLS_LANG
    2108 f3c 06/24 22:57:32 2730 ::GetNlsLang() - registry key NLS_LANG not set therefore setting NLS_LANG to American_America.US7ASCII
    2108 f3c 06/24 22:57:32 2730 OraChildProcess::Initialize() - enter
    2108 f3c 06/24 22:57:32 2730 OraChildProcess::ReadBuf() - ReadFile: LastError=109
    2108 f3c 06/24 22:57:32 2730 OraChildProcess::Wait() - Child OK
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Database is in no mount mode.
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - restore_config: data summary file [E:\oracle\HLD\sapbackup\backHLD.log]
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Saved current data summary file to
    2108 f3c 06/24 22:57:32 2730 ClSapAgent::constructSAPBackupID() - Constructed SAP backupJodId = [235844187_2516]
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Run [brrestore -d util_file -b2 235844187_2516 -m E:\oracle\HLD\sapbackup\backHLD.log==E:\oracle\HLD\sapbackup -c force -u / ]
    2108 f3c 06/24 22:57:32 2730 ::ExecuteBrRestore() - Invoking: [brrestore -d util_file -b2 235844187_2516 -m E:\oracle\HLD\sapbackup\backHLD.log==E:\oracle\HLD\sapbackup -c force -u / ]
    2108 f3c 06/24 22:57:32 2730 ::GetNlsLang() - fetching registry key NLS_LANG
    2108 f3c 06/24 22:57:32 2730 ::GetNlsLang() - registry key NLS_LANG not set therefore setting NLS_LANG to American_America.US7ASCII
    2108 f3c 06/24 22:57:32 2730 ClSapAgent::SetSapEnv() - SETENVIRONMENTVARIABLE(DIR_LIBRARY=D:\usr\sap\HLD\SYS\exe\uc\NTAMD64)
    2108 f3c 06/24 22:57:32 2730 FXRegistry::GetRegValues(341) - Wrong data type (4) enumerating registry key [SOFTWARE\CommVault Systems\Galaxy\Instance001\OracleSapAgent], value [nUPGRADETO90TIME]
    2108 f3c 06/24 22:57:32 2730 ClSapAgent::SetSapEnv() - Using sapbackupLoc=[E:\oracle\HLD\sapbackup] saparchLoc=[E:\oracle\HLD\saparch]
    2108 f3c 06/24 22:57:32 2730 ClSapAgent::FillNTEnv() - SETENVIRONMENTVARIABLE(CvClientName=SAP-TEST) set successfully
    2108 f3c 06/24 22:57:32 2730 ClSapAgent::FillNTEnv() - SETENVIRONMENTVARIABLE(CvInstanceName=Instance001) set successfully
    2108 f3c 06/24 22:57:32 2730 OraChildProcess::Initialize() - enter
    2108 f3c 06/24 22:57:32 2730 OraChildProcess::BeginWait() - Rman thread with HNDL=3c8 TID=4872 EC=259 was created
    2108 1308 06/24 22:57:32 2730 OraChildProcess::WaitThread() - start: thread Id=4872
    2108 f3c 06/24 22:57:35 2730 ::ExecuteBrRestore() - After Begin wait...
    2108 f3c 06/24 22:57:35 2730 BRToolsScriptFile() - RemoveFile [C:\Program Files\Commvault\ContentStore\iDataAgent\JobResults\CV_JobResults\2\0\2730\.cv_internal.cmd] failed, error=[0x80070002:{FXFile::RemoveFile(112)/W32.2.(The system cannot find the file specified. (ERROR_FILE_NOT_FOUND.2))-Unable to get attributes, File=[\\?\C:\Program Files\Commvault\ContentStore\iDataAgent\JobResults\CV_JobResults\2\0\2730\.cv_internal.cmd], cannot delete file} + {FXFile::RemoveFile(103)/W32.2.(The system cannot find the file specified. (ERROR_FILE_NOT_FOUND.2))-First attempt to delete failed, checking attributes for retry attempt, File=[\\?\C:\Program Files\Commvault\ContentStore\iDataAgent\JobResults\CV_JobResults\2\0\2730\.cv_internal.cmd]}]
    2108 f3c 06/24 22:57:35 2730 ::ExecuteBrRestore() - getting new OraSbtJobUnit ...
    2108 f3c 06/24 22:57:35 2730 ::DbSbtJobUnit() - enter.
    2108 f3c 06/24 22:57:35 2730 ::Init() - [2730] enter.
    2108 f3c 06/24 22:57:35 2730 ::Init() - Control thread was not started
    2108 f3c 06/24 22:57:35 2730 ::Init() - service Name : OraSbtSrvcDATA2730
    2108 f3c 06/24 22:57:35 2730 ::ExecuteBrRestore() - m_jobUnit->Init succeeded.
    2108 f3c 06/24 22:57:35 2730 ::WaitRman() - enter; m_notifyRequester = False
    2108 f3c 06/24 22:57:35 2730 OraChildProcess::ReadBuf() - Rman thread with HNDL=3c4 TID=5180 EC=259 was created
    2108 143c 06/24 22:57:35 2730 OraChildProcess::ReadThread() - start: thread Id=5180
    2108 1308 06/24 22:57:37 2730 OraChildProcess::Wait() - Child process: dwExitCode=-1073740791
    2108 1308 06/24 22:57:37 2730 OraChildProcess::WaitThread() - Wait failed; lastErr=-1073740791
    2108 143c 06/24 22:57:47 2730 OraChildProcess::ReadThread() - GETLASTERROR returned=109 (ret=0)
    2108 f3c 06/24 22:57:47 2730 ::CloseJobResultsFile() - [2730] going to m_buResults.closeFile...
    2108 f3c 06/24 22:57:47 2730 JOBRESULTSTABLE(C:\Program Files\Commvault\ContentStore\iDataAgent\JobResults\CV_JobResults\2\0\2730 removing copy 'C:\Program Files\Commvault\ContentStore\iDataAgent\JobResults\CV_JobResults\2\0\2730'
    2108 f3c 06/24 22:57:47 2730 ::CloseJobResultsFile() - [2730] m_buResults.closeFile() & cleanUp() succeeded.
    2108 f3c 06/24 22:57:47 2730 OraChildProcess::Finalize() - start
    2108 f3c 06/24 22:57:47 2730 ::ProcessComplete() - Sending ORA_MSG_RMAN_COMPLETE
    2108 f3c 06/24 22:57:47 2730 ::WaitRman() - sap BR*TOOL execution failed.
    2108 f3c 06/24 22:57:47 2730 ::WaitRman() - Sap BR*Tools execution Failed.
    Please, check the client log file for details.
    2108 f3c 06/24 22:57:47 2730 BRToolsScriptFile() - RemoveFile [C:\Program Files\Commvault\ContentStore\iDataAgent\JobResults\CV_JobResults\2\0\2730\.cv_internal.cmd] failed, error=[0x80070002:{FXFile::RemoveFile(112)/W32.2.(The system cannot find the file specified. (ERROR_FILE_NOT_FOUND.2))-Unable to get attributes, File=[\\?\C:\Program Files\Commvault\ContentStore\iDataAgent\JobResults\CV_JobResults\2\0\2730\.cv_internal.cmd], cannot delete file} + {FXFile::RemoveFile(103)/W32.2.(The system cannot find the file specified. (ERROR_FILE_NOT_FOUND.2))-First attempt to delete failed, checking attributes for retry attempt, File=[\\?\C:\Program Files\Commvault\ContentStore\iDataAgent\JobResults\CV_JobResults\2\0\2730\.cv_internal.cmd]}]
    2108 f3c 06/24 22:57:47 2730 ::ExecuteBrRestore() - Renamed to
    2108 f3c 06/24 22:57:47 2730 BRToolsScriptFile() - RemoveFile [C:\Program Files\Commvault\ContentStore\iDataAgent\JobResults\CV_JobResults\2\0\2730\.cv_internal.cmd] failed, error=[0x80070002:{FXFile::RemoveFile(112)/W32.2.(The system cannot find the file specified. (ERROR_FILE_NOT_FOUND.2))-Unable to get attributes, File=[\\?\C:\Program Files\Commvault\ContentStore\iDataAgent\JobResults\CV_JobResults\2\0\2730\.cv_internal.cmd], cannot delete file} + {FXFile::RemoveFile(103)/W32.2.(The system cannot find the file specified. (ERROR_FILE_NOT_FOUND.2))-First attempt to delete failed, checking attributes for retry attempt, File=[\\?\C:\Program Files\Commvault\ContentStore\iDataAgent\JobResults\CV_JobResults\2\0\2730\.cv_internal.cmd]}]
    2108 f3c 06/24 22:57:47 2730 ::ExitHere() - enter: phase=11
    2108 f3c 06/24 22:57:47 2730 GetChannelParamFileName() - Channel Parameter File : C:\PROGRA~1\COMMVA~1\CONTEN~1\Base\Temp\cv_channel_info2730
    2108 f3c 06/24 22:57:47 2730 DeleteChannelParamFile() - Cleaned up channel parameter file
    2108 f3c 06/24 22:57:47 2730 ::NotifyCommServeJobComplete() - Notify CommServe: jobObject.complete(FAIL)
    2108 f3c 06/24 22:57:47 2730 Sending FAILED complete message to JM, 2730
    2108 f3c 06/24 22:57:47 2730 ::ExitHere() - m_firstErrDescr = [Sap BR*Tools execution Failed.
    Please, check the client log file for details.]
    2108 f3c 06/24 22:57:47 2730 ::Finalize() - enter Parent=true
    2108 f3c 06/24 22:57:47 2730 ::Finalize() - m_jobControl->finishedWorkWithoutExit() ...
    2108 f3c 06/24 22:57:47 2730 finishedWorkWithOutExit() - Release control semaphore 2730:2108
    2108 f3c 06/24 22:57:47 2730 finishedWorkWithOutExit() - Waiting for control thread to Quit, 2730
    2108 1630 06/24 22:57:47 2730 controlThread() - Normal termination, Job Id 2730
    2108 1630 06/24 22:57:47 2730 controlThread() - Send unregister message to CVD, Job Id 2730
    2108 1630 06/24 22:57:47 2730 unRegisterProcess() - Send Message to CVD 2730
    2108 1630 06/24 22:57:47 2730 unRegisterProcess() - Send Message Successfully 2730
    2108 1630 06/24 22:57:47 2730 CVJobCtrlLog::unregisterProcess(): successfully removed file [C:\Program Files\Commvault\ContentStore\Base\JobControl\2.108]
    2108 1630 06/24 22:57:47 2730 controlThread() - Control thread done, Job Id 2730
    2108 f3c 06/24 22:57:47 2730 finishedWorkWithOutExit() - Control thread Done , ID : 2730
    2108 f3c 06/24 22:57:47 2730 ::Finalize() - delete m_jobControl ...
    2108 f3c 06/24 22:57:47 2730 ::~DbSbtJobUnit() - [2730] enter.
    2108 f3c 06/24 22:57:47 2730 ::~DbSbtJobUnit() - [2730] going to delete m_oraThread
    2108 f3c 06/24 22:57:47 2730 ::~DbSbtJobUnit() - [2730] after: delete m_oraThread
    2108 f3c 06/24 22:57:47 2730 ::Finalize() - [2730] delete m_jobObject.
    2108 f3c 06/24 22:57:47 2730 ::~DbJobObject() - After m_jobObject deletion.
    2108 f3c 06/24 22:57:47 2730 ::Finalize() - delete m_event ...

The content of the forums, threads and posts reflects the thoughts and opinions of each author, and does not represent the thoughts, opinions, plans or strategies of Commvault Systems, Inc. ("Commvault") and Commvault undertakes no obligation to update, correct or modify any statements made in this forum. Any and all third party links, statements, comments, or feedback posted to, or otherwise provided by this forum, thread or post are not affiliated with, nor endorsed by, Commvault.
Commvault, Commvault and logo, the “CV” logo, Commvault Systems, Solving Forward, SIM, Singular Information Management, Simpana, Commvault Galaxy, Unified Data Management, QiNetix, Quick Recovery, QR, CommNet, GridStor, Vault Tracker, InnerVault, QuickSnap, QSnap, Recovery Director, CommServe, CommCell, SnapProtect, ROMS, and CommValue, are trademarks or registered trademarks of Commvault Systems, Inc. All other third party brands, products, service names, trademarks, or registered service marks are the property of and used to identify the products or services of their respective owners. All specifications are subject to change without notice.
Close
Copyright © 2020 Commvault | All Rights Reserved. | Legal | Privacy Policy