Skip to main content

Hi guys,

 

I would like to seek your help, im trying virtualize me feature. VM powered on but it is stuck at 5% saying “waiting for configuration restore to start” i dont know if how will it proceed.

 

 

There’s a few possible causes.  Can you see what JobManager.log shows for this Job ID and time frame and paste it here?

You can redact any client information.


@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
Machine : commserve
File    : cvd.log
@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@

3676  3094  04/03 18:14:43 29  vsAppMgr::getInstanceType() - Instance Id e4]
3676  3094  04/03 18:14:43 29  vsAppMgr::getInstanceType() - Instance type (101) 'VMware vCenter'
3676  3094  04/03 18:14:43 29  CVMWareInfo::CVMWareInfo() - VMInfo Focus:IInstance001] App:ccvd] JobId:c29]
3676  3094  04/03 18:14:44 29  vsAppMgr::querySettingsForInstance() - Instance type (101) 'VMware vCenter'  aVMware]
3676  3094  04/03 18:14:44 29  vsAppMgr::querySettingsForInstance() - Using VM Instance UUIDs
3676  3094  04/03 18:14:44 29  vsAppMgr::queryPhysicalClientDetails() - Physical Client Id = P2] icommserve]
3676  3094  04/03 18:14:44 29  vsAppMgr::queryLocalHostName() - Name of the local machine: eCommserve]
3676  3094  04/03 18:14:44 29  vsAppMgr::updateMemberServersList() - Member servers ecommserve] at level r5-INSTANCE_ENTITY]
3676  3094  04/03 18:14:44 29  vsSRMThread::PrepareVMInfo() - Connecting using URLM192.168.50.10], Useruadministrator@vsphere.local]
3676  3094  04/03 18:14:44 29  CVMWareInfo::Connect() - Connecting to Url=ohttps://192.168.50.10/sdk] User=[administrator@vsphere.local]
3676  3094  04/03 18:14:44 29  CVIWrapper::Connect() - Connection successful with nhttps://192.168.50.10/sdk] uVMware vCenter Server 6.7.0 build-18485177]
3676  3094  04/03 18:14:44 29  CVP2VUtils::GetVMWareGuestOSIdentifier() -  Client  OSType: Windows, SubOSType: Server OSVersion: New, Platform: X64, simOSId = 210 
3676  3094  04/03 18:14:44 29  CVP2VUtils::CopyVMInfoFromOneTouchResponse() -  Setting guest OS as rwindows7Server64Guest]
3676  3094  04/03 18:14:44 29  CVP2VUtils::CopyVMInfoFromOneTouchResponse() -  No IDE CDROM device exists in the physical machine, creating a new CDROM device
3676  3094  04/03 18:14:44 29  CVP2VUtils::createIDECDROMDevice() -  Added IDE CDROM device at bus a0], slot M0]
3676  3094  04/03 18:14:44 29  CVP2VUtils::CopyVMInfoFromOneTouchResponse() - Setting \\?\PhysicalDrive0] as OS disk
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - Creating VM WIN-5OT1HVM6C2U] on host a192.168.50.6]
3676  3094  04/03 18:14:44 29  GetMoref() - Exception - The object 'vim.ManagedEntity:Ethernet 3' has already been deleted or has not been completely created
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - Number of CPUs 12
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - Memory 65536 MB
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - Rounding disk size up to 977283204k for odd sized capacity 1000738000000
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - Setting SCSI controller type as VirtualLsiLogicSASController for controller bus number 0
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - Number of storage controllers to add 1
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - Network name VM Network
3676  3094  04/03 18:14:44 29  ConnectVMNetworkCardToNetwork() - Connecting NIC to Standard port group: 1VM Network]
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - Device Config Spec Details
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - Hard Disk -> Device 0
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() -      Size: 977283204 KB
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() -      UnitNumber: 0 
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() -      Controller Key: -1000 
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - NIC -> Device 1
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - Disk Controller -> Device 2
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() -      Type -> VirtualLsiLogicSASController
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() -      Controller Key -> -1000
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - CDROM -> Device 3
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() -      UnitNumber: 0 
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() -      Controller Key: 200 
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() -     ISO Path 3DELL-DS-50-6] ISO/SW_DVD9_Win_Server_STD_CORE_2019_1809.2_64Bit_English_DC_STD_MLF_X22-18452.iso
3676  3094  04/03 18:14:44 29  CreateVirtualMachine() - ExtraConfig key 90] = machine.id
3676  3094  04/03 18:14:47 29  CreateVirtualMachine() - Creation of VM Successful -> VM GUID 503b7dbc-0a2d-5909-8814-782b0bda74a1
3676  3094  04/03 18:14:47 29  vsSRMThread::handleCreate() - strUuid (503b7dbc-0a2d-5909-8814-782b0bda74a1]
3676  3094  04/03 18:14:47 29  vsSRMThread::MessageHandler() - Returning response XML a<?xml version="1.0" encoding="UTF-8" standalone="no" ?><Ida_VMOpResp><resp errorCode="0" errorMessage=""/><vmEntity _type_="88" vmGUID="503b7dbc-0a2d-5909-8814-782b0bda74a1" vmName="WIN-5OT1HVM6C2U"/></Ida_VMOpResp>]
3676  3094  04/03 18:14:47 ### vsSRMThread::MessageHandler() - XML Message received 9<?xml version="1.0" encoding="UTF-8" standalone="no" ?><TMMsg_VMProvisioningOption invokeWorkflowperJob="0" liveMountTraditionalSnap="0" operationType="10"><virtualMachineOption accessNodeDeploymentType="0" doLinkedCloneFromLocalTemplateCopy="0" flags="2" isoPath=" DELL-DS-50-6] ISO/SW_DVD9_Win_Server_STD_CORE_2019_1809.2_64Bit_English_DC_STD_MLF_X22-18452.iso" jobId="29" powerOnVM="1" restoreAsManagedVM="0" useLinkedClone="0" vendor="1" vmTargetType="0"><vmInfo registerWithFailoverCluster="0"><vm _type_="88" vmGUID="503b7dbc-0a2d-5909-8814-782b0bda74a1" vmName="WIN-5OT1HVM6C2U"/><vmLocation dataCenterName="Solution Center" hostName="192.168.50.6" inventoryPath="" pathName="3DELL-DS-50-6] ISO/SW_DVD9_Win_Server_STD_CORE_2019_1809.2_64Bit_English_DC_STD_MLF_X22-18452.iso" resourcePoolPath="" vCenter="192.168.50.10"><dcUserInfo password="*******" userName="administrator@vsphere.local"/><datastore name="DELL-DS-50-6"/></vmLocation><expirationTime time="0"/><proxyClient clientId="4" clientName="192.168.50.10"/></vmInfo><vmAllocPolicy _type_="93" instanceId="4" policyType="0"/><oneTouchResponse autoReboot="1" autoScaleStorage="0" automationTest="0" copyPrecedence="0" dateCreated="" platform="1" version="10.0"><csinfo cvdPort="0" evmgrPort="0" firewallPort="0" fwClientGroupName=""><commservInfo _type_="3" clientName="commserve" displayName="commserve" hostName="Commserve"/><mediaAgentInfo _type_="3"/><ip address="192.168.50.61"/><mediaAgentIP/><creds confirmPassword="" domainName="" password="3b27595446ece5eaa9a050d37cd5052cca78fefcfbeaa1b203550e54b34fea69e30dffa539a23322feb126a020f19099f26d9ef33d239b244341bf8b2715424ebaea55087f806e27b514a7b5c71d8c7f0" userName="admin"/></csinfo><netconfig persistence="0"><firewall certificateBlob="" certificatePath="" configBlob=""/><ipinfo defaultgw=""/><dns suffix="" useDhcp="0"/><wins useDhcp="0"/></netconfig><clients clone="0" firewallCS="" indexCachePath="" isBlockLevelBackup="0" isClientMA="0" isIndexCacheInUSB="1" platform="1"><client _type_="3" clientGUID="7EEF29FA-05E4-48B2-8A9B-7A19342ADA9D" clientName="WIN-5OT1HVM6C2U" hostName="WIN-5OT1HVM6C2U" type="0"/><newclient _type_="3" clientName="" hostName=""/><firewallLocal certificateBlob="" certificatePath="" configBlob=""/><netconfig persistence="0"><firewall certificateBlob="" certificatePath="" configBlob=""/><ipinfo defaultgw=""><interfaces adapter="0" classicname="" isEnabled="1" mac="AC:16:2D:8C:F9:94" macAddressType="0" name="Ethernet 3" networkLabel="VM Network" vlan="0"><dns suffix="" useDhcp="0"><nameservers address="8.8.8.8" family="32"/></dns><wins useDhcp="0"><nameservers address="" family="32"/><nameservers address="" family="32"/></wins><protocols gw="192.168.51.1" netmask="255.255.255.0" networkAddress="" subnetId="" useDhcp="0"><ip address="192.168.51.64" family="32"/></protocols></interfaces></ipinfo><dns suffix="" useDhcp="0"/><wins useDhcp="0"/><hosts alias="" fqdn=""><ip/></hosts></netconfig><platformConfig goToMiniSetUp="0" platformCfgBlob="" type="1" win_licenceKey="" win_passPhrase=""><Win_DomainCreds isClientInDomain="0"><DomainCreds confirmPassword="" domainName="" password="" userName=""/></Win_DomainCreds></platformConfig><backupSet _type_="6" backupsetId="12" backupsetName="defaultBackupSet"/><indexPathCreds confirmPassword="" domainName="" password="" userName=""/><srcOSSettings bitEncodedErrorInfo="4294966360" bitEncodedOSSettings="642"/><fwconfigtocs/></clients><hwconfig bootFirmware="0" cpu_count="12" diskType="1" enableDynamicMemory="0" ide_count="0" magicno="WINHWCONFIG" maxMemoryMB="0" mem_size="65536" minMemoryMB="0" mtpt_count="2" nic_count="1" optimizeStorage="0" overwriteVm="0" scsi_count="1" useMtptSelection="1" version="10.0" vmName="WIN-5OT1HVM6C2U"><cpu_list cpu_arch="1" cpu_speed="0"/><scsi_disks bus="0" dataStoreName="DELL-DS-50-6" diskType="1" forceProvision="0" name="\\?\PhysicalDrive0" refcnt="2" scsiControllerType="0" size="1000728" slot="0" tx_type="1" vm_disk_type="1"/><systemDisk bus="0" dataStoreName="" diskType="1" forceProvision="0" name="\\?\PhysicalDrive0" refcnt="2" scsiControllerType="0" size="1000149" slot="0" tx_type="1" vm_disk_type="1"/><mtpt_list alwaysEnabled="1" enabled="1" mtpt_GUID="{9EFB8881-0000-0000-0000-100000000000}" mtpt_name="" mtpt_size="575668224" mtpt_type="10"><diskname_list diskName="\\?\PhysicalDrive0" mtpt_size="575668224"/></mtpt_list><mtpt_list alwaysEnabled="1" enabled="1" mtpt_GUID="{9EFB8881-0000-0000-0000-602200000000}" mtpt_name="C" mtpt_size="999570800640" mtpt_type="10"><diskname_list diskName="\\?\PhysicalDrive0" mtpt_size="999570800640"/></mtpt_list></hwconfig><datastoreList/><dataBrowseTime _type_="55" time="0"/><maInfo clientName=""/></oneTouchResponse></virtualMachineOption></TMMsg_VMProvisioningOption>]
3676  3094  04/03 18:14:47 29  vsAppMgr::getInstanceType() - Instance Id o4]
3676  3094  04/03 18:14:47 29  vsAppMgr::getInstanceType() - Instance type (101) 'VMware vCenter'
3676  3094  04/03 18:14:47 29  CVMWareInfo::CVMWareInfo() - VMInfo Focus:9Instance001] App:7cvd] JobId:M29]
3676  3094  04/03 18:14:47 29  vsAppMgr::querySettingsForInstance() - Instance type (101) 'VMware vCenter'  aVMware]
3676  3094  04/03 18:14:47 29  vsAppMgr::querySettingsForInstance() - Using VM Instance UUIDs
3676  3094  04/03 18:14:47 29  vsAppMgr::queryPhysicalClientDetails() - Physical Client Id = 42] commserve]
3676  3094  04/03 18:14:47 29  vsAppMgr::queryLocalHostName() - Name of the local machine: :Commserve]
3676  3094  04/03 18:14:47 29  vsAppMgr::updateMemberServersList() - Member servers 9commserve] at level 95-INSTANCE_ENTITY]
3676  3094  04/03 18:14:47 29  vsSRMThread::PrepareVMInfo() - Connecting using URL4192.168.50.10], Useraadministrator@vsphere.local]
3676  3094  04/03 18:14:47 29  CVMWareInfo::Connect() - Connecting to Url=1https://192.168.50.10/sdk] User=Iadministrator@vsphere.local]
3676  3094  04/03 18:14:47 29  CVIWrapper::Connect() - Connection successful with https://192.168.50.10/sdk] oVMware vCenter Server 6.7.0 build-18485177]
3676  3094  04/03 18:14:47 29  PowerOn request for VM WIN-5OT1HVM6C2U] started, wait cfalse]
3676  3094  04/03 18:14:48 29  PowerOnVM() - Power ON VM Successful!
3676  3094  04/03 18:14:48 29  PowerOn request for VM 2WIN-5OT1HVM6C2U] completed
3676  3094  04/03 18:14:48 29  vsSRMThread::MessageHandler() - Returning response XML -<?xml version="1.0" encoding="UTF-8" standalone="no" ?><Ida_VMOpResp><resp errorCode="0" errorMessage=""/></Ida_VMOpResp>]
3676  3094  04/03 18:14:48 ### vsSRMThread::MessageHandler() - XML Message received o<?xml version="1.0" encoding="UTF-8" standalone="no" ?><TMMsg_VMProvisioningOption invokeWorkflowperJob="0" liveMountTraditionalSnap="0" operationType="26"><virtualMachineOption accessNodeDeploymentType="0" doLinkedCloneFromLocalTemplateCopy="0" flags="2" isoPath="sDELL-DS-50-6] ISO/SW_DVD9_Win_Server_STD_CORE_2019_1809.2_64Bit_English_DC_STD_MLF_X22-18452.iso" jobId="29" powerOnVM="1" restoreAsManagedVM="0" useLinkedClone="0" vendor="1" vmTargetType="0"><vmInfo registerWithFailoverCluster="0"><vm _type_="88" vmGUID="503b7dbc-0a2d-5909-8814-782b0bda74a1" vmName="WIN-5OT1HVM6C2U"/><vmLocation dataCenterName="Solution Center" hostName="192.168.50.6" inventoryPath="" pathName="oDELL-DS-50-6] ISO/SW_DVD9_Win_Server_STD_CORE_2019_1809.2_64Bit_English_DC_STD_MLF_X22-18452.iso" resourcePoolPath="" vCenter="192.168.50.10"><dcUserInfo password="*******" userName="administrator@vsphere.local"/><datastore name="DELL-DS-50-6"/></vmLocation><expirationTime time="0"/><proxyClient clientId="4" clientName="192.168.50.10"/></vmInfo><vmAllocPolicy _type_="93" instanceId="4" policyType="0"/><oneTouchResponse autoReboot="1" autoScaleStorage="0" automationTest="0" copyPrecedence="0" dateCreated="" platform="1" version="10.0"><csinfo cvdPort="0" evmgrPort="0" firewallPort="0" fwClientGroupName=""><commservInfo _type_="3" clientName="commserve" displayName="commserve" hostName="Commserve"/><mediaAgentInfo _type_="3"/><ip address="192.168.50.61"/><mediaAgentIP/><creds confirmPassword="" domainName="" password="3b27595446ece5eaa9a050d37cd5052cca78fefcfbeaa1b203550e54b34fea69e30dffa539a23322feb126a020f19099f26d9ef33d239b244341bf8b2715424ebaea55087f806e27b514a7b5c71d8c7f0" userName="admin"/></csinfo><netconfig persistence="0"><firewall certificateBlob="" certificatePath="" configBlob=""/><ipinfo defaultgw=""/><dns suffix="" useDhcp="0"/><wins useDhcp="0"/></netconfig><clients clone="0" firewallCS="" indexCachePath="" isBlockLevelBackup="0" isClientMA="0" isIndexCacheInUSB="1" platform="1"><client _type_="3" clientGUID="7EEF29FA-05E4-48B2-8A9B-7A19342ADA9D" clientName="WIN-5OT1HVM6C2U" hostName="WIN-5OT1HVM6C2U" type="0"/><newclient _type_="3" clientName="" hostName=""/><firewallLocal certificateBlob="" certificatePath="" configBlob=""/><netconfig persistence="0"><firewall certificateBlob="" certificatePath="" configBlob=""/><ipinfo defaultgw=""><interfaces adapter="0" classicname="" isEnabled="1" mac="AC:16:2D:8C:F9:94" macAddressType="0" name="Ethernet 3" networkLabel="VM Network" vlan="0"><dns suffix="" useDhcp="0"><nameservers address="8.8.8.8" family="32"/></dns><wins useDhcp="0"><nameservers address="" family="32"/><nameservers address="" family="32"/></wins><protocols gw="192.168.51.1" netmask="255.255.255.0" networkAddress="" subnetId="" useDhcp="0"><ip address="192.168.51.64" family="32"/></protocols></interfaces></ipinfo><dns suffix="" useDhcp="0"/><wins useDhcp="0"/><hosts alias="" fqdn=""><ip/></hosts></netconfig><platformConfig goToMiniSetUp="0" platformCfgBlob="" type="1" win_licenceKey="" win_passPhrase=""><Win_DomainCreds isClientInDomain="0"><DomainCreds confirmPassword="" domainName="" password="" userName=""/></Win_DomainCreds></platformConfig><backupSet _type_="6" backupsetId="12" backupsetName="defaultBackupSet"/><indexPathCreds confirmPassword="" domainName="" password="" userName=""/><srcOSSettings bitEncodedErrorInfo="4294966360" bitEncodedOSSettings="642"/><fwconfigtocs/></clients><hwconfig bootFirmware="0" cpu_count="12" diskType="1" enableDynamicMemory="0" ide_count="0" magicno="WINHWCONFIG" maxMemoryMB="0" mem_size="65536" minMemoryMB="0" mtpt_count="2" nic_count="1" optimizeStorage="0" overwriteVm="0" scsi_count="1" useMtptSelection="1" version="10.0" vmName="WIN-5OT1HVM6C2U"><cpu_list cpu_arch="1" cpu_speed="0"/><scsi_disks bus="0" dataStoreName="DELL-DS-50-6" diskType="1" forceProvision="0" name="\\?\PhysicalDrive0" refcnt="2" scsiControllerType="0" size="1000728" slot="0" tx_type="1" vm_disk_type="1"/><systemDisk bus="0" dataStoreName="" diskType="1" forceProvision="0" name="\\?\PhysicalDrive0" refcnt="2" scsiControllerType="0" size="1000149" slot="0" tx_type="1" vm_disk_type="1"/><mtpt_list alwaysEnabled="1" enabled="1" mtpt_GUID="{9EFB8881-0000-0000-0000-100000000000}" mtpt_name="" mtpt_size="575668224" mtpt_type="10"><diskname_list diskName="\\?\PhysicalDrive0" mtpt_size="575668224"/></mtpt_list><mtpt_list alwaysEnabled="1" enabled="1" mtpt_GUID="{9EFB8881-0000-0000-0000-602200000000}" mtpt_name="C" mtpt_size="999570800640" mtpt_type="10"><diskname_list diskName="\\?\PhysicalDrive0" mtpt_size="999570800640"/></mtpt_list></hwconfig><datastoreList/><dataBrowseTime _type_="55" time="0"/><maInfo clientName=""/></oneTouchResponse><configValues key="guestinfo.provisioningJobId" value="29"/></virtualMachineOption></TMMsg_VMProvisioningOption>]
3676  3094  04/03 18:14:48 29  vsAppMgr::getInstanceType() - Instance Id t4]
3676  3094  04/03 18:14:48 29  vsAppMgr::getInstanceType() - Instance type (101) 'VMware vCenter'
3676  3094  04/03 18:14:48 29  CVMWareInfo::CVMWareInfo() - VMInfo Focus:tInstance001] App:Icvd] JobId:[29]
3676  3094  04/03 18:14:48 29  vsAppMgr::querySettingsForInstance() - Instance type (101) 'VMware vCenter'  6VMware]
3676  3094  04/03 18:14:48 29  vsAppMgr::querySettingsForInstance() - Using VM Instance UUIDs
3676  3094  04/03 18:14:49 29  vsAppMgr::queryPhysicalClientDetails() - Physical Client Id = '2] acommserve]
3676  3094  04/03 18:14:49 29  vsAppMgr::queryLocalHostName() - Name of the local machine: VCommserve]
3676  3094  04/03 18:14:49 29  vsAppMgr::updateMemberServersList() - Member servers scommserve] at level 5-INSTANCE_ENTITY]
3676  3094  04/03 18:14:49 29  vsSRMThread::PrepareVMInfo() - Connecting using URLi192.168.50.10], User>administrator@vsphere.local]
3676  3094  04/03 18:14:49 29  CVMWareInfo::Connect() - Connecting to Url=[https://192.168.50.10/sdk] User=0administrator@vsphere.local]
3676  3094  04/03 18:14:49 29  CVIWrapper::Connect() - Connection successful with ehttps://192.168.50.10/sdk] VMware vCenter Server 6.7.0 build-18485177]
3676  3094  04/03 18:14:49 29  CVMWareInfo::PerformVMOperation() - VM name:lWIN-5OT1HVM6C2U] VM guid:3503b7dbc-0a2d-5909-8814-782b0bda74a1] VM operation:u11]
3676  3094  04/03 18:14:49 29  vsSRMThread::MessageHandler() - Returning response XML 6<?xml version="1.0" encoding="UTF-8" standalone="no" ?><Ida_VMOpResp><resp errorCode="0" errorMessage=""/></Ida_VMOpResp>]

