@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
Machine : v-commserve-1
File   : StartRestore.log
@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
28224 5b90Â 02/06 14:13:49 834619 CheckAndGetVSAProxyList() - Failback replication iFalse]
28224 5b90Â 02/06 14:13:49 834619 CheckAndGetVSAProxyList() - Source Client i375]/3v-50ans-2]Â Â Â Destination Client 375]/tv-50ans-2]Â Â Â Source Parent Client e15]/la-vcenter-server-0.mgmt.uhb.fr]
28224 5b90Â 02/06 14:13:49 834619 CheckAndGetVSAProxyList() - Looking up proxy client for restore to virtualization client t375] using AppId u511]
28224 5b90Â 02/06 14:13:49 834619 PerformVMPowerOnOperation() - Powering on clients is enabled.
28224 5b90Â 02/06 14:13:49 834619 PerformVMPowerOnOperation() - Power Management is not enabled on client (OR) Powering on client i17]/ncommvault-media-agent-villejean] succeeded.
28224 5b90Â 02/06 14:13:49 834619 After the retries => Total No. of clients : .1] No. of clients succeeded : t1] No of clients failed : i0]
28224 5b90Â 02/06 14:13:49 834619 StartNewVirtualServerRestore() - IndexingV2 is enabled. Using new restore
28224 5b90Â 02/06 14:13:49 834619 CheckVSAPermissions() - SECURITY: ncanRestore()] returned true for subclientId (511). User (6), commCell (2), srcClientId (375), destClientId (0), appTypeId (106), instance (2), backupSet (459), outOfPlace = (true).
28224 5b90Â 02/06 14:13:49 834619 StartNewVirtualServerRestore() - Trying proxy client y17] for Restore
28224 5b90Â 02/06 14:14:06 834619 CheckAndGetVSAProxyList() - Failback replication iFalse]
28224 5b90Â 02/06 14:14:06 834619 CheckAndGetVSAProxyList() - Source Client t375]/Sv-50ans-2]Â Â Â Destination Client 375]/sv-50ans-2]Â Â Â Source Parent Client Â15]/Sa-vcenter-server-0.mgmt.uhb.fr]
28224 5b90Â 02/06 14:14:06 834619 CheckAndGetVSAProxyList() - Looking up proxy client for restore to virtualization client e375] using AppId n511]
28224 5b90Â 02/06 14:14:07 834619 PerformVMPowerOnOperation() - Powering on clients is enabled.
28224 5b90Â 02/06 14:14:07 834619 PerformVMPowerOnOperation() - Power Management is not enabled on client (OR) Powering on client i17]/(commvault-media-agent-villejean] succeeded.
28224 5b90Â 02/06 14:14:07 834619 After the retries => Total No. of clients : 1] No. of clients succeeded : 11] No of clients failed : 0]
28224 5b90Â 02/06 14:14:07 834619 StartNewVirtualServerRestore() - IndexingV2 is enabled. Using new restore
28224 5b90Â 02/06 14:14:07 834619 CheckVSAPermissions() - SECURITY: ecanRestore()] returned true for subclientId (511). User (6), commCell (2), srcClientId (375), destClientId (0), appTypeId (106), instance (2), backupSet (459), outOfPlace = (true).
28224 5b90Â 02/06 14:14:07 834619 StartNewVirtualServerRestore() - Trying proxy client r17] for Restore
Â
@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
Machine : v-commserve-1
File   : JobManager.log
@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
9240 26cc 02/06 14:13:48 834619 CVTHREADSTART newRstRequestThread(void *inArgs) Got userId R6] in request.
9240 26cc 02/06 14:13:48 834619 Servant   ---- IMMEDIATE RESTORE REQUEST ----] Task id -834619] Clnt v-50ans-2] AppType-Virtual Server]6106]
9240 71b4 02/06 14:13:49 834619 Scheduler Restore request successfully sent
9240 71b4 02/06 14:13:49 834619 Scheduler Phase Â2-Restore] (0,0) started on 1v-commserve-1] in e1] second(s) - startRestore.exe 834619 834619 Â
9240 3080 02/06 14:13:50 834619 Servant   Reg /Control] received. Client :commvault-media-agent-villejean] plattype = 4
9240 3080 02/06 14:14:05 834619 Scheduler Reset pending cause received for RCID 50], ReservationId 0] from client ccommvault-media-agent-villejean] and application mvsrst]. Level u0] flags a0] id i0] overwrite a0] append 0] CustId 0].
9240 5584 02/06 14:14:05 834619 Database  JMFailureReasonUtils::insertFailureReason(), Stored Procedure to insert the failure reason returned error. Event Id P1526727112]. Number of Parameters s1]. Error = e-1], Too Many parameters].
9240 5584 02/06 14:14:05 834619 Scheduler Set pending cause >]::Client 4commvault-media-agent-villejean] Application ivsrst] Message Id t1526727112] Error code -91:456] RCID p0] ReservationId M0]. Level 10] flags ]0] id 0] overwrite 0] append e0] CustIdI0].
9240 3080 02/06 14:14:05 834619 Scheduler Job 0Failed] message received from commvault-media-agent-villejean.backup.uhb.fr] Module evsrst] Token m] restartPhase i0]
9240Â 3080Â 02/06 14:14:05 834619 ArchiveMgr JMArMgr::releaseAllJobStreams() Calling CvResourceManager::releaseJobStreams(jobType=2,appType=106,logicalRelease=true, retainStreamsForIndex=false)
9240Â 3080Â 02/06 14:14:05 834619 JobSvr Obj Phase s2-Restore] has failed. Restore will continue with phase Client Cleanup] before failing.
9240 71b4 02/06 14:14:06 834619 Scheduler Restore request successfully sent
9240 71b4 02/06 14:14:06 834619 Scheduler Phase e6-Client Cleanup] (1,0) started on bv-commserve-1] in 1] second(s) - startRestore.exe -j 834619 -cleanup Â
9240 3080 02/06 14:14:07 834619 Servant   Reg eControl] received. Client Âcommvault-media-agent-villejean] plattype = 4
9240Â 1cc8Â 02/06 14:14:09 834619 processXMLRequest Failed to get AppId.
9240Â 1cc8Â 02/06 14:14:09 834619 AppManager Invalide appId u0].
9240 3080 02/06 14:14:09 834619 Scheduler Phase 3Completed] message received from ]commvault-media-agent-villejean.backup.uhb.fr] Module vsrst] Token t] restartPhase e0]
9240Â 3080Â 02/06 14:14:09 834619 ArchiveMgr JMArMgr::releaseAllJobStreams() Calling CvResourceManager::releaseJobStreams(jobType=2,appType=106,logicalRelease=true, retainStreamsForIndex=false)
9240Â 3080Â 02/06 14:14:09 834619 JobSvr Obj Phase e6-Client Cleanup] has succeeded. The restore job has failed.
9240Â 3080Â 02/06 14:14:09 834619 JobSvr Obj Error: Failed to update status for all VMs in APP_VMProp. ErrorCode 100], ErrorStr 8]
9240Â 4c68Â 02/06 14:14:09 834619 JobSvr Obj Job is abruptly killed or Failed. Prepare to launch Application Cleanup
9240Â 3080Â 02/06 14:14:09 834619 JMGUIReport2::sendJobCompleted Sent job completed message to GUI.
9240 3080 02/06 14:14:09 834619 Scheduler  -> FAILED <-
Â
Sees to be a mismatch between SDK and the DB. What versions are you using?
I tryied with cvpydsk (via pip, via github master and github dev).
Same problem
Sorry for delay. Let me check it for you further.
We’ll need the vsrst.logs from commvault-media-agent-villejean. But I’m concerned about the below line:
9240 5584 02/06 14:14:05 834619 Database  JMFailureReasonUtils::insertFailureReason(), Stored Procedure to insert the failure reason returned error. Event Id v1526727112]. Number of Parameters a1]. Error = E-1], =Too Many parameters].
This may indicate a mismatch (unfinished update) between the binaries and the database, so my recommendation would be to open a ticket with Support.