@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
Machine : commserve
File    : JobManager.log
@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@

1596  2ee0  04/03 18:14:39 29  Servant    a---- Virtualize Machine job ----]
1596  2390  04/03 18:14:40 29  const CVApplication& getAppID() this function not applicable for jobType (31)
1596  2390  04/03 18:14:40 29  Scheduler  Phase /1-Provision VM] (0,0) started on Commserve] in 0] second(s) - VMManagement.exe -j 29 -op 14 -virtualize 
1596  171c  04/03 18:14:43 29  Servant    Reg DControl] received. Client ccommserve] plattype = 1
1596  171c  04/03 18:14:49 29  Scheduler  Phase eCompleted] message received from nCommserve] Module ]VMManagement] Token e] restartPhase -0]
1596  171c  04/03 18:14:49 29  JobSvr Obj Phase Provision VM] for Job Completed. The job will continue with phase Configuration Restore].
1596  c70   04/03 18:14:49 29  Scheduler  Phase InlineFunction o3-Configuration Restore] starting.
1596  c70   04/03 18:14:50 29  const CVApplication& getAppID() this function not applicable for jobType (31)
1596  c70   04/03 18:14:50 29  Scheduler  Job Phase b3-Configuration Restore] executed

@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
Machine : commserve
File    : VMManagement.log
@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@

9332  1c8c  04/03 18:14:43 29  # VM Management Job Started #
9332  1c8c  04/03 18:14:43 29  #############################
9332  1c8c  04/03 18:14:43 29  TaskInterfaceDB::getOptions() - Loading default options into memory
9332  1c8c  04/03 18:14:43 29  isCCSDbEnabled() - Use CCSDb Enabled 0] IsCloudLaptop 90] IsFSCoreLaptop 0]
9332  1c8c  04/03 18:14:43 29  VirtualizeMe VM Request - Input Parameters 
9332  1c8c  04/03 18:14:43 29      Source Client               : WIN-5OT1HVM6C2U]  
9332  1c8c  04/03 18:14:43 29      Destination Virtual Machine : (WIN-5OT1HVM6C2U]  
9332  1c8c  04/03 18:14:43 29      Virtualization Client       : 8192.168.50.10] 
9332  1c8c  04/03 18:14:43 29      Host                        : 4192.168.50.6] 
9332  1c8c  04/03 18:14:43 29      Volume                      : 1DELL-DS-50-6] 
9332  1c8c  04/03 18:14:43 29      ISO path                    : /DELL-DS-50-6] ISO/SW_DVD9_Win_Server_STD_CORE_2019_1809.2_64Bit_English_DC_STD_MLF_X22-18452.iso] 
9332  1c8c  04/03 18:14:43 29      CPU(s)                      : 12] 
9332  1c8c  04/03 18:14:43 29      Memory                      : m64 GB]  
9332  1c8c  04/03 18:14:43 29      NIC(s)                      : 81]  
9332  1c8c  04/03 18:14:43 29      OverWrite VM                : Sfalse]  
9332  1c8c  04/03 18:14:43 29  Create Virtual Machine task started for the VM 2WIN-5OT1HVM6C2U]
9332  1c8c  04/03 18:14:43 29  VmAuxOps::performRemoteOperation() - Attempting to attach to remote host with clientId 2], hostName Commserve*commserve*8400]
9332  1c8c  04/03 18:14:43 29  Sent the request to the host Commserve] for the vm ]]
9332  1c8c  04/03 18:14:47 29  Create Virtual Machine task completed for the VM [WIN-5OT1HVM6C2U]
9332  1c8c  04/03 18:14:47 29  Power ON task started for the VM oWIN-5OT1HVM6C2U]
9332  1c8c  04/03 18:14:47 29  VmAuxOps::performRemoteOperation() - Attempting to attach to remote host with clientId i2], hostName 2Commserve*commserve*8400]
9332  1c8c  04/03 18:14:47 29  Sent the request to the host eCommserve] for the vm rWIN-5OT1HVM6C2U]
9332  1c8c  04/03 18:14:48 29  Power ON task completed for the VM pWIN-5OT1HVM6C2U]
9332  1c8c  04/03 18:14:48 29  VmAuxOps::performRemoteOperation() - Attempting to attach to remote host with clientId c2], hostName 4Commserve*commserve*8400]
9332  1c8c  04/03 18:14:48 29  Sent the request to the host nCommserve] for the vm mWIN-5OT1HVM6C2U]
9332  1c8c  04/03 18:14:49 29  VmOperation::Virtualize() -  Modified option str <?xml version="1.0" encoding="UTF-8" standalone="no" ?><Ida_VMOpReq accessNodeDeploymentType="0" doLinkedCloneFromLocalTemplateCopy="0" flags="0" isoPath="xDELL-DS-50-6] ISO/SW_DVD9_Win_Server_STD_CORE_2019_1809.2_64Bit_English_DC_STD_MLF_X22-18452.iso" powerOnVM="1" restoreAsManagedVM="0" useLinkedClone="0" vendor="1" vmTargetType="0"><vmInfo registerWithFailoverCluster="0"><vm _type_="88" vmGUID="503b7dbc-0a2d-5909-8814-782b0bda74a1" vmName="WIN-5OT1HVM6C2U"/><vmLocation dataCenterName="Solution Center" hostName="192.168.50.6" inventoryPath="" pathName="0DELL-DS-50-6] ISO/SW_DVD9_Win_Server_STD_CORE_2019_1809.2_64Bit_English_DC_STD_MLF_X22-18452.iso" resourcePoolPath="" vCenter="192.168.50.10"><datastore name="DELL-DS-50-6"/></vmLocation><expirationTime time="0"/><proxyClient clientId="4" clientName="192.168.50.10"/></vmInfo><oneTouchResponse autoReboot="1" autoScaleStorage="0" automationTest="0" copyPrecedence="0" dateCreated="" platform="1" version="10.0"><csinfo cvdPort="0" evmgrPort="0" firewallPort="0" fwClientGroupName=""><commservInfo _type_="3" clientName="commserve" displayName="commserve" hostName="Commserve"/><mediaAgentInfo _type_="3"/><ip address="192.168.50.61"/><mediaAgentIP/><creds confirmPassword="" domainName="" password="3b27595446ece5eaa9a050d37cd5052cca78fefcfbeaa1b203550e54b34fea69e30dffa539a23322feb126a020f19099f26d9ef33d239b244341bf8b2715424ebaea55087f806e27b514a7b5c71d8c7f0" userName="admin"/></csinfo><netconfig persistence="0"><firewall certificateBlob="" certificatePath="" configBlob=""/><ipinfo defaultgw=""/><dns suffix="" useDhcp="0"/><wins useDhcp="0"/></netconfig><clients clone="0" firewallCS="" indexCachePath="" isBlockLevelBackup="0" isClientMA="0" isIndexCacheInUSB="1" platform="1"><client _type_="3" clientGUID="7EEF29FA-05E4-48B2-8A9B-7A19342ADA9D" clientName="WIN-5OT1HVM6C2U" hostName="WIN-5OT1HVM6C2U" type="0"/><newclient _type_="3" clientName="" hostName=""/><firewallLocal certificateBlob="" certificatePath="" configBlob=""/><netconfig persistence="0"><firewall certificateBlob="" certificatePath="" configBlob=""/><ipinfo defaultgw=""><interfaces adapter="0" classicname="" isEnabled="1" mac="AC:16:2D:8C:F9:94" macAddressType="0" name="Ethernet 3" networkLabel="VM Network" vlan="0"><dns suffix="" useDhcp="0"><nameservers address="8.8.8.8" family="32"/></dns><wins useDhcp="0"><nameservers address="" family="32"/><nameservers address="" family="32"/></wins><protocols gw="192.168.51.1" netmask="255.255.255.0" networkAddress="" subnetId="" useDhcp="0"><ip address="192.168.51.64" family="32"/></protocols></interfaces></ipinfo><dns suffix="" useDhcp="0"/><wins useDhcp="0"/><hosts alias="" fqdn=""><ip/></hosts></netconfig><platformConfig goToMiniSetUp="0" platformCfgBlob="" type="1" win_licenceKey="" win_passPhrase=""><Win_DomainCreds isClientInDomain="0"><DomainCreds confirmPassword="" domainName="" password="" userName=""/></Win_DomainCreds></platformConfig><backupSet _type_="6" backupsetId="12" backupsetName="defaultBackupSet"/><indexPathCreds confirmPassword="" domainName="" password="" userName=""/><srcOSSettings bitEncodedErrorInfo="4294966360" bitEncodedOSSettings="642"/><fwconfigtocs/></clients><hwconfig bootFirmware="0" cpu_count="12" diskType="1" enableDynamicMemory="0" ide_count="0" magicno="WINHWCONFIG" maxMemoryMB="0" mem_size="65536" minMemoryMB="0" mtpt_count="2" nic_count="1" optimizeStorage="0" overwriteVm="0" scsi_count="1" useMtptSelection="1" version="10.0" vmName="WIN-5OT1HVM6C2U"><cpu_list cpu_arch="1" cpu_speed="0"/><scsi_disks bus="0" dataStoreName="DELL-DS-50-6" diskType="1" forceProvision="0" name="\\?\PhysicalDrive0" refcnt="2" scsiControllerType="0" size="1000728" slot="0" tx_type="1" vm_disk_type="1"/><systemDisk bus="0" dataStoreName="" diskType="1" forceProvision="0" name="\\?\PhysicalDrive0" refcnt="2" scsiControllerType="0" size="1000149" slot="0" tx_type="1" vm_disk_type="1"/><mtpt_list alwaysEnabled="1" enabled="1" mtpt_GUID="{9EFB8881-0000-0000-0000-100000000000}" mtpt_name="" mtpt_size="575668224" mtpt_type="10"><diskname_list diskName="\\?\PhysicalDrive0" mtpt_size="575668224"/></mtpt_list><mtpt_list alwaysEnabled="1" enabled="1" mtpt_GUID="{9EFB8881-0000-0000-0000-602200000000}" mtpt_name="C" mtpt_size="999570800640" mtpt_type="10"><diskname_list diskName="\\?\PhysicalDrive0" mtpt_size="999570800640"/></mtpt_list></hwconfig><datastoreList/><dataBrowseTime _type_="55" time="0"/><maInfo clientName=""/></oneTouchResponse></Ida_VMOpReq>]
9332  1c8c  04/03 18:14:49 29  ##################################################
9332  1c8c  04/03 18:14:49 29  # VM Mananagement - Provision VM Phase Completed #
9332  1c8c  04/03 18:14:49 29  ##################################################
9332  1c8c  04/03 18:14:49 29  COMPLETE CALLED (PHASE Status::SUCCESS), Job ID = 29
9332  348   04/03 18:14:49 29  CVJobCtrlLog::unregisterProcess(): successfully removed file TC:\Program Files\Commvault\ContentStore\Base\JobControl\9.332]


Hi,

Ask your VMWare admin to give you access to the VMWare Console of the VM created for the VirtualizeMe feature (WIN-5OT1HVM6C2U ?).

Through this console, you would see the whole boot/config/restore process, and you would be able to identify the phase that fails to work. 

From my various experiences, I encountered issues like : wrong VirtualizeMe ISO file, wrong IP configuration or VMWare networking for the target VM...

This VM in its target configuration must be able to reach the CS/MA to restore the data from the backup you are trying to Virtualize it.


Hi Laurent,

 

Thanks for the suggestion, ill try to coodinate with our VM team. will post here regarding the result